issue with Silicon Labs Multiprotocol Add-on / Silicon Firmware Flasher : Failed to connect, secondary seems unresponsive

[josephhungkk]

Describe the issue you are experiencing

I've flashed the SkyConnect with the correct RCPMultiPAN firmware, and have then installed Silicon Labs Multiprotocol Add-on with no automatic firmware update selected, but get continuous error in the log "Failed to connect, secondary seems unresponsive".
Tried any baudrate without success.
Tired using the Silicon Firmware Flasher to flash back to zigbee only firmware without success.
Using Web Base Flasher, it said it cannot determine the firmware it's using.
Try to disable multiprotocol using System -> Hardware -> Home Assistant SkyConnect Configure, it seems 'SUCCESS', but the discover showing SkyConnect MultiProtocol, which is not expected.

What type of installation are you running?

Home Assistant OS

Which operating system are you running on?

Home Assistant Operating System

Which add-on are you reporting an issue with?

Silicon Labs Multiprotocol

What is the version of the add-on?

2.4.4

Steps to reproduce the issue

1.Install Silicon Labs Multiprotocol Add-on version 2.4.3
2.Run the add on with any baudrate with no automatic firmware upgrade
3.
...

System Health information

System Information

version	core-2024.2.1
installation_type	Home Assistant OS
dev	false
hassio	true
docker	true
user	root
virtualenv	false
python_version	3.12.1
os_name	Linux
os_version	6.1.63-haos-raspi
arch	aarch64
timezone	Europe/London
config_dir	/config

Home Assistant Community Store

GitHub API	ok
GitHub Content	ok
GitHub Web	ok
GitHub API Calls Remaining	5000
Installed Version	1.34.0
Stage	running
Available Repositories	1398
Downloaded Repositories	10
HACS Data	ok

AccuWeather

can_reach_server	ok
remaining_requests	35

Home Assistant Cloud

logged_in	true
subscription_expiration	January 1, 2018 at 00:00
relayer_connected	false
relayer_region	null
remote_enabled	false
remote_connected	false
alexa_enabled	true
google_enabled	true
remote_server	null
certificate_status	null
instance_id	040297cae6714fd08dfb072e95eeec58
can_reach_cert_server	ok
can_reach_cloud_auth	ok
can_reach_cloud	ok

Home Assistant Supervisor

host_os	Home Assistant OS 11.5
update_channel	stable
supervisor_version	supervisor-2024.01.1
agent_version	1.6.0
docker_version	24.0.7
disk_total	938.2 GB
disk_used	13.5 GB
healthy	true
supported	true
board	rpi5-64
supervisor_api	ok
version_api	ok
installed_addons	Advanced SSH & Web Terminal (17.1.0), Home Assistant Google Drive Backup (0.112.1), Studio Code Server (5.15.0), ESPHome (2023.12.9), Log Viewer (0.17.0), WireGuard (0.10.2), Duck DNS (1.15.0), Silicon Labs Flasher (0.2.0), Silicon Labs Multiprotocol (2.4.4)

Dashboards

dashboards	1
resources	0
views	1
mode	storage

Recorder

oldest_recorder_run	February 3, 2024 at 19:50
current_recorder_run	February 12, 2024 at 20:45
estimated_db_size	93.62 MiB
database_engine	sqlite
database_version	3.44.2

Xiaomi Gateway 3

version	3.3.6 (6a494ae)

Anything in the Supervisor logs that might be useful for us?

24-02-13 10:04:52 WARNING (MainThread) [supervisor.addons.addon] Timeout while waiting for addon Silicon Labs Multiprotocol to start, took more than 120 seconds

Anything in the add-on logs that might be useful for us?

MultiProtocol Log

[10:10:08] INFO: The otbr-web is disabled.
s6-rc: info: service mdns: starting
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service mdns successfully started
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/check-cpcd-shm.sh
[10:10:08] INFO: Starting mDNS Responder...
Default: mDNSResponder (Engineering Build) (Jan 24 2024 17:58:11) starting
cont-init: info: /etc/cont-init.d/check-cpcd-shm.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service banner: starting

-----------------------------------------------------------
 Add-on: Silicon Labs Multiprotocol
 Zigbee and OpenThread multiprotocol add-on
-----------------------------------------------------------
 Add-on version: 2.4.4
 You are running the latest version of this add-on.
 System: Home Assistant OS 11.5  (aarch64 / raspberrypi5-64)
 Home Assistant Core: 2024.2.1
 Home Assistant Supervisor: 2024.01.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
[10:10:08] INFO: Flashing firmware is disabled
s6-rc: info: service universal-silabs-flasher successfully started
s6-rc: info: service cpcd-config: starting
[10:10:09] INFO: Generating cpcd configuration.
s6-rc: info: service cpcd-config successfully started
s6-rc: info: service cpcd: starting
[10:10:09] INFO: Starting cpcd...
WARNING in function 'main' in file /usr/src/cpc-daemon/main.c at line #186 : Running CPCd as 'root' is not recommended. Proceed at your own risk.
[10:10:09:631693] Info : [CPCd v4.3.1.0] [Library API v3] [RCP Protocol v4]
[10:10:09:631743] Info : Git commit: 133b29678b3d0bc7578e098d2f46b4d5bcd2ebb4 / branch: 
[10:10:09:631744] Info : Sources hash: ff8300587e7e4ab1def7a89a272c0baef32f9eb3bff9b0ba06b94e655d652367
[10:10:09:631746] WARNING : In function 'main' in file /usr/src/cpc-daemon/main.c at line #186 : Running CPCd as 'root' is not recommended. Proceed at your own risk.
[10:10:09:631758] Info : Reading cli arguments
[10:10:09:631761] Info : /usr/local/bin/cpcd 
[10:10:09:632792] Info : Reading configuration
[10:10:09:632797] Info :   file_path = /usr/local/etc/cpcd.conf
[10:10:09:632798] Info :   instance_name = cpcd_0
[10:10:09:632799] Info :   socket_folder = /dev/shm
[10:10:09:632800] Info :   operation_mode = MODE_NORMAL
[10:10:09:632801] Info :   use_encryption = false
[10:10:09:632802] Info :   binding_key_file = /etc/binding-key.key
[10:10:09:632803] Info :   stdout_tracing = false
[10:10:09:632803] Info :   file_tracing = false
[10:10:09:632804] Info :   lttng_tracing = false
[10:10:09:632805] Info :   enable_frame_trace = false
[10:10:09:632806] Info :   traces_folder = /dev/shm/cpcd-traces
[10:10:09:632807] Info :   bus = UART
[10:10:09:632807] Info :   uart_baudrate = 460800
[10:10:09:632808] Info :   uart_hardflow = true
[10:10:09:632809] Info :   uart_file = /dev/ttyUSB0
[10:10:09:632810] Info :   fu_recovery_pins_enabled = false
[10:10:09:632811] Info :   fu_connect_to_bootloader = false
[10:10:09:632812] Info :   fu_enter_bootloader = false
[10:10:09:632813] Info :   restart_cpcd = false
[10:10:09:632813] Info :   application_version_validation = false
[10:10:09:632814] Info :   print_secondary_versions_and_exit = false
[10:10:09:632815] Info :   use_noop_keep_alive = false
[10:10:09:632816] Info :   reset_sequence = true
[10:10:09:632817] Info :   stats_interval = 0
[10:10:09:632818] Info :   rlimit_nofile = 2000
[10:10:09:632819] Info : ENCRYPTION IS DISABLED 
[10:10:09:632819] Info : Starting daemon in normal mode
[10:10:09:643952] Info : Connecting to Secondary...
[10:10:11:644133] Info : Failed to connect, secondary seems unresponsive
[10:10:11:644147] Info : Connecting to Secondary...
[10:10:13:644251] Info : Failed to connect, secondary seems unresponsive
[10:10:13:644265] Info : Connecting to Secondary...
[10:10:15:644357] Info : Failed to connect, secondary seems unresponsive
[10:10:15:644372] Info : Connecting to Secondary...
[10:10:17:644466] Info : Failed to connect, secondary seems unresponsive
[10:10:17:644482] Info : Connecting to Secondary...

Silicon Labs Flahser Log
-----------------------------------------------------------
 Add-on: Silicon Labs Flasher
 Silicon Labs firmware flasher add-on
-----------------------------------------------------------
 Add-on version: 0.2.0
 You are running the latest version of this add-on.
 System: Home Assistant OS 11.5  (aarch64 / raspberrypi5-64)
 Home Assistant Core: 2024.2.1
 Home Assistant Supervisor: 2024.01.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
[10:03:35] INFO: Checking /dev/ttyUSB0 identifying SkyConnect v1.0 from Nabu Casa.
[10:03:35] INFO: Starting universal-silabs-flasher with /dev/ttyUSB0 (bootloader baudrate 115200)
2024-02-13 10:03:36 core-silabs-flasher asyncio[151] DEBUG Using selector: EpollSelector
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.flash[151] INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.3.1', ezsp_version='7.3.1.0', ot_rcp_version=None, fw_type=<FirmwareImageType.NCP_UART_HW: 'ncp-uart-hw'>, baudrate=115200)
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.flash[151] DEBUG Probing app type ApplicationType.EZSP first
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.flash[151] DEBUG Probing with 115200 baudrate first
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.gecko_bootloader.GeckoBootloaderProtocol object at 0x7fad466810>, Serial<id=0x7fad426140, open=True>(port='/dev/ttyUSB0', baudrate=115200, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2024-02-13 10:03:36 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'3'
2024-02-13 10:03:38 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.EZSP at 115200 baud
2024-02-13 10:03:38 core-silabs-flasher bellows.ezsp[151] DEBUG Resetting EZSP
2024-02-13 10:03:38 core-silabs-flasher bellows.uart[151] DEBUG Resetting ASH
2024-02-13 10:03:38 core-silabs-flasher bellows.uart[151] DEBUG Sending: b'1ac038bc7e'
2024-02-13 10:03:43 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.CPC at 460800 baud
2024-02-13 10:03:43 core-silabs-flasher bellows.uart[151] DEBUG Connection lost: None
2024-02-13 10:03:43 core-silabs-flasher bellows.uart[151] DEBUG Closed serial connection
2024-02-13 10:03:43 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0x7fad4731d0>, Serial<id=0x7fad424f10, open=True>(port='/dev/ttyUSB0', baudrate=460800, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2024-02-13 10:03:43 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:43 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:44 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:44 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:44 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:45 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:45 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:45 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:46 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:46 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:46 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:47 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:47 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.CPC at 115200 baud
2024-02-13 10:03:47 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0x7fad473210>, Serial<id=0x7fad424f10, open=True>(port='/dev/ttyUSB0', baudrate=115200, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2024-02-13 10:03:47 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:47 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:48 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:48 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:48 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:49 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:49 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:49 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:50 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:50 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:50 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:51 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:51 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.CPC at 230400 baud
2024-02-13 10:03:51 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.cpc.CPCProtocol object at 0x7fad473490>, Serial<id=0x7fad424f10, open=True>(port='/dev/ttyUSB0', baudrate=230400, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2024-02-13 10:03:51 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:51 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:52 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:52 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:52 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:53 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:53 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:53 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:54 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:55 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:55 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'\x14\x00\n\x00\xc4U\xd3\x02\x00\x04\x00\x03\x00\x00\x00\xdb\x12'
2024-02-13 10:03:56 core-silabs-flasher universal_silabs_flasher.cpc[151] 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-02-13 10:03:56 core-silabs-flasher universal_silabs_flasher.flasher[151] INFO Probing ApplicationType.SPINEL at 460800 baud
2024-02-13 10:03:56 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <universal_silabs_flasher.spinel.SpinelProtocol object at 0x7fad473d10>, Serial<id=0x7fad424f10, open=True>(port='/dev/ttyUSB0', baudrate=460800, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2024-02-13 10:03:56 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:56 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-02-13 10:03:57 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:57 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:57 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-02-13 10:03:58 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:58 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:58 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-02-13 10:03:59 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:59 core-silabs-flasher universal_silabs_flasher.spinel[151] 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-02-13 10:03:59 core-silabs-flasher universal_silabs_flasher.common[151] DEBUG Sending data b'~\x83\x02\x02\xe65~'
2024-02-13 10:04:00 core-silabs-flasher universal_silabs_flasher.spinel[151] 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
[10:04: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

Additional information

No response

[puddly]

Why do you have firmware flashing disabled? The addon requires specific firmware to run on the device and will install that specific version.

[josephhungkk]

Why do you have firmware flashing disabled? The addon requires specific firmware to run on the device and will install that specific version.

If turn on the automatic update, the error from universal-silabs-flasher will show ...

[puddly]

Which error are you referring to?

Can you physically unplug the SkyConnect and plug it back in? Re-enable firmware flashing and run it again.

[josephhungkk]

I have tried to physically remove and reboot and retry and no success.
(Failed to probe running application type)

The log as follow
17:14:21] INFO: The otbr-web is disabled.
s6-rc: info: service mdns: starting
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service mdns successfully started
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/check-cpcd-shm.sh
[17:14:21] INFO: Starting mDNS Responder...
Default: mDNSResponder (Engineering Build) (Jan 24 2024 17:58:11) starting
cont-init: info: /etc/cont-init.d/check-cpcd-shm.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service banner: starting

---

Add-on: Silicon Labs Multiprotocol
Zigbee and OpenThread multiprotocol add-on

Add-on version: 2.4.4
You are running the latest version of this add-on.
System: Home Assistant OS 11.5 (aarch64 / raspberrypi5-64)
Home Assistant Core: 2024.2.1
Home Assistant Supervisor: 2024.01.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
[17:14:22] INFO: Checking /dev/ttyUSB0 identifying SkyConnect v1.0 from Nabu Casa.
[17:14:22] INFO: Starting universal-silabs-flasher with /dev/ttyUSB0
2024-02-13 17:14:22.582 homeassistant universal_silabs_flasher.flash INFO Extracted GBL metadata: NabuCasaMetadata(metadata_version=1, sdk_version='4.3.1', ezsp_version='7.3.1.0', ot_rcp_version='SL-OPENTHREAD/2.3.1.0_GitHub-e6df00dd6' (2.3.1.0), cpc_version='4.3.1-4f7f9e99-dirty-de58d93e' (4.3.1), fw_type=<FirmwareImageType.RCP_UART_802154: 'rcp-uart-802154'>, baudrate=460800)
2024-02-13 17:14:22.583 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.GECKO_BOOTLOADER at 115200 baud
2024-02-13 17:14:24.588 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.CPC at 460800 baud
2024-02-13 17:14:28.901 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.CPC at 115200 baud
2024-02-13 17:14:33.213 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.CPC at 230400 baud
2024-02-13 17:14:37.523 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.EZSP at 115200 baud
2024-02-13 17:14:42.532 homeassistant universal_silabs_flasher.flasher INFO Probing ApplicationType.SPINEL at 460800 baud
Error: Failed to probe running application type
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 mdns: stopping
s6-rc: info: service banner: stopping
Default: mDNSResponder (Engineering Build) (Jan 24 2024 17:58:11) 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
[17:14:46] INFO: mDNS ended with exit code 4 (signal 0)...
s6-rc: info: service mdns successfully stopped

[puddly]

When you say "I've flashed the SkyConnect with the correct RCPMultiPAN firmware", what specific firmware did you install?

Do you have ZHA disabled?

[josephhungkk]

NabuCasa_SkyConnect_RCP_v4.4.0_rcp-uart-hw-802154_460800.gbl

ZHA is discovered after ‘started’ Multi Protocol. But sure cannot connect successfully.

[puddly]

As mentioned above, the addon requires a very specific firmware to run on the stick (4.3.1). It's not compatible with the firmware you installed.

Double check that you have ZHA completely disabled, flash the coordinator back to Zigbee firmware with your web browser, and re-enable firmware flashing so the addon can install the correct firmware.

[josephhungkk]

As state before. Web flashing not successful. It’s said
‘The running firmware could not be detected’

[puddly]

Give it another try and make sure to physically unplug the stick and plug it back in before flashing. Try a different platform as well and make sure you have the correct drivers installed if you're using Windows or macOS.

[edmondss]

I have the same issue suddenly today. It was working fine and I did not changed anything. What's wrong with it?

[github-actions]

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.