I think now that you’ve got it online, you can probably switch back to config files and it will probably work. If not, it is possible to configure this via the config file as well - it just might be a bit more of a pain since you need to set it back to false before re-running it or it will wipe your network.
First just check if changing back to the config file now works or not…
I removed the UI added thing and restarted the container and the config file thing worked! Thank you! Do you mind telling what caused the issue? Did I do something wrong during the setup?
I don’t think you did anything wrong. As much as I’d love to say that you missed something in the docs, I think that for a new dongle this initialisation is required, but it’s not documented that I can see…
I’ll update the docs - I’m glad it’s working and apologies for the hassle.
Hello,
Unfortunately I was not able to succeed with my dongle.
My Sonoff USB dongle stays in “INITIALIZING” state and can not come to online.
I installed the binding and followed steps described in the zigbee binding configuration.
What I have problem with is the firmware flash.
Guideline says:
Upgrading firmware
Dongle firmware can be upgraded using the openHAB console with the zigbee firmware command. The firmware file must be specified next. The dongle will be taken offline, put into firmware upgrade mode and then upgraded. You MUST ensure that you have the correct firmware for your dongle as programming the incorrect firmware can render the device inoperable - requiring a programmer to recover.
Going into konsole and typing zigbee firmware returns Error: Exception during command execution (IllegalArgumentException): Invalid number of arguments
Flashing was successful. Unfortunately the device can not switch to online mode. I tried few setting with the binding configuration and few restarts and it did not bring me further
My log file:
2024-12-04 21:10:45.277 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initializing ZigBee network [zigbee:coordinator_ember:393c17565b].
2024-12-04 21:10:45.278 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Channel 11
2024-12-04 21:10:45.278 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - PANID 46671
2024-12-04 21:10:45.279 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - EPANID C9656BCB1CB20148
2024-12-04 21:10:45.281 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key A01AD1348081A373337DA05E88969229
2024-12-04 21:10:45.282 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key 5A6967426565416C6C69616E63653039
2024-12-04 21:10:45.283 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Config: zigbee_initialise found, initializeNetwork=false
2024-12-04 21:10:45.284 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network Key String A01AD1348081A373337DA05E88969229
2024-12-04 21:10:45.285 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Network key final array A01AD1348081A373337DA05E88969229
2024-12-04 21:10:45.286 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link Key String 5A6967426565416C6C69616E63653039
2024-12-04 21:10:45.287 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Link key final array 5A6967426565416C6C69616E63653039
2024-12-04 21:10:45.287 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Initializing ZigBee Ember serial bridge handler.
2024-12-04 21:10:45.335 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - ZigBee Ember Coordinator opening Port:'/dev/ttyUSB0' PAN:b64f, EPAN:C9656BCB1CB20148, Channel:11
2024-12-04 21:10:45.336 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - Ember end device poll timeout set to (169 * 2^9) = 86528 seconds
2024-12-04 21:10:45.341 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Scheduling ZigBee start
2024-12-04 21:10:45.271 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'zigbee:coordinator_ember:393c17565b' changed from UNINITIALIZED (DISABLED) to INITIALIZING
2024-12-04 21:10:45.348 [INFO ] [penhab.event.FirmwareStatusInfoEvent] - Firmware status of thing zigbee:coordinator_ember:393c17565b changed to UNKNOWN.
2024-12-04 21:10:46.343 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - ZigBee network starting
2024-12-04 21:10:46.344 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - Initialising ZigBee coordinator
2024-12-04 21:10:46.373 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=INITIALISING
2024-12-04 21:10:46.375 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Connecting to serial port [/dev/ttyUSB0] at 115200 baud, flow control FLOWCONTROL_OUT_RTSCTS.
2024-12-04 21:10:46.435 [DEBUG] [nding.zigbee.serial.ZigBeeSerialPort] - Serial port [/dev/ttyUSB0] is initialized.
2024-12-04 21:11:23.446 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2024-12-04 21:11:23.448 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2024-12-04 21:11:28.540 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration received.
2024-12-04 21:11:28.542 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_port as no change
2024-12-04 21:11:28.544 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_channel as no change
2024-12-04 21:11:28.545 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_initialise as no change
2024-12-04 21:11:28.546 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_concentrator as no change
2024-12-04 21:11:28.547 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_trustcentremode as no change
2024-12-04 21:11:28.548 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_extendedpanid as no change
2024-12-04 21:11:28.548 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_baud as no change
2024-12-04 21:11:28.550 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Processing zigbee_flowcontrol -> 0
2024-12-04 21:11:28.551 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_panid as no change
2024-12-04 21:11:28.555 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_powermode as no change
2024-12-04 21:11:28.556 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_txpower as no change
2024-12-04 21:11:28.562 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networksize as no change
2024-12-04 21:11:28.563 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_linkkey as no change
2024-12-04 21:11:28.565 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_childtimeout as no change
2024-12-04 21:11:28.566 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networkkey as no change
2024-12-04 21:11:28.567 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_meshupdateperiod as no change
2024-12-04 21:11:28.568 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration received (Coordinator).
2024-12-04 21:11:28.571 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration update: Processing zigbee_flowcontrol -> 0
2024-12-04 21:11:48.579 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2024-12-04 21:11:48.579 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2024-12-04 21:11:53.659 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration received.
2024-12-04 21:11:53.661 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_port as no change
2024-12-04 21:11:53.664 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_channel as no change
2024-12-04 21:11:53.666 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_initialise as no change
2024-12-04 21:11:53.668 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_concentrator as no change
2024-12-04 21:11:53.671 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_trustcentremode as no change
2024-12-04 21:11:53.673 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_extendedpanid as no change
2024-12-04 21:11:53.674 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_baud as no change
2024-12-04 21:11:53.676 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Processing zigbee_flowcontrol -> 2
2024-12-04 21:11:53.677 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_panid as no change
2024-12-04 21:11:53.678 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_powermode as no change
2024-12-04 21:11:53.679 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_txpower as no change
2024-12-04 21:11:53.679 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networksize as no change
2024-12-04 21:11:53.680 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_linkkey as no change
2024-12-04 21:11:53.681 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_childtimeout as no change
2024-12-04 21:11:53.682 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networkkey as no change
2024-12-04 21:11:53.683 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_meshupdateperiod as no change
2024-12-04 21:11:53.684 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration received (Coordinator).
2024-12-04 21:11:53.685 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration update: Processing zigbee_flowcontrol -> 2
2024-12-04 21:12:17.699 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=OFFLINE
2024-12-04 21:12:17.700 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: networkStateUpdated called with state=SHUTDOWN
2024-12-04 21:12:22.733 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration received.
2024-12-04 21:12:22.734 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_port as no change
2024-12-04 21:12:22.735 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_channel as no change
2024-12-04 21:12:22.735 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_initialise as no change
2024-12-04 21:12:22.736 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_concentrator as no change
2024-12-04 21:12:22.737 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_trustcentremode as no change
2024-12-04 21:12:22.737 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_extendedpanid as no change
2024-12-04 21:12:22.738 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_baud as no change
2024-12-04 21:12:22.739 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Processing zigbee_flowcontrol -> 1
2024-12-04 21:12:22.739 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_panid as no change
2024-12-04 21:12:22.740 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_powermode as no change
2024-12-04 21:12:22.740 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_txpower as no change
2024-12-04 21:12:22.741 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networksize as no change
2024-12-04 21:12:22.742 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_linkkey as no change
2024-12-04 21:12:22.743 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_childtimeout as no change
2024-12-04 21:12:22.744 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_networkkey as no change
2024-12-04 21:12:22.744 [DEBUG] [ng.zigbee.ember.handler.EmberHandler] - null: Ember configuration update: Ignored zigbee_meshupdateperiod as no change
2024-12-04 21:12:22.745 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration received (Coordinator).
2024-12-04 21:12:22.746 [DEBUG] [bee.handler.ZigBeeCoordinatorHandler] - null: Configuration update: Processing zigbee_flowcontrol -> 1
My Configuration:
My dongle is away of the Raspberry Pi 4 Model B Rev 1.2. connected ot the USB2 slot recognised as /dev/ttyUSB0
Openhab ver. 4.2.1 / (edit updated after posting to 4.2.3)
Already working z-Wave controller with many devices.
Ember Coordinator settings (i played with flow control settings as well):
UID: zigbee:coordinator_ember:393c17565b
label: Ember Coordinator
thingTypeUID: zigbee:coordinator_ember
configuration:
zigbee_port: /dev/ttyUSB0
zigbee_initialise: false
zigbee_channel: 11
zigbee_concentrator: 1
zigbee_trustcentremode: TC_JOIN_SECURE
zigbee_extendedpanid: C9656BCB1CB20148
zigbee_flowcontrol: 1
zigbee_baud: 115200
zigbee_panid: 46671
zigbee_powermode: 1
zigbee_txpower: 0
zigbee_networksize: 25
zigbee_linkkey: 5A6967426565416C6C69616E63653039
zigbee_childtimeout: 86400
zigbee_networkkey: A01AD1348081A373337DA05E88969229
zigbee_meshupdateperiod: 86400
channels:
- id: rx_dat
channelTypeUID: zigbee:ember_ash_rx_dat
label: Data frames received
description: Provides a count of DATA frames received by the host.
configuration: {}
- id: tx_dat
channelTypeUID: zigbee:ember_ash_tx_dat
label: Data frames sent
description: Provides a count of DATA frames sent by the host.
configuration: {}
- id: rx_nak
channelTypeUID: zigbee:ember_ash_rx_nak
label: NAK frames received
description: Provides a count of DATA frames with an error or that were
discarded by the NCP due to lack of memory.
configuration: {}
- id: tx_nak
channelTypeUID: zigbee:ember_ash_tx_nak
label: NAK frames sent
description: Provides a count of DATA frames with an error or that were
discarded by the host due to failed CRC.
configuration: {}
- id: rx_ack
channelTypeUID: zigbee:ember_ash_rx_ack
label: ACK frames received
description: Provides a count of DATA frames received successfully by the NCP.
configuration: {}
- id: tx_ack
channelTypeUID: zigbee:ember_ash_tx_ack
label: ACK frames sent
description: Provides a count of DATA frames received successfully by the host.
configuration: {}
Why do you want to update the firmware? This shouldn’t be needed - the stock firmware should work just fine.
Without more detailed logging it’s a bit hard to see what’s happening, but have you initialised the network? From the logs I see here, the network is not initialised during this log, but it’s impossible to know if you’ve already done this earlier? This is described earlier in this thread - the docs were updated to reflect this, but as it’s still not in the latest RELEASE, it may not be reflected in the online docs yet.
It was written this was in the guideline to be sure to have right firmware. So I did flashed the latest one.
What does it mean initilise the network? I just connected the USB dongle. it must be online to add new devices. I am waiting the dongle to be online in my things list
So, your logging looks correct - the com.zsmartsystems.zigbee is set to DEBUG - however - I don’t see any logging from that package, which is strange. Without this I can’t really see what is going on and why it’s not working.
What I’d like to see is a startup with this logging as it will tell me (hopefully) what is going on. We should see LOTS of logging when the binding starts - you’ll likely think it’s too much, but it would be good to get it in it’s entirety.
Depending on what that shows, we might want to do the network initialisation and get the logging again to see what’s happening there, but we need to see this detailed logging… Somehow…
@chris I was able to collect log just after reboot of the system… log file.txt (385.2 KB)
After reboot the USB Dongle goes to DISABLE mode. When i want to ENABLE it these logs are comming. log file 2.txt (17.0 KB)
Maybe something strange is happening during the initialisation (ie when you tick the “advanced” box, and “Reinitialise Controller”. Can you please do this again, and provide the log from this?
I’m also not sure why we don’t see the detailed logging from com.zsmartsystems.zigbee. Unfortunately without this it’s hard to know exactly what the issue is since there are a few things that can cause the COMMUNICATION_ERROR response.
One other point - I see you’re running 4.2.3 - if there’s any way to update to the snapshot version of the binding, that might also help with additional logging.
What have you done @chris ?
I enebled additional DEBUG logs for you, reinitilized again and it appear to ONLINE!
I attach logs anyway maybe you will be able to identify the problem. I actually did really nothing. log3.txt (127.6 KB) log4.txt (177.2 KB)
I activated com.zsmartsystems.zigbee to DEBUG