Page 5 sur 7

Re: Avis sur coordinateur

Publié : 28 sept. 2025, 14:34
par pipiche
le only once veut dire qu'il n'est possible d'ecraser la Mac Addresse qu'une seule fois.
Donc si tu as deja fait un restore et que la Mac a été ecrasée tu vas etre bloqué avec cette mac.

Attention l'ancien coordinateur et le nouveau vont etre avec la meme Mac@ donc ne pas les utiliser en meme temps car ca risque de faire un sacré bazarre.

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 09:54
par lost
Hello,

Bon, la manip pour écraser la MAC ne semble pas fonctionnelle avec ce coordinateur SonOff Dongle Plus MG24.
Idem 1ère tentative: Au redémarrage avec la modif config OverWriteCoordinatorIEEEOnlyOnce et redémarrage avec reinit plugin => ce dernier ne réponds plus et niveau logs domoticz (expurgés des autres matériels qui reportent):

Code : Tout sélectionner

2025-09-30 09:25:30.930  Status: Zi-Stick: Entering work loop.
2025-09-30 09:25:30.930  Zi-Stick: Worker thread started.
2025-09-30 09:25:30.931  Status: Zi-Stick: Started.
2025-09-30 09:25:35.085  Status: Zi-Stick: Initialized version 7.1, author 'pipiche38'
2025-09-30 09:25:35.105  Status: Zi-Stick: Welcome to Zigbee for Domoticz (Z4D) plugin. (c)pipiche38 - 2018 - 2025
2025-09-30 09:25:35.106  Zi-Stick: PYTHONPATH is not set
2025-09-30 09:25:35.106  Status: Zi-Stick: Z4D requires python3.9 or above and you are running 3.9
2025-09-30 09:25:35.115  Status: Zi-Stick: Z4D is loading configuration settings
2025-09-30 09:25:35.120  Zi-Stick: Loading PluginConf -  from Domoticz sqlite Db
2025-09-30 09:25:35.126  Zi-Stick: /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/PluginConf-47.json timestamp is 1759217002.647022
2025-09-30 09:25:35.126  Zi-Stick: Dz PluginConf is older than Json Dz: 0 Json: 1759217002.647022
2025-09-30 09:25:35.130  Status: Zi-Stick: PluginAnalytics set to 1
2025-09-30 09:25:35.131  Status: Zi-Stick: OverWriteCoordinatorIEEEOnlyOnce set to True
2025-09-30 09:25:35.132  Status: Zi-Stick: zigpySourceRouting set to 1
2025-09-30 09:25:35.132  Status: Zi-Stick: channel set to 20
2025-09-30 09:25:35.133  Status: Zi-Stick: TXpower_set set to 20
2025-09-30 09:25:35.133  Status: Zi-Stick: filename set to /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/PluginConf-47.json
2025-09-30 09:25:35.134  Status: Zi-Stick: pluginHome set to /home/domo/domoticz/plugins/Domoticz-Zigbee
2025-09-30 09:25:35.134  Status: Zi-Stick: homedirectory set to /home/domo/domoticz/plugins/Domoticz-Zigbee
2025-09-30 09:25:35.134  Status: Zi-Stick: pluginData set to /home/domo/domoticz/plugins/Domoticz-Zigbee/Data
2025-09-30 09:25:35.135  Status: Zi-Stick: pluginConfig set to /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf
2025-09-30 09:25:35.135  Status: Zi-Stick: pluginOTAFirmware set to /home/domo/domoticz/plugins/Domoticz-Zigbee/OTAFirmware
2025-09-30 09:25:35.136  Status: Zi-Stick: pluginReports set to /home/domo/domoticz/plugins/Domoticz-Zigbee/Reports
2025-09-30 09:25:35.136  Status: Zi-Stick: pluginWWW set to /home/domo/domoticz/plugins/Domoticz-Zigbee/www
2025-09-30 09:25:35.137  Status: Zi-Stick: pluginLogs set to /home/domo/domoticz/plugins/Domoticz-Zigbee/Logs
2025-09-30 09:25:35.137  Status: Zi-Stick: SSLCertificate set to /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.crt
2025-09-30 09:25:35.137  Status: Zi-Stick: SSLPrivateKey set to /home/domo/domoticz/plugins/Domoticz-Zigbee/certs/server.key
2025-09-30 09:25:35.138  Status: Zi-Stick: Sunricher set to 1
2025-09-30 09:25:35.138  Status: Zi-Stick: occupancySettings set to 1
2025-09-30 09:25:35.139  Status: Zi-Stick: ControllerInRawMode set to 1
2025-09-30 09:25:35.140  Status: Zi-Stick: expJsonDatabase set to 0
2025-09-30 09:25:35.140  Status: Zi-Stick: ControllerInRawMode set to 1
2025-09-30 09:25:35.519  Status: Zi-Stick: Z4D is checking the python modules requirements
2025-09-30 09:25:35.520  Status: Zi-Stick: Checking Python modules /home/domo/domoticz/plugins/Domoticz-Zigbee/constraints.txt
2025-09-30 09:25:35.544  Status: Zi-Stick:    - zigpy==0.80.1 version required 0.80.1 installed 0.80.1
2025-09-30 09:25:35.566  Status: Zi-Stick:    - zigpy_znp==0.14.1 version required 0.14.1 installed 0.14.1
2025-09-30 09:25:35.605  Status: Zi-Stick:    - zigpy_deconz==0.25.0 version required 0.25.0 installed 0.25.0
2025-09-30 09:25:35.620  Status: Zi-Stick:    - bellows==0.45.1 version required 0.45.1 installed 0.45.1
2025-09-30 09:25:35.639  Status: Zi-Stick:    - dnspython==2.7.0 version required 2.7.0 installed 2.7.0
2025-09-30 09:25:35.650  Status: Zi-Stick:    - pyserial>=3.5 version required 3.5 installed 3.5
2025-09-30 09:25:35.674  Status: Zi-Stick:    - charset-normalizer==2.0.11 version required 2.0.11 installed 2.0.11
2025-09-30 09:25:35.694  Status: Zi-Stick:    - jsonschema==4.17.3 version required 4.17.3 installed 4.17.3
2025-09-30 09:25:35.713  Status: Zi-Stick:    - cryptography<=40.0.2 version required 40.0.2 installed 3.3.2
2025-09-30 09:25:35.714  Status: Zi-Stick: Z4D is installing the WebUI in the domoticz custom menu
2025-09-30 09:25:35.717  Status: Zi-Stick: Z4D Please watch plugin logs into /home/domo/domoticz/plugins/Domoticz-Zigbee/Logs/PluginZigbee_47.log
2025-09-30 09:25:35.722  Status: Zi-Stick: Z4D is initializing a connection to Domoticz Api/Json
2025-09-30 09:25:35.737  Status: Zi-Stick: Z4D is starting with stable7-7.1.022
2025-09-30 09:25:35.762  Status: Zi-Stick: Z4D loads ZCL Cluster definitions
2025-09-30 09:25:35.890  Status: Zi-Stick: Z4D loaded 16 configuration from legacy database.
2025-09-30 09:25:35.906  Status: Zi-Stick: ++ Overwrite standard configuration model HK-SENSOR-4IN1-A with /home/domo/domoticz/plugins/Domoticz-Zigbee/Conf/Local-Devices/HK-SENSOR-4IN1-A.json
2025-09-30 09:25:35.908  Status: Zi-Stick: Z4D loads 1 configuration from the local certified Db.
2025-09-30 09:25:36.983  Status: Zi-Stick: Z4D loads 650 certified devices from repository version [6.475]
2025-09-30 09:25:36.984  Status: Zi-Stick: Z4D loading plugin database
2025-09-30 09:25:37.171  Status: Zi-Stick: Z4D loads 7 entries from /home/domo/domoticz/plugins/Domoticz-Zigbee/Data/DeviceList-47.txt
2025-09-30 09:25:37.205  Status: Zi-Stick: Z4D is starting transport Mode: 'ZigpyEZSP' Serial: '/dev/ttyUSB11' IP: '0.0.0.0 'Port: '9999'
2025-09-30 09:25:40.594  Status: Zi-Stick: Z4D starting EZSP
2025-09-30 09:25:40.600  Status: Zi-Stick: Z4D starting WebUI on port 9440
2025-09-30 09:25:41.126  Status: Zi-Stick: Plugin looks to upgrade the Certified Device package
2025-09-30 09:25:41.456  RasPiMobo: General/Percentage (PI CPU Usage)
2025-09-30 09:25:44.454  Status: Zi-Stick: ++ Enables boost power mode and the alternate transmitter output.
2025-09-30 09:25:44.456  Status: Zi-Stick: ++ Started radio ezsp port: /dev/ttyUSB11 config {'device': {'path': '/dev/ttyUSB11', 'baudrate': 115200, 'flow_control': 'software'}, 'network': {}, 'ezsp_config': {'CONFIG_TX_POWER_MODE': 3}, 'ota': {}, 'handle_unknown_devices': True}
2025-09-30 09:25:44.459  Status: Zi-Stick: ++ Coordinator initialisation requested Channel 20(0x14) ExtendedPanId: 0x0000000000000000
2025-09-30 09:25:44.461  Status: Zi-Stick: ++ Use of Zigpy Persistent Db
(...)
2025-09-30 09:26:43.284  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
2025-09-30 09:26:57.288  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:27:25.296  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:27:39.299  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:27:53.303  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:28:07.307  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:28:21.310  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:28:35.313  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:28:49.317  Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly
(...)
2025-09-30 09:29:59.334  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 67.000000 seconds ago)
(...)
2025-09-30 09:30:13.573  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 81.000000 seconds ago)
(...)
2025-09-30 09:30:41.579  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 109.000000 seconds ago)
(...)
2025-09-30 09:30:55.582  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 123.000000 seconds ago)
(...)
2025-09-30 09:31:09.585  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 137.000000 seconds ago)
2025-09-30 09:31:23.589  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 151.000000 seconds ago)
2025-09-30 09:31:37.593  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 165.000000 seconds ago)
(...)
2025-09-30 09:31:51.596  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 179.000000 seconds ago)
2025-09-30 09:32:05.600  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 193.000000 seconds ago)
2025-09-30 09:32:06.813  Status: Closing application!...
2025-09-30 09:32:06.814  Status: Stopping worker...
2025-09-30 09:32:06.815  Status: RxQueue: queue worker stopped...
2025-09-30 09:32:06.816  Status: Stopping all hardware...
(...)
2025-09-30 09:32:19.603  Error: WebServer:8080 thread seems to have ended unexpectedly (last update 207.000000 seconds ago)
Bref, au bout d'1mn on a du "thread seems to have ended unexpectedly" côté plugin suivi... attente, puis demande d'arrêt plugin et c'est le serveur web de domoticz qui ne réponds plus... Au final arrêt du service qui seul permet de remettre Domoticz en route.

Côté plugin voilà le log correspondant avec l'essai en fin. Mais à partir du moment ou cela coince c'est silencieux.

Sur cet essai, j'avais remis le flow control en SW n'ayant pas trouvé l'info pour ce coordinateur récent, mais pas de différence.
PluginZigbee_47_MacChangeKoSonoffMG24.log
(5.9 Kio) Téléchargé 48 fois

Un essai de redémarrage sur ce coordinateur en virant la config d'écrasement MAC et l'init coordinateur mène au même type d'enchainement avec le "thread seems to have ended unexpectedly" et le serveur web de domoticz qui plante.à la demande d'arrêt plugin.

=> Retour (fonctionnel) à l'ancien coordinateur ZGA008 après avoir remis la config sauvegardée au départ.

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 11:14
par pipiche
tu peux essayer de faire les manips en direct avec la commande zigpy-cli ( https://github.com/zigpy/zigpy-cli )

Code : Tout sélectionner

 zigpy radio znp /dev/ttyUSB1 restore mon-backup-precedent-coordinator-backup.json

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 11:47
par lost
J'en était resté au fait que cela ne fonctionnait pas sur les radios non TI...

Visiblement, il serait préférable que je fasse la manip de mon PC (Debian 13) que du raspberry avec Domoticz (toujours Debian 11)?

Bon, ça a l'air simple, surtout comparé à me refaire un Domoticz de test de ce côté PC (et aussi revoir le côté venv laissé en plan l'année dernière quand j'avais déjà voulu faire la MAJ globale du raspberry) pour tester si ce coordinateur ne posait pas un pb plus global de compatibilité, afin d'éviter de perturber à chaque fois la gestion de la baraque en y allant direct sur le PI...

Je regarde cela d'ici ce soir...

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 12:37
par lost
Bon, installé zigpy cli dans un venv sur le PC pour test:

Code : Tout sélectionner

mkdir zigbeeTools
cd zigbeeTools/
python3 -m venv venv
venv/bin/pip3 install zigpy-cli
Ca semble fonctionnel:

Code : Tout sélectionner

venv/bin/zigpy --help
Usage: zigpy [OPTIONS] COMMAND [ARGS]...

Options:
  -v, --verbose
  --help         Show this message and exit.

Commands:
  db
  ota
  pcap
  radio
Plug du Sonoff MG24 vu en ttyUSB0:

Code : Tout sélectionner

~/zigbeeTools/zigpy-cli$ sudo dmesg | tail -n 15
[20961.984748] usb 9-1.2: new full-speed USB device number 3 using xhci_hcd
[20962.120219] usb 9-1.2: New USB device found, idVendor=10c4, idProduct=ea60, bcdDevice= 1.00
[20962.120239] usb 9-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[20962.120247] usb 9-1.2: Product: SONOFF Dongle Plus MG24
[20962.120254] usb 9-1.2: Manufacturer: SONOFF
[20962.120260] usb 9-1.2: SerialNumber: XXXXXXXXXXXXXXXXXX
[20962.270096] usbcore: registered new interface driver usbserial_generic
[20962.270115] usbserial: USB Serial support registered for generic
[20962.283407] usbcore: registered new interface driver cp210x
[20962.283431] usbserial: USB Serial support registered for cp210x
[20962.283504] cp210x 9-1.2:1.0: cp210x converter detected
[20962.292595] usb 9-1.2: cp210x converter now attached to ttyUSB0
Essai de la commande avec le backup plugin récupéré du PI:

Code : Tout sélectionner

~/zigbeeTools/zigpy-cli$ venv/bin/zigpy radio znp /dev/ttyUSB0 restore Coordinator-47.backup 
Traceback (most recent call last):
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 701, in _skip_bootloader
    result = await responses.get()
             ^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/queues.py", line 186, in get
    await getter
asyncio.exceptions.CancelledError

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/home/yann/zigbeeTools/zigpy-cli/venv/bin/zigpy", line 8, in <module>
    sys.exit(cli())
             ~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1462, in __call__
    return self.main(*args, **kwargs)
           ~~~~~~~~~^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1383, in main
    rv = self.invoke(ctx)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1246, in invoke
    return ctx.invoke(self.callback, **ctx.params)
           ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 814, in invoke
    return callback(*args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/decorators.py", line 46, in new_func
    return f(get_current_context().obj, *args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/cli.py", line 20, in inner
    return loop.run_until_complete(cmd(*args, **kwargs))
           ~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/base_events.py", line 725, in run_until_complete
    return future.result()
           ~~~~~~~~~~~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/radio.py", line 145, in restore
    await app.connect()
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/zigbee/application.py", line 73, in connect
    await znp.connect()
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 744, in connect
    self.capabilities = (await self._skip_bootloader()).Capabilities
                         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 700, in _skip_bootloader
    async with asyncio_timeout(CONNECT_PROBE_TIMEOUT):
               ~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/timeouts.py", line 116, in __aexit__
    raise TimeoutError from exc_val
TimeoutError
Ces erreurs sortant après un peu d'attente. Rien de plus en retentant en verbose (-v).

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 13:33
par lost
Bon, c'est pas noté dans le help mais -vvv montre ceci:

Code : Tout sélectionner

/zigbeeTools/zigpy-cli$ venv/bin/zigpy -vvv radio znp /dev/ttyUSB0 restore Coordinator-47.backup
2025-09-30 13:31:05.078 marsupilami2 asyncio DEBUG Using selector: EpollSelector
2025-09-30 13:31:05.079 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Ledvance(url='https://api.update.ledvance.com/v1/zigbee/firmwares', manufacturer_ids=(4489, 4364))
2025-09-30 13:31:05.079 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Sonoff(url=None, manufacturer_ids=(4742,))
2025-09-30 13:31:05.079 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Inovelli(url=None, manufacturer_ids=(4655,))
2025-09-30 13:31:05.079 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: ThirdReality(url=None, manufacturer_ids=(4659, 4877, 5127))
2025-09-30 13:31:05.080 marsupilami2 zigpy.serial DEBUG Opening a serial connection to '/dev/ttyUSB0' (baudrate=115200, xonxoff=False, rtscts=False)
2025-09-30 13:31:05.112 marsupilami2 zigpy.serial DEBUG Connection made: SerialTransport(<_UnixSelectorEventLoop running=True closed=False debug=False>, <ZnpMtProtocol connected to '/dev/ttyUSB0' (api: <zigpy_znp.api.ZNP object at 0x7f79d4fc9160>)>, Serial<id=0x7f79d4fb70a0, open=True>(port='/dev/ttyUSB0', baudrate=115200, bytesize=8, parity='N', stopbits=1, timeout=0, xonxoff=False, rtscts=False, dsrdtr=False))
2025-09-30 13:31:05.113 marsupilami2 zigpy_znp.api DEBUG Toggling RTS/DTR pins to skip bootloader or reset chip
2025-09-30 13:31:05.113 marsupilami2 zigpy_znp.uart DEBUG Setting serial pin states: DTR=False, RTS=False
2025-09-30 13:31:05.267 marsupilami2 zigpy_znp.uart DEBUG Setting serial pin states: DTR=False, RTS=True
2025-09-30 13:31:05.420 marsupilami2 zigpy_znp.uart DEBUG Setting serial pin states: DTR=False, RTS=False
2025-09-30 13:31:05.575 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:06.076 marsupilami2 zigpy_znp.api DEBUG Sending CC253x bootloader skip bytes
2025-09-30 13:31:08.579 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:09.582 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:10.584 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:11.586 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:12.588 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:13.590 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:14.592 marsupilami2 zigpy_znp.api DEBUG Sending request: SYS.Ping.Req()
2025-09-30 13:31:15.115 marsupilami2 zigpy_znp.api DEBUG Connection to /dev/ttyUSB0 failed, cleaning up
2025-09-30 13:31:15.115 marsupilami2 zigpy.serial DEBUG Waiting for serial port to close
2025-09-30 13:31:15.117 marsupilami2 zigpy.serial DEBUG Connection lost: None
Traceback (most recent call last):
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 701, in _skip_bootloader
    result = await responses.get()
             ^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/queues.py", line 186, in get
    await getter
asyncio.exceptions.CancelledError

The above exception was the direct cause of the following exception:

Traceback (most recent call last):
  File "/home/yann/zigbeeTools/zigpy-cli/venv/bin/zigpy", line 8, in <module>
    sys.exit(cli())
             ~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1462, in __call__
    return self.main(*args, **kwargs)
           ~~~~~~~~~^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1383, in main
    rv = self.invoke(ctx)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1246, in invoke
    return ctx.invoke(self.callback, **ctx.params)
           ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 814, in invoke
    return callback(*args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/decorators.py", line 46, in new_func
    return f(get_current_context().obj, *args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/cli.py", line 20, in inner
    return loop.run_until_complete(cmd(*args, **kwargs))
           ~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/base_events.py", line 725, in run_until_complete
    return future.result()
           ~~~~~~~~~~~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/radio.py", line 145, in restore
    await app.connect()
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/zigbee/application.py", line 73, in connect
    await znp.connect()
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 744, in connect
    self.capabilities = (await self._skip_bootloader()).Capabilities
                         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_znp/api.py", line 700, in _skip_bootloader
    async with asyncio_timeout(CONNECT_PROBE_TIMEOUT):
               ~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/timeouts.py", line 116, in __aexit__
    raise TimeoutError from exc_val
TimeoutError

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 13:41
par lost
En fait, la radio c'est EZSP ici, pas ZNP, j'avais pas fait gaffe. Là on va bien plus loin sur un "info", pour tester, mais on finit tt de même avec une erreur:

Code : Tout sélectionner

~/zigbeeTools/zigpy-cli$ venv/bin/zigpy -vvv radio ezsp /dev/ttyUSB0 info
2025-09-30 13:35:32.546 marsupilami2 asyncio DEBUG Using selector: EpollSelector
2025-09-30 13:35:32.616 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Ledvance(url='https://api.update.ledvance.com/v1/zigbee/firmwares', manufacturer_ids=(4489, 4364))
2025-09-30 13:35:32.616 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Sonoff(url=None, manufacturer_ids=(4742,))
2025-09-30 13:35:32.616 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: Inovelli(url=None, manufacturer_ids=(4655,))
2025-09-30 13:35:32.619 marsupilami2 zigpy.ota DEBUG Registering new OTA provider: ThirdReality(url=None, manufacturer_ids=(4659, 4877, 5127))
2025-09-30 13:35:32.619 marsupilami2 zigpy.serial DEBUG Opening a serial connection to '/dev/ttyUSB0' (baudrate=115200, xonxoff=True, rtscts=False)
2025-09-30 13:35:32.651 marsupilami2 zigpy.serial DEBUG Connection made: <bellows.ash.AshProtocol object at 0x7f35714dba10>
2025-09-30 13:35:32.652 marsupilami2 bellows.ezsp DEBUG Resetting EZSP
2025-09-30 13:35:32.652 marsupilami2 bellows.uart DEBUG Resetting ASH
2025-09-30 13:35:32.652 marsupilami2 bellows.ash DEBUG Sending frame CANCEL + RstFrame() + FLAG
2025-09-30 13:35:32.652 marsupilami2 bellows.ash DEBUG Sending data  1ac038bc7e
2025-09-30 13:35:34.149 marsupilami2 bellows.ash DEBUG Received data 1ac1020b0a527e
2025-09-30 13:35:34.149 marsupilami2 bellows.ash DEBUG Received cancel byte, clearing buffer
2025-09-30 13:35:34.150 marsupilami2 bellows.ash DEBUG Received frame RStackFrame(version=2, reset_code=<NcpResetCode.RESET_SOFTWARE: 11>)
2025-09-30 13:35:34.150 marsupilami2 bellows.ezsp DEBUG Switching to EZSP protocol version 4
2025-09-30 13:35:34.150 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  version: () {'desiredProtocolVersion': 4}
2025-09-30 13:35:34.151 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=0, re_tx=False, ack_num=0, ezsp_frame=b'\x00\x00\x00\x04') + FLAG
2025-09-30 13:35:34.151 marsupilami2 bellows.ash DEBUG Sending data  004221a850ed2c7e
2025-09-30 13:35:34.156 marsupilami2 bellows.ash DEBUG Received data 0142a1a8592845c6a5bb7e
2025-09-30 13:35:34.157 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=0, re_tx=0, ack_num=1, ezsp_frame=b'\x00\x80\x00\r\x02Pt')
2025-09-30 13:35:34.157 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=1) + FLAG
2025-09-30 13:35:34.157 marsupilami2 bellows.ash DEBUG Sending data  8160597e
2025-09-30 13:35:34.157 marsupilami2 bellows.ezsp.protocol DEBUG Received command version: {'protocolVersion': 13, 'stackType': 2, 'stackVersion': 29776}
2025-09-30 13:35:34.157 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 1.60 to 1.40
2025-09-30 13:35:34.158 marsupilami2 bellows.ezsp DEBUG Switching to EZSP protocol version 13
2025-09-30 13:35:34.158 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  version: () {'desiredProtocolVersion': 13}
2025-09-30 13:35:34.158 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=1, re_tx=False, ack_num=1, ezsp_frame=b'\x00\x00\x01\x00\x00\r') + FLAG
2025-09-30 13:35:34.158 marsupilami2 bellows.ash DEBUG Sending data  7d314221a9542a7d38dc7a7e
2025-09-30 13:35:34.164 marsupilami2 bellows.ash DEBUG Received data 1242a1a9542a7d38b009e002607e
2025-09-30 13:35:34.165 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=1, re_tx=0, ack_num=2, ezsp_frame=b'\x00\x80\x01\x00\x00\r\x02Pt')
2025-09-30 13:35:34.165 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=2) + FLAG
2025-09-30 13:35:34.165 marsupilami2 bellows.ash DEBUG Sending data  82503a7e
2025-09-30 13:35:34.165 marsupilami2 bellows.ezsp.protocol DEBUG Received command version: {'protocolVersion': 13, 'stackType': 2, 'stackVersion': 29776}
2025-09-30 13:35:34.165 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 1.40 to 1.23
2025-09-30 13:35:34.166 marsupilami2 bellows.ezsp DEBUG EZSP Stack Type: 2, Stack Version: 7450, Protocol version: 13
2025-09-30 13:35:34.166 marsupilami2 bellows.ezsp DEBUG Sending XNCP frame: XncpCommand(command_id=<XncpCommandId.GET_SUPPORTED_FEATURES_REQ: 0>, status=<EmberStatus.SUCCESS: 0>, payload=GetSupportedFeaturesReq())
2025-09-30 13:35:34.166 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  customFrame: (b'\x00\x00\x00',) {}
2025-09-30 13:35:34.166 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=2, re_tx=False, ack_num=2, ezsp_frame=b'\x01\x00\x01G\x00\x03\x00\x00\x00') + FLAG
2025-09-30 13:35:34.166 marsupilami2 bellows.ash DEBUG Sending data  224321a97d332a16b25994e79e7e
2025-09-30 13:35:34.173 marsupilami2 bellows.ash DEBUG Received data 2343a1a97d332a65b27d33e77e
2025-09-30 13:35:34.173 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=2, re_tx=0, ack_num=3, ezsp_frame=b'\x01\x80\x01G\x00p\x00')
2025-09-30 13:35:34.173 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=3) + FLAG
2025-09-30 13:35:34.173 marsupilami2 bellows.ash DEBUG Sending data  83401b7e
2025-09-30 13:35:34.174 marsupilami2 bellows.ezsp.protocol DEBUG Received command customFrame: {'status': <EmberStatus.INVALID_CALL: 112>, 'reply': b''}
2025-09-30 13:35:34.174 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 1.23 to 1.08
2025-09-30 13:35:34.174 marsupilami2 bellows.ezsp DEBUG XNCP features: 0
2025-09-30 13:35:34.174 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getValue: () {'valueId': <EzspValueId.VALUE_FORCE_TX_AFTER_FAILED_CCA_ATTEMPTS: 58>}
2025-09-30 13:35:34.175 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=3, re_tx=False, ack_num=3, ezsp_frame=b'\x02\x00\x01\xaa\x00:') + FLAG
2025-09-30 13:35:34.175 marsupilami2 bellows.ash DEBUG Sending data  334021a9fe2a2f65c67e
2025-09-30 13:35:34.180 marsupilami2 bellows.ash DEBUG Received data 3440a1a9fe2a22b27d38fe7e
2025-09-30 13:35:34.180 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=3, re_tx=0, ack_num=4, ezsp_frame=b'\x02\x80\x01\xaa\x007\x00')
2025-09-30 13:35:34.180 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=4) + FLAG
2025-09-30 13:35:34.181 marsupilami2 bellows.ash DEBUG Sending data  8430fc7e
2025-09-30 13:35:34.181 marsupilami2 bellows.ezsp.protocol DEBUG Received command getValue: {'status': <EzspStatus.ERROR_INVALID_ID: 55>, 'value': b''}
2025-09-30 13:35:34.181 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 1.08 to 0.95
2025-09-30 13:35:34.181 marsupilami2 bellows.ezsp DEBUG Setting value VALUE_FORCE_TX_AFTER_FAILED_CCA_ATTEMPTS = 1 (old value None)
2025-09-30 13:35:34.181 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setValue: () {'valueId': <EzspValueId.VALUE_FORCE_TX_AFTER_FAILED_CCA_ATTEMPTS: 58>, 'value': b'\x01'}
2025-09-30 13:35:34.181 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=4, re_tx=False, ack_num=4, ezsp_frame=b'\x03\x00\x01\xab\x00:\x01\x01') + FLAG
2025-09-30 13:35:34.181 marsupilami2 bellows.ash DEBUG Sending data  444121a9ff2a2fb3582a047e
2025-09-30 13:35:34.187 marsupilami2 bellows.ash DEBUG Received data 4541a1a9ff2a1587db7e
2025-09-30 13:35:34.187 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=4, re_tx=0, ack_num=5, ezsp_frame=b'\x03\x80\x01\xab\x00\x00')
2025-09-30 13:35:34.188 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=5) + FLAG
2025-09-30 13:35:34.188 marsupilami2 bellows.ash DEBUG Sending data  8520dd7e
2025-09-30 13:35:34.188 marsupilami2 bellows.ezsp.protocol DEBUG Received command setValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.188 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.95 to 0.83
2025-09-30 13:35:34.188 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE: 26>}
2025-09-30 13:35:34.188 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=5, re_tx=False, ack_num=5, ezsp_frame=b'\x04\x00\x01R\x00\x1a') + FLAG
2025-09-30 13:35:34.189 marsupilami2 bellows.ash DEBUG Sending data  554621a9062a0f94897e
2025-09-30 13:35:34.195 marsupilami2 bellows.ash DEBUG Received data 5646a1a9062a1532597d5eba7e
2025-09-30 13:35:34.195 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=5, re_tx=0, ack_num=6, ezsp_frame=b'\x04\x80\x01R\x00\x00\x80\x00')
2025-09-30 13:35:34.195 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=6) + FLAG
2025-09-30 13:35:34.195 marsupilami2 bellows.ash DEBUG Sending data  8610be7e
2025-09-30 13:35:34.195 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 128}
2025-09-30 13:35:34.196 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.83 to 0.73
2025-09-30 13:35:34.196 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_SOURCE_ROUTE_TABLE_SIZE = 200 (old value 128)
2025-09-30 13:35:34.196 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE: 26>, 'value': 200}
2025-09-30 13:35:34.196 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=6, re_tx=False, ack_num=6, ezsp_frame=b'\x05\x00\x01S\x00\x1a\xc8\x00') + FLAG
2025-09-30 13:35:34.196 marsupilami2 bellows.ash DEBUG Sending data  664721a9072a0f7a59cc047e
2025-09-30 13:35:34.203 marsupilami2 bellows.ash DEBUG Received data 6747a1a9072a237d38497e
2025-09-30 13:35:34.203 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=6, re_tx=0, ack_num=7, ezsp_frame=b'\x05\x80\x01S\x006')
2025-09-30 13:35:34.203 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=7) + FLAG
2025-09-30 13:35:34.203 marsupilami2 bellows.ash DEBUG Sending data  87009f7e
2025-09-30 13:35:34.204 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.ERROR_INVALID_VALUE: 54>}
2025-09-30 13:35:34.204 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.73 to 0.65
2025-09-30 13:35:34.204 marsupilami2 bellows.ezsp DEBUG Could not set config EzspConfigId.CONFIG_SOURCE_ROUTE_TABLE_SIZE = 200: EzspStatus.ERROR_INVALID_VALUE
2025-09-30 13:35:34.204 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT: 19>}
2025-09-30 13:35:34.204 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=7, re_tx=False, ack_num=7, ezsp_frame=b'\x06\x00\x01R\x00\x13') + FLAG
2025-09-30 13:35:34.204 marsupilami2 bellows.ash DEBUG Sending data  774421a9062a0680f57e
2025-09-30 13:35:34.210 marsupilami2 bellows.ash DEBUG Received data 7044a1a9062a15ba599e597e
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=7, re_tx=0, ack_num=0, ezsp_frame=b'\x06\x80\x01R\x00\x00\x08\x00')
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=0) + FLAG
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Sending data  8070787e
2025-09-30 13:35:34.211 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 8}
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.65 to 0.57
2025-09-30 13:35:34.211 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_END_DEVICE_POLL_TIMEOUT = 8 (old value 8)
2025-09-30 13:35:34.211 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_END_DEVICE_POLL_TIMEOUT: 19>, 'value': 8}
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=0, re_tx=False, ack_num=0, ezsp_frame=b'\x07\x00\x01S\x00\x13\x08\x00') + FLAG
2025-09-30 13:35:34.211 marsupilami2 bellows.ash DEBUG Sending data  004521a9072a06ba5969ca7e
2025-09-30 13:35:34.217 marsupilami2 bellows.ash DEBUG Received data 0145a1a9072a15d7a37e
2025-09-30 13:35:34.217 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=0, re_tx=0, ack_num=1, ezsp_frame=b'\x07\x80\x01S\x00\x00')
2025-09-30 13:35:34.218 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=1) + FLAG
2025-09-30 13:35:34.218 marsupilami2 bellows.ash DEBUG Sending data  8160597e
2025-09-30 13:35:34.218 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.218 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.57 to 0.50
2025-09-30 13:35:34.218 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_TC_REJOINS_USING_WELL_KNOWN_KEY_TIMEOUT_S: 56>}
2025-09-30 13:35:34.218 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=1, re_tx=False, ack_num=1, ezsp_frame=b'\x08\x00\x01R\x008') + FLAG
2025-09-30 13:35:34.218 marsupilami2 bellows.ash DEBUG Sending data  7d314a21a9062a2d87607e
2025-09-30 13:35:34.224 marsupilami2 bellows.ash DEBUG Received data 124aa1a9062a159e58e4097e
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=1, re_tx=0, ack_num=2, ezsp_frame=b'\x08\x80\x01R\x00\x00,\x01')
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=2) + FLAG
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Sending data  82503a7e
2025-09-30 13:35:34.225 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 300}
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.50 to 0.44
2025-09-30 13:35:34.225 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_TC_REJOINS_USING_WELL_KNOWN_KEY_TIMEOUT_S = 90 (old value 300)
2025-09-30 13:35:34.225 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_TC_REJOINS_USING_WELL_KNOWN_KEY_TIMEOUT_S: 56>, 'value': 90}
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=2, re_tx=False, ack_num=2, ezsp_frame=b'\t\x00\x01S\x008Z\x00') + FLAG
2025-09-30 13:35:34.225 marsupilami2 bellows.ash DEBUG Sending data  224b21a9072a2de85988aa7e
2025-09-30 13:35:34.232 marsupilami2 bellows.ash DEBUG Received data 234ba1a9072a1559157e
2025-09-30 13:35:34.232 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=2, re_tx=0, ack_num=3, ezsp_frame=b'\t\x80\x01S\x00\x00')
2025-09-30 13:35:34.232 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=3) + FLAG
2025-09-30 13:35:34.232 marsupilami2 bellows.ash DEBUG Sending data  83401b7e
2025-09-30 13:35:34.232 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.233 marsupilami2 bellows.ash DEBUG Changing ACK timeout from 0.44 to 0.40
2025-09-30 13:35:34.233 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_INDIRECT_TRANSMISSION_TIMEOUT: 18>}
2025-09-30 13:35:34.233 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=3, re_tx=False, ack_num=3, ezsp_frame=b'\n\x00\x01R\x00\x12') + FLAG
2025-09-30 13:35:34.233 marsupilami2 bellows.ash DEBUG Sending data  334821a9062a07871d7e
2025-09-30 13:35:34.239 marsupilami2 bellows.ash DEBUG Received data 3448a1a9062a150a52e3be7e
2025-09-30 13:35:34.239 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=3, re_tx=0, ack_num=4, ezsp_frame=b'\n\x80\x01R\x00\x00\xb8\x0b')
2025-09-30 13:35:34.240 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=4) + FLAG
2025-09-30 13:35:34.240 marsupilami2 bellows.ash DEBUG Sending data  8430fc7e
2025-09-30 13:35:34.240 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 3000}
2025-09-30 13:35:34.240 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_INDIRECT_TRANSMISSION_TIMEOUT = 7680 (old value 3000)
2025-09-30 13:35:34.240 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_INDIRECT_TRANSMISSION_TIMEOUT: 18>, 'value': 7680}
2025-09-30 13:35:34.241 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=4, re_tx=False, ack_num=4, ezsp_frame=b'\x0b\x00\x01S\x00\x12\x00\x1e') + FLAG
2025-09-30 13:35:34.241 marsupilami2 bellows.ash DEBUG Sending data  444921a9072a07b247f62d7e
2025-09-30 13:35:34.247 marsupilami2 bellows.ash DEBUG Received data 4549a1a9072a15c06a7e
2025-09-30 13:35:34.247 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=4, re_tx=0, ack_num=5, ezsp_frame=b'\x0b\x80\x01S\x00\x00')
2025-09-30 13:35:34.247 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=5) + FLAG
2025-09-30 13:35:34.248 marsupilami2 bellows.ash DEBUG Sending data  8520dd7e
2025-09-30 13:35:34.248 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.248 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_STACK_PROFILE: 12>}
2025-09-30 13:35:34.248 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=5, re_tx=False, ack_num=5, ezsp_frame=b'\x0c\x00\x01R\x00\x0c') + FLAG
2025-09-30 13:35:34.248 marsupilami2 bellows.ash DEBUG Sending data  554e21a9062a19eb3c7e
2025-09-30 13:35:34.254 marsupilami2 bellows.ash DEBUG Received data 564ea1a9062a15b2597bf87e
2025-09-30 13:35:34.254 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=5, re_tx=0, ack_num=6, ezsp_frame=b'\x0c\x80\x01R\x00\x00\x00\x00')
2025-09-30 13:35:34.255 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=6) + FLAG
2025-09-30 13:35:34.255 marsupilami2 bellows.ash DEBUG Sending data  8610be7e
2025-09-30 13:35:34.255 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 0}
2025-09-30 13:35:34.255 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_STACK_PROFILE = 2 (old value 0)
2025-09-30 13:35:34.255 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_STACK_PROFILE: 12>, 'value': 2}
2025-09-30 13:35:34.255 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=6, re_tx=False, ack_num=6, ezsp_frame=b'\r\x00\x01S\x00\x0c\x02\x00') + FLAG
2025-09-30 13:35:34.255 marsupilami2 bellows.ash DEBUG Sending data  664f21a9072a19b059da827e
2025-09-30 13:35:34.261 marsupilami2 bellows.ash DEBUG Received data 674fa1a9072a15439e7e
2025-09-30 13:35:34.261 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=6, re_tx=0, ack_num=7, ezsp_frame=b'\r\x80\x01S\x00\x00')
2025-09-30 13:35:34.262 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=7) + FLAG
2025-09-30 13:35:34.262 marsupilami2 bellows.ash DEBUG Sending data  87009f7e
2025-09-30 13:35:34.262 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.262 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_SUPPORTED_NETWORKS: 45>}
2025-09-30 13:35:34.262 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=7, re_tx=False, ack_num=7, ezsp_frame=b'\x0e\x00\x01R\x00-') + FLAG
2025-09-30 13:35:34.262 marsupilami2 bellows.ash DEBUG Sending data  774c21a9062a385a2a7e
2025-09-30 13:35:34.269 marsupilami2 bellows.ash DEBUG Received data 704ca1a9062a15b3593a1b7e
2025-09-30 13:35:34.269 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=7, re_tx=0, ack_num=0, ezsp_frame=b'\x0e\x80\x01R\x00\x00\x01\x00')
2025-09-30 13:35:34.269 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=0) + FLAG
2025-09-30 13:35:34.269 marsupilami2 bellows.ash DEBUG Sending data  8070787e
2025-09-30 13:35:34.270 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 1}
2025-09-30 13:35:34.270 marsupilami2 bellows.ezsp DEBUG Current config CONFIG_SUPPORTED_NETWORKS = 1 exceeds the default of 1, skipping
2025-09-30 13:35:34.270 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE: 6>}
2025-09-30 13:35:34.270 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=0, re_tx=False, ack_num=0, ezsp_frame=b'\x0f\x00\x01R\x00\x06') + FLAG
2025-09-30 13:35:34.270 marsupilami2 bellows.ash DEBUG Sending data  004d21a9062a7d3317a67e
2025-09-30 13:35:34.276 marsupilami2 bellows.ash DEBUG Received data 014da1a9062a15ba5987a87e
2025-09-30 13:35:34.276 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=0, re_tx=0, ack_num=1, ezsp_frame=b'\x0f\x80\x01R\x00\x00\x08\x00')
2025-09-30 13:35:34.277 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=1) + FLAG
2025-09-30 13:35:34.277 marsupilami2 bellows.ash DEBUG Sending data  8160597e
2025-09-30 13:35:34.277 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 8}
2025-09-30 13:35:34.277 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_MULTICAST_TABLE_SIZE = 16 (old value 8)
2025-09-30 13:35:34.277 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE: 6>, 'value': 16}
2025-09-30 13:35:34.277 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=1, re_tx=False, ack_num=1, ezsp_frame=b'\x10\x00\x01S\x00\x06\x10\x00') + FLAG
2025-09-30 13:35:34.277 marsupilami2 bellows.ash DEBUG Sending data  7d315221a9072a7d33a25909f27e
2025-09-30 13:35:34.284 marsupilami2 bellows.ash DEBUG Received data 1252a1a9072a208c697e
2025-09-30 13:35:34.284 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=1, re_tx=0, ack_num=2, ezsp_frame=b'\x10\x80\x01S\x005')
2025-09-30 13:35:34.284 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=2) + FLAG
2025-09-30 13:35:34.284 marsupilami2 bellows.ash DEBUG Sending data  82503a7e
2025-09-30 13:35:34.285 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.ERROR_OUT_OF_MEMORY: 53>}
2025-09-30 13:35:34.285 marsupilami2 bellows.ezsp DEBUG Could not set config EzspConfigId.CONFIG_MULTICAST_TABLE_SIZE = 16: EzspStatus.ERROR_OUT_OF_MEMORY
2025-09-30 13:35:34.285 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE: 25>}
2025-09-30 13:35:34.285 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=2, re_tx=False, ack_num=2, ezsp_frame=b'\x11\x00\x01R\x00\x19') + FLAG
2025-09-30 13:35:34.285 marsupilami2 bellows.ash DEBUG Sending data  225321a9062a0c604a7e
2025-09-30 13:35:34.291 marsupilami2 bellows.ash DEBUG Received data 2353a1a9062a15b259cc3f7e
2025-09-30 13:35:34.291 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=2, re_tx=0, ack_num=3, ezsp_frame=b'\x11\x80\x01R\x00\x00\x00\x00')
2025-09-30 13:35:34.291 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=3) + FLAG
2025-09-30 13:35:34.291 marsupilami2 bellows.ash DEBUG Sending data  83401b7e
2025-09-30 13:35:34.291 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 0}
2025-09-30 13:35:34.291 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE = 2 (old value 0)
2025-09-30 13:35:34.291 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_TRUST_CENTER_ADDRESS_CACHE_SIZE: 25>, 'value': 2}
2025-09-30 13:35:34.292 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=3, re_tx=False, ack_num=3, ezsp_frame=b'\x12\x00\x01S\x00\x19\x02\x00') + FLAG
2025-09-30 13:35:34.292 marsupilami2 bellows.ash DEBUG Sending data  335021a9072a0cb059ed8c7e
2025-09-30 13:35:34.298 marsupilami2 bellows.ash DEBUG Received data 3450a1a9072a15ae0c7e
2025-09-30 13:35:34.298 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=3, re_tx=0, ack_num=4, ezsp_frame=b'\x12\x80\x01S\x00\x00')
2025-09-30 13:35:34.298 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=4) + FLAG
2025-09-30 13:35:34.298 marsupilami2 bellows.ash DEBUG Sending data  8430fc7e
2025-09-30 13:35:34.298 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.299 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_SECURITY_LEVEL: 13>}
2025-09-30 13:35:34.299 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=4, re_tx=False, ack_num=4, ezsp_frame=b'\x13\x00\x01R\x00\r') + FLAG
2025-09-30 13:35:34.299 marsupilami2 bellows.ash DEBUG Sending data  445121a9062a7d38ab807e
2025-09-30 13:35:34.305 marsupilami2 bellows.ash DEBUG Received data 4551a1a9062a15b7591ec17e
2025-09-30 13:35:34.305 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=4, re_tx=0, ack_num=5, ezsp_frame=b'\x13\x80\x01R\x00\x00\x05\x00')
2025-09-30 13:35:34.305 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=5) + FLAG
2025-09-30 13:35:34.305 marsupilami2 bellows.ash DEBUG Sending data  8520dd7e
2025-09-30 13:35:34.305 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 5}
2025-09-30 13:35:34.305 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_SECURITY_LEVEL = 5 (old value 5)
2025-09-30 13:35:34.306 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_SECURITY_LEVEL: 13>, 'value': 5}
2025-09-30 13:35:34.306 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=5, re_tx=False, ack_num=5, ezsp_frame=b'\x14\x00\x01S\x00\r\x05\x00') + FLAG
2025-09-30 13:35:34.306 marsupilami2 bellows.ash DEBUG Sending data  555621a9072a7d38b759c9de7e
2025-09-30 13:35:34.312 marsupilami2 bellows.ash DEBUG Received data 5656a1a9072a15f0147e
2025-09-30 13:35:34.312 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=5, re_tx=0, ack_num=6, ezsp_frame=b'\x14\x80\x01S\x00\x00')
2025-09-30 13:35:34.312 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=6) + FLAG
2025-09-30 13:35:34.313 marsupilami2 bellows.ash DEBUG Sending data  8610be7e
2025-09-30 13:35:34.313 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.313 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE: 5>}
2025-09-30 13:35:34.313 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=6, re_tx=False, ack_num=6, ezsp_frame=b'\x15\x00\x01R\x00\x05') + FLAG
2025-09-30 13:35:34.313 marsupilami2 bellows.ash DEBUG Sending data  665721a9062a10a97c7e
2025-09-30 13:35:34.319 marsupilami2 bellows.ash DEBUG Received data 6757a1a9062a15ba5989cd7e
2025-09-30 13:35:34.319 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=6, re_tx=0, ack_num=7, ezsp_frame=b'\x15\x80\x01R\x00\x00\x08\x00')
2025-09-30 13:35:34.320 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=7) + FLAG
2025-09-30 13:35:34.320 marsupilami2 bellows.ash DEBUG Sending data  87009f7e
2025-09-30 13:35:34.320 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 8}
2025-09-30 13:35:34.320 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_ADDRESS_TABLE_SIZE = 16 (old value 8)
2025-09-30 13:35:34.320 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE: 5>, 'value': 16}
2025-09-30 13:35:34.321 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=7, re_tx=False, ack_num=7, ezsp_frame=b'\x16\x00\x01S\x00\x05\x10\x00') + FLAG
2025-09-30 13:35:34.321 marsupilami2 bellows.ash DEBUG Sending data  775421a9072a10a25972c47e
2025-09-30 13:35:34.327 marsupilami2 bellows.ash DEBUG Received data 7054a1a9072a20d2717e
2025-09-30 13:35:34.327 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=7, re_tx=0, ack_num=0, ezsp_frame=b'\x16\x80\x01S\x005')
2025-09-30 13:35:34.327 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=0) + FLAG
2025-09-30 13:35:34.327 marsupilami2 bellows.ash DEBUG Sending data  8070787e
2025-09-30 13:35:34.327 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.ERROR_OUT_OF_MEMORY: 53>}
2025-09-30 13:35:34.328 marsupilami2 bellows.ezsp DEBUG Could not set config EzspConfigId.CONFIG_ADDRESS_TABLE_SIZE = 16: EzspStatus.ERROR_OUT_OF_MEMORY
2025-09-30 13:35:34.328 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD: 34>}
2025-09-30 13:35:34.328 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=0, re_tx=False, ack_num=0, ezsp_frame=b'\x17\x00\x01R\x00"') + FLAG
2025-09-30 13:35:34.328 marsupilami2 bellows.ash DEBUG Sending data  005521a9062a3764867e
2025-09-30 13:35:34.334 marsupilami2 bellows.ash DEBUG Received data 0155a1a9062a15b0594b0d7e
2025-09-30 13:35:34.334 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=0, re_tx=0, ack_num=1, ezsp_frame=b'\x17\x80\x01R\x00\x00\x02\x00')
2025-09-30 13:35:34.334 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=1) + FLAG
2025-09-30 13:35:34.334 marsupilami2 bellows.ash DEBUG Sending data  8160597e
2025-09-30 13:35:34.335 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 2}
2025-09-30 13:35:34.335 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD = 2 (old value 2)
2025-09-30 13:35:34.335 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_PAN_ID_CONFLICT_REPORT_THRESHOLD: 34>, 'value': 2}
2025-09-30 13:35:34.335 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=1, re_tx=False, ack_num=1, ezsp_frame=b'\x18\x00\x01S\x00"\x02\x00') + FLAG
2025-09-30 13:35:34.335 marsupilami2 bellows.ash DEBUG Sending data  7d315a21a9072a37b059283f7e
2025-09-30 13:35:34.341 marsupilami2 bellows.ash DEBUG Received data 125aa1a9072a15e7dd7e
2025-09-30 13:35:34.342 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=1, re_tx=0, ack_num=2, ezsp_frame=b'\x18\x80\x01S\x00\x00')
2025-09-30 13:35:34.342 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=2) + FLAG
2025-09-30 13:35:34.342 marsupilami2 bellows.ash DEBUG Sending data  82503a7e
2025-09-30 13:35:34.342 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.342 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_KEY_TABLE_SIZE: 30>}
2025-09-30 13:35:34.343 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=2, re_tx=False, ack_num=2, ezsp_frame=b'\x19\x00\x01R\x00\x1e') + FLAG
2025-09-30 13:35:34.343 marsupilami2 bellows.ash DEBUG Sending data  225b21a9062a0b1def7e
2025-09-30 13:35:34.349 marsupilami2 bellows.ash DEBUG Received data 235ba1a9062a15be5997887e
2025-09-30 13:35:34.349 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=2, re_tx=0, ack_num=3, ezsp_frame=b'\x19\x80\x01R\x00\x00\x0c\x00')
2025-09-30 13:35:34.349 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=3) + FLAG
2025-09-30 13:35:34.349 marsupilami2 bellows.ash DEBUG Sending data  83401b7e
2025-09-30 13:35:34.349 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 12}
2025-09-30 13:35:34.349 marsupilami2 bellows.ezsp DEBUG Current config CONFIG_KEY_TABLE_SIZE = 12 exceeds the default of 4, skipping
2025-09-30 13:35:34.349 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_MAX_END_DEVICE_CHILDREN: 17>}
2025-09-30 13:35:34.350 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=3, re_tx=False, ack_num=3, ezsp_frame=b'\x1a\x00\x01R\x00\x11') + FLAG
2025-09-30 13:35:34.350 marsupilami2 bellows.ash DEBUG Sending data  335821a9062a04adfa7e
2025-09-30 13:35:34.356 marsupilami2 bellows.ash DEBUG Received data 3458a1a9062a159259fe237e
2025-09-30 13:35:34.356 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=3, re_tx=0, ack_num=4, ezsp_frame=b'\x1a\x80\x01R\x00\x00 \x00')
2025-09-30 13:35:34.356 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=4) + FLAG
2025-09-30 13:35:34.356 marsupilami2 bellows.ash DEBUG Sending data  8430fc7e
2025-09-30 13:35:34.356 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 32}
2025-09-30 13:35:34.356 marsupilami2 bellows.ezsp DEBUG Current config CONFIG_MAX_END_DEVICE_CHILDREN = 32 exceeds the default of 32, skipping
2025-09-30 13:35:34.357 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_APPLICATION_ZDO_FLAGS: 42>}
2025-09-30 13:35:34.357 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=4, re_tx=False, ack_num=4, ezsp_frame=b'\x1b\x00\x01R\x00*') + FLAG
2025-09-30 13:35:34.357 marsupilami2 bellows.ash DEBUG Sending data  445921a9062a3ff2477e
2025-09-30 13:35:34.363 marsupilami2 bellows.ash DEBUG Received data 4559a1a9062a15b259ffee7e
2025-09-30 13:35:34.363 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=4, re_tx=0, ack_num=5, ezsp_frame=b'\x1b\x80\x01R\x00\x00\x00\x00')
2025-09-30 13:35:34.363 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=5) + FLAG
2025-09-30 13:35:34.363 marsupilami2 bellows.ash DEBUG Sending data  8520dd7e
2025-09-30 13:35:34.363 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 0}
2025-09-30 13:35:34.363 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_APPLICATION_ZDO_FLAGS = 3 (old value 0)
2025-09-30 13:35:34.364 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_APPLICATION_ZDO_FLAGS: 42>, 'value': <EmberZdoConfigurationFlags.APP_RECEIVES_SUPPORTED_ZDO_REQUESTS|APP_HANDLES_UNSUPPORTED_ZDO_REQUESTS: 3>}
2025-09-30 13:35:34.364 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=5, re_tx=False, ack_num=5, ezsp_frame=b'\x1c\x00\x01S\x00*\x03\x00') + FLAG
2025-09-30 13:35:34.364 marsupilami2 bellows.ash DEBUG Sending data  555e21a9072a3fb1597d5ef47e
2025-09-30 13:35:34.371 marsupilami2 bellows.ash DEBUG Received data 565ea1a9072a15fd567e
2025-09-30 13:35:34.371 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=5, re_tx=0, ack_num=6, ezsp_frame=b'\x1c\x80\x01S\x00\x00')
2025-09-30 13:35:34.371 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=6) + FLAG
2025-09-30 13:35:34.371 marsupilami2 bellows.ash DEBUG Sending data  8610be7e
2025-09-30 13:35:34.372 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.372 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  getConfigurationValue: () {'configId': <EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>}
2025-09-30 13:35:34.372 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=6, re_tx=False, ack_num=6, ezsp_frame=b'\x1d\x00\x01R\x00\x01') + FLAG
2025-09-30 13:35:34.372 marsupilami2 bellows.ash DEBUG Sending data  665f21a9062a14e4ba7e
2025-09-30 13:35:34.378 marsupilami2 bellows.ash DEBUG Received data 675fa1a9062a154d591d417e
2025-09-30 13:35:34.378 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=6, re_tx=0, ack_num=7, ezsp_frame=b'\x1d\x80\x01R\x00\x00\xff\x00')
2025-09-30 13:35:34.379 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=7) + FLAG
2025-09-30 13:35:34.379 marsupilami2 bellows.ash DEBUG Sending data  87009f7e
2025-09-30 13:35:34.379 marsupilami2 bellows.ezsp.protocol DEBUG Received command getConfigurationValue: {'status': <EzspStatus.SUCCESS: 0>, 'value': 255}
2025-09-30 13:35:34.379 marsupilami2 bellows.ezsp DEBUG Setting config CONFIG_PACKET_BUFFER_COUNT = 255 (old value 255)
2025-09-30 13:35:34.379 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  setConfigurationValue: () {'configId': <EzspConfigId.CONFIG_PACKET_BUFFER_COUNT: 1>, 'value': 255}
2025-09-30 13:35:34.379 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=7, re_tx=False, ack_num=7, ezsp_frame=b'\x1e\x00\x01S\x00\x01\xff\x00') + FLAG
2025-09-30 13:35:34.379 marsupilami2 bellows.ash DEBUG Sending data  775c21a9072a144d59b0527e
2025-09-30 13:35:34.386 marsupilami2 bellows.ash DEBUG Received data 705ca1a9072a22ff717e
2025-09-30 13:35:34.386 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=7, re_tx=0, ack_num=0, ezsp_frame=b'\x1e\x80\x01S\x007')
2025-09-30 13:35:34.386 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=0) + FLAG
2025-09-30 13:35:34.386 marsupilami2 bellows.ash DEBUG Sending data  8070787e
2025-09-30 13:35:34.386 marsupilami2 bellows.ezsp.protocol DEBUG Received command setConfigurationValue: {'status': <EzspStatus.ERROR_INVALID_ID: 55>}
2025-09-30 13:35:34.386 marsupilami2 bellows.ezsp DEBUG Could not set config EzspConfigId.CONFIG_PACKET_BUFFER_COUNT = 255: EzspStatus.ERROR_INVALID_ID
2025-09-30 13:35:34.387 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  addEndpoint: () {'endpoint': 1, 'profileId': 260, 'deviceId': <DeviceType.IAS_CONTROL: 1024>, 'deviceVersion': 0, 'inputClusterCount': 5, 'outputClusterCount': 4, 'inputClusterList': [0, 6, 10, 25, 1281], 'outputClusterList': [1, 32, 1280, 1282]}
2025-09-30 13:35:34.387 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=0, re_tx=False, ack_num=0, ezsp_frame=b'\x1f\x00\x01\x02\x00\x01\x04\x01\x00\x04\x00\x05\x04\x00\x00\x06\x00\n\x00\x19\x00\x01\x05\x01\x00 \x00\x00\x05\x02\x05') + FLAG
2025-09-30 13:35:34.387 marsupilami2 bellows.ash DEBUG Sending data  005d21a9562a14b658944e25af5192499a4e2dabf4ce668efcc64389fc7b3da2b2eb7e
2025-09-30 13:35:34.396 marsupilami2 bellows.ash DEBUG Received data 015da1a9562a15a99b7e
2025-09-30 13:35:34.396 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=0, re_tx=0, ack_num=1, ezsp_frame=b'\x1f\x80\x01\x02\x00\x00')
2025-09-30 13:35:34.396 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=1) + FLAG
2025-09-30 13:35:34.397 marsupilami2 bellows.ash DEBUG Sending data  8160597e
2025-09-30 13:35:34.397 marsupilami2 bellows.ezsp.protocol DEBUG Received command addEndpoint: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.397 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  addEndpoint: () {'endpoint': 2, 'profileId': 49246, 'deviceId': <DeviceType.CONTROLLER: 2080>, 'deviceVersion': 0, 'inputClusterCount': 1, 'outputClusterCount': 0, 'inputClusterList': [0], 'outputClusterList': []}
2025-09-30 13:35:34.397 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=1, re_tx=False, ack_num=1, ezsp_frame=b' \x00\x01\x02\x00\x02^\xc0 \x08\x00\x01\x00\x00\x00') + FLAG
2025-09-30 13:35:34.397 marsupilami2 bellows.ash DEBUG Sending data  7d316221a9562a17ec99b44225ab5592499e337e
2025-09-30 13:35:34.405 marsupilami2 bellows.ash DEBUG Received data 1262a1a9562a15aced7e
2025-09-30 13:35:34.405 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=1, re_tx=0, ack_num=2, ezsp_frame=b' \x80\x01\x02\x00\x00')
2025-09-30 13:35:34.405 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=2) + FLAG
2025-09-30 13:35:34.405 marsupilami2 bellows.ash DEBUG Sending data  82503a7e
2025-09-30 13:35:34.405 marsupilami2 bellows.ezsp.protocol DEBUG Received command addEndpoint: {'status': <EzspStatus.SUCCESS: 0>}
2025-09-30 13:35:34.405 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  networkState: () {}
2025-09-30 13:35:34.406 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=2, re_tx=False, ack_num=2, ezsp_frame=b'!\x00\x01\x18\x00') + FLAG
2025-09-30 13:35:34.406 marsupilami2 bellows.ash DEBUG Sending data  226321a94c2ae8287e
2025-09-30 13:35:34.411 marsupilami2 bellows.ash DEBUG Received data 2363a1a94c2a158c037e
2025-09-30 13:35:34.412 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=2, re_tx=0, ack_num=3, ezsp_frame=b'!\x80\x01\x18\x00\x00')
2025-09-30 13:35:34.412 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=3) + FLAG
2025-09-30 13:35:34.412 marsupilami2 bellows.ash DEBUG Sending data  83401b7e
2025-09-30 13:35:34.412 marsupilami2 bellows.ezsp.protocol DEBUG Received command networkState: {'status': <EmberNetworkStatus.NO_NETWORK: 0>}
2025-09-30 13:35:34.412 marsupilami2 bellows.ezsp.protocol DEBUG Sending command  networkInit: () {'networkInitBitmask': <EmberNetworkInitBitmask.NETWORK_INIT_NO_OPTIONS: 0>}
2025-09-30 13:35:34.413 marsupilami2 bellows.ash DEBUG Sending frame DataFrame(frm_num=3, re_tx=False, ack_num=3, ezsp_frame=b'"\x00\x01\x17\x00\x00\x00') + FLAG
2025-09-30 13:35:34.413 marsupilami2 bellows.ash DEBUG Sending data  336021a9432a15b231657e
2025-09-30 13:35:34.419 marsupilami2 bellows.ash DEBUG Received data 3460a1a9432a86f3377e
2025-09-30 13:35:34.419 marsupilami2 bellows.ash DEBUG Received frame DataFrame(frm_num=3, re_tx=0, ack_num=4, ezsp_frame=b'"\x80\x01\x17\x00\x93')
2025-09-30 13:35:34.419 marsupilami2 bellows.ash DEBUG Sending frame AckFrame(res=0, ncp_ready=0, ack_num=4) + FLAG
2025-09-30 13:35:34.419 marsupilami2 bellows.ash DEBUG Sending data  8430fc7e
2025-09-30 13:35:34.419 marsupilami2 bellows.ezsp.protocol DEBUG Received command networkInit: {'status': <EmberStatus.NOT_JOINED: 147>}
2025-09-30 13:35:34.420 marsupilami2 zigpy.serial DEBUG Waiting for serial port to close
2025-09-30 13:35:34.422 marsupilami2 zigpy.serial DEBUG Connection lost: None
2025-09-30 13:35:34.422 marsupilami2 bellows.uart DEBUG Connection lost: None
2025-09-30 13:35:34.422 marsupilami2 zigpy.application DEBUG Connection to the radio has been lost: None
Traceback (most recent call last):
  File "/home/yann/zigbeeTools/zigpy-cli/venv/bin/zigpy", line 8, in <module>
    sys.exit(cli())
             ~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1462, in __call__
    return self.main(*args, **kwargs)
           ~~~~~~~~~^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1383, in main
    rv = self.invoke(ctx)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1850, in invoke
    return _process_result(sub_ctx.command.invoke(sub_ctx))
                           ~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 1246, in invoke
    return ctx.invoke(self.callback, **ctx.params)
           ~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/core.py", line 814, in invoke
    return callback(*args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/click/decorators.py", line 46, in new_func
    return f(get_current_context().obj, *args, **kwargs)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/cli.py", line 20, in inner
    return loop.run_until_complete(cmd(*args, **kwargs))
           ~~~~~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/lib/python3.13/asyncio/base_events.py", line 725, in run_until_complete
    return future.result()
           ~~~~~~~~~~~~~^^
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/zigpy_cli/radio.py", line 88, in info
    await app.load_network_info(load_devices=False)
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/bellows/zigbee/application.py", line 271, in load_network_info
    await self._ensure_network_running()
  File "/home/yann/zigbeeTools/zigpy-cli/venv/lib/python3.13/site-packages/bellows/zigbee/application.py", line 185, in _ensure_network_running
    raise NetworkNotFormed("Node is not part of a network")
zigpy.exceptions.NetworkNotFormed: Node is not part of a network
Dis moi ce que tu en penses... et si je peux tenter le restore en EZSP malgré ce final?

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 15:39
par pipiche
ce que je comprends de la dernière manip, ce n'est pas u n message d'erreur, il t'indique simplement que le coordinateur n'a jamais été initialisé
zigpy.exceptions.NetworkNotFormed: Node is not part of a network
Donc

Code : Tout sélectionner

zigpy -vvvv radio ezsp /dev/xxxxx form
devrait l'initialiser

Ou faire directement la commande restore depuis un backup

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 16:43
par lost
Bon, le form passe et, en -vvv c'est très verbeux, finit par:

Code : Tout sélectionner

2025-09-30 16:17:59.065 marsupilami2 zigpy.backups DEBUG Adding a new backup NetworkBackup(version=1, backup_time=datetime.datetime(2025, 9, 30, 14, 17, 59, 65255, tzinfo=datetime.timezone.utc), network_info=NetworkInfo(extended_pan_id=e6:b3:4d:3f:87:f5:69:f9, pan_id=0xB1CA, nwk_update_id=0, nwk_manager_id=0x0000, channel=11, channel_mask=<Channels.ALL_CHANNELS: 134215680>, security_level=5, network_key=Key(key=4d:ea:13:f1:fd:c5:80:af:80:78:4a:c5:89:89:5f:7e, tx_counter=4097, rx_counter=0, seq=0, partner_ieee=ff:ff:ff:ff:ff:ff:ff:ff), tc_link_key=Key(key=5a:69:67:42:65:65:41:6c:6c:69:61:6e:63:65:30:39, tx_counter=0, rx_counter=0, seq=0, partner_ieee=38:39:8f:ff:fe:f6:29:b2), key_table=[], children=[], nwk_addresses={}, stack_specific={'ezsp': {'hashed_tclk': '8ea55547f4d74cbf31a268035ea9f655'}}, metadata={'ezsp': {'chip_info': None, 'stack_version': 13, 'can_burn_userdata_custom_eui64': True, 'can_rewrite_custom_eui64': True, 'flow_control': None}}, source='bellows@0.46.1'), node_info=NodeInfo(nwk=0x0000, ieee=38:39:8f:ff:fe:f6:29:b2, logical_type=<LogicalType.Coordinator: 0>, model='Dongle Plus MG24', manufacturer='SONOFF', version='7.4.5.0 build 0'))
Et la commande retourne bien 0 donc ca semble OK.

Dès lors, la commande info (sans verbosité) retourne les infos actuelles (ce que je pensais avoir direct, à tords):

Code : Tout sélectionner

~/zigbeeTools/zigpy-cli$ venv/bin/zigpy radio ezsp /dev/ttyUSB0 info
PAN ID:                0xB1CA
Extended PAN ID:       e6:b3:4d:3f:87:f5:69:f9
Channel:               11
Channel mask:          [11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26]
NWK update ID:         0
Device IEEE:           38:39:8f:ff:fe:f6:29:b2
Device NWK:            0x0000
Network key:           4d:ea:13:f1:fd:c5:80:af:80:78:4a:c5:89:89:5f:7e
Network key sequence:  0
Network key counter:   8193
Le restore semble passer aussi et à la fin les infos ci dessus changent bien pour celles de l'ancien coordinateur (sauf Network key counter qui diffère).

Du coup, arrêt plugin, échange des coordinateurs (avec attribution du même ttyUSB) et rédemarrage plugin (sans réinit coordinateur vu qu'a priori le zigpy cli a fait le job) qui échoue de manière similaire, avec ce dernier message normal:

Code : Tout sélectionner

2025-09-30 16:36:34.986 Status: Zi-Stick: ++ Started radio ezsp port: /dev/ttyUSB11 config {'device': {'path': '/dev/ttyUSB11', 'baudrate': 115200, 'flow_control': 'software'}, 'network': {}, 'ezsp_config': {'CONFIG_TX_POWER_MODE': 3}, 'ota': {}, 'handle_unknown_devices': True}
2025-09-30 16:36:34.987 Status: Zi-Stick: ++ Use of Zigpy Persistent Db 
Puis un peu plus d'1mn après, les "Error: Zi-Stick hardware (47) thread seems to have ended unexpectedly" qui débutent, arrêt plugin qui plante le webUI Domoticez et redémarrage du service requis.

Remettre l'ancien coordinateur au redémarrage domoticz puis réactiver plugin => Tout OK.

Bref, AMHA y'a un truc qui plait pas au plugin avec ce coordinateur au final, qui arrivait sans doute dans ce cadre avant que le restore de config soit fait.

Le pb, c'est que j'ai désormais 2 coordinateurs qui ne sont plus utilisables de manière colocalisée sans foutre la grouille afin de pouvoir tester via une install de test sur le PC, vu que sur les EFR c'est du 1 shot.

Re: Avis sur coordinateur

Publié : 30 sept. 2025, 17:58
par pipiche
je peu pas t'aider car tu ne mets pas les logs.
Ici tu as mis le flow control a Software, alors qu'avant c'était Hardware