Rasbee II: firmware flashing flashing not working, hardwar defect?

General
#1

I’ve purchased the Rasbee in Mai this year and had it working as part of a home assistant system on a Raspberry Pi 3.

Four week ago, the system got unreliable and kind of slow, so I wanted to debug the system. Actually, the situation got worse, and the old home assistant and a newly installed system didn’t show the Rasbee anymore. I tried the Rasbee on another Raspberry Pi with Raspberry Pi os and GCFFlasher. Actually, gcfflasher -l showed nothing.

Expected behavior
Listing of the Rasbee II with gcfflasher -l and finding the hardware in den deconz app in home assistant

Actual behavior
The hardware isn’t showing up and the deconz app in home assistant shows “not connected”

What I tried
Setting up home assistant from the ground and searching for Rasbeen with
Phoscon App

Setting up Raspberry Pi os in 32 and 64 bit, compiling GCFFlasher and looking for the Rasbbee

REMARK: I disabled Bluetooth and enabled uart in the config.txt for the Raspberry Pi 3 and 4

Any help is appreciated

Alexander

#2

I’ve set up a system with the headless image from the deconz website and tried to flash the firmware without success.

GCFFlasher reports: retry connect bootloader RaspBee

So is the hardware dead?

#3

This time the flashing with GCFFlasher starts, but after a view seconds I get this:
…
slip put 0x16
slip put 0xCA
slip put 0x02
slip put 0x2C
slip put 0xBE
slip put 0xBE
slip put 0xC0
|retry, failed

How to solve that?

I tried these two firmware versions:
deCONZ_RaspBeeII_0x26720700.bin.GCF August 2021 (md5 checked!)
deCONZ_RaspBeeII_0x26780700.bin.GCF Mai 2022

dmesg

[ 12.057472] uart-pl011 fe201000.serial: no DMA platform data

syslog

Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: Router Advertisement from fe80::ce40:d0ff:fe49:8553
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: adding address 2001:9e8:1632:c200:68ff:fe2e:7818:8c22/64
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: adding address fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2/64
Dec  6 08:50:38 phoscon avahi-daemon[338]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::8f43:67e2:cd43:47d0.
Dec  6 08:50:38 phoscon avahi-daemon[338]: Joining mDNS multicast group on interface eth0.IPv6 with address 2001:9e8:1632:c200:68ff:fe2e:7818:8c22.
Dec  6 08:50:38 phoscon avahi-daemon[338]: Registering new address record for 2001:9e8:1632:c200:68ff:fe2e:7818:8c22 on eth0.*.
Dec  6 08:50:38 phoscon avahi-daemon[338]: Withdrawing address record for fe80::8f43:67e2:cd43:47d0 on eth0.
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: adding route to 2001:9e8:1632:c200::/64
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: adding route to fdb2:3e1d:9b68::/64
Dec  6 08:50:38 phoscon avahi-daemon[338]: Registering new address record for fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2 on eth0.*.
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: requesting DHCPv6 information
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: fe80::ce40:d0ff:fe49:8553 is reachable again
Dec  6 08:50:38 phoscon dhcpcd[391]: eth0: adding default route via fe80::ce40:d0ff:fe49:8553
Dec  6 08:50:38 phoscon kernel: [   10.798523] ICMPv6: process `dhcpcd' is using deprecated sysctl (syscall) net.ipv6.neigh.eth0.retrans_time - use net.ipv6.neigh.eth0.retrans_time_ms instead
Dec  6 08:50:38 phoscon systemd[1]: Starting Time & Date Service...
Dec  6 08:50:38 phoscon dbus-daemon[346]: [system] Successfully activated service 'org.freedesktop.timedate1'
Dec  6 08:50:38 phoscon systemd[1]: Started Time & Date Service.
Dec  6 08:50:38 phoscon deCONZ[343]: This plugin does not support propagateSizeHints()
Dec  6 08:50:38 phoscon dhcpcd[391]: Too few arguments.
Dec  6 08:50:38 phoscon deCONZ[343]: This plugin does not support propagateSizeHints()
Dec  6 08:50:38 phoscon dhcpcd[391]: Too few arguments.
Dec  6 08:50:39 phoscon systemd[1]: systemd-rfkill.service: Succeeded.
Dec  6 08:50:39 phoscon kernel: [   12.057472] uart-pl011 fe201000.serial: no DMA platform data
Dec  6 08:50:42 phoscon dhcpcd[391]: eth0: leased 192.168.188.129 for 43200 seconds
Dec  6 08:50:42 phoscon avahi-daemon[338]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.188.129.
Dec  6 08:50:42 phoscon avahi-daemon[338]: New relevant interface eth0.IPv4 for mDNS.
Dec  6 08:50:42 phoscon avahi-daemon[338]: Registering new address record for 192.168.188.129 on eth0.IPv4.
Dec  6 08:50:42 phoscon dhcpcd[391]: eth0: adding route to 192.168.188.0/24
Dec  6 08:50:42 phoscon dhcpcd[391]: eth0: adding default route via 192.168.188.1
Dec  6 08:50:42 phoscon dhcpcd[391]: Too few arguments.
Dec  6 08:50:42 phoscon dhcpcd[391]: Too few arguments.
Dec  6 08:50:42 phoscon dhcpcd[391]: forked to background, child pid 635
Dec  6 08:50:42 phoscon systemd[1]: Started dhcpcd on all interfaces.
Dec  6 08:50:42 phoscon systemd[1]: Reached target Network.
Dec  6 08:50:42 phoscon systemd[1]: Starting dnsmasq - A lightweight DHCP and caching DNS server...
Dec  6 08:50:42 phoscon systemd[1]: Starting Network Time Service...
Dec  6 08:50:42 phoscon systemd[1]: Starting OpenBSD Secure Shell server...
Dec  6 08:50:42 phoscon systemd[1]: Starting Permit User Sessions...
Dec  6 08:50:42 phoscon systemd[1]: Starting /etc/rc.local Compatibility...
Dec  6 08:50:42 phoscon systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped.
Dec  6 08:50:42 phoscon systemd[1]: Started /etc/rc.local Compatibility.
Dec  6 08:50:42 phoscon systemd[1]: Started Permit User Sessions.
Dec  6 08:50:42 phoscon systemd[1]: Started Getty on tty1.
Dec  6 08:50:42 phoscon systemd[1]: Reached target Login Prompts.
Dec  6 08:50:42 phoscon ntpd[637]: ntpd 4.2.8p12@1.3728-o (1): Starting
Dec  6 08:50:42 phoscon ntpd[637]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 105:113
Dec  6 08:50:42 phoscon systemd[1]: Started Network Time Service.
Dec  6 08:50:42 phoscon ntpd[648]: proto: precision = 0.778 usec (-20)
Dec  6 08:50:42 phoscon dnsmasq[636]: dnsmasq: syntax check OK.
Dec  6 08:50:42 phoscon ntpd[648]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature
Dec  6 08:50:42 phoscon ntpd[648]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2023-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37
Dec  6 08:50:42 phoscon ntpd[648]: Listen and drop on 0 v6wildcard [::]:123
Dec  6 08:50:42 phoscon ntpd[648]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Dec  6 08:50:42 phoscon ntpd[648]: Listen normally on 2 lo 127.0.0.1:123
Dec  6 08:50:42 phoscon ntpd[648]: Listen normally on 3 eth0 192.168.188.129:123
Dec  6 08:50:42 phoscon ntpd[648]: Listen normally on 4 lo [::1]:123
Dec  6 08:50:42 phoscon ntpd[648]: bind(21) AF_INET6 fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2#123 flags 0x11 failed: Cannot assign requested address
Dec  6 08:50:42 phoscon ntpd[648]: unable to create socket on eth0 (5) for fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2#123
Dec  6 08:50:42 phoscon ntpd[648]: failed to init interface for address fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2
Dec  6 08:50:42 phoscon ntpd[648]: bind(21) AF_INET6 2001:9e8:1632:c200:68ff:fe2e:7818:8c22#123 flags 0x11 failed: Cannot assign requested address
Dec  6 08:50:42 phoscon ntpd[648]: unable to create socket on eth0 (6) for 2001:9e8:1632:c200:68ff:fe2e:7818:8c22#123
Dec  6 08:50:42 phoscon ntpd[648]: failed to init interface for address 2001:9e8:1632:c200:68ff:fe2e:7818:8c22
Dec  6 08:50:42 phoscon ntpd[648]: Listen normally on 7 eth0 [fe80::8f43:67e2:cd43:47d0%2]:123
Dec  6 08:50:42 phoscon ntpd[648]: Listening on routing socket on fd #22 for interface updates
Dec  6 08:50:42 phoscon ntpd[648]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec  6 08:50:42 phoscon ntpd[648]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized
Dec  6 08:50:42 phoscon dnsmasq[657]: started, version 2.80 cachesize 150
Dec  6 08:50:42 phoscon dnsmasq[657]: DNS service limited to local subnets
Dec  6 08:50:42 phoscon dnsmasq[657]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect inotify dumpfile
Dec  6 08:50:42 phoscon dnsmasq[657]: reading /run/dnsmasq/resolv.conf
Dec  6 08:50:42 phoscon dnsmasq[657]: using nameserver 192.168.188.1#53
Dec  6 08:50:42 phoscon dnsmasq[657]: using nameserver fdb2:3e1d:9b68::1#53
Dec  6 08:50:42 phoscon dnsmasq[657]: read /etc/hosts - 2 addresses
Dec  6 08:50:42 phoscon systemd[1]: Started OpenBSD Secure Shell server.
Dec  6 08:50:42 phoscon dnsmasq[658]: Too few arguments.
Dec  6 08:50:42 phoscon systemd[1]: Started dnsmasq - A lightweight DHCP and caching DNS server.
Dec  6 08:50:42 phoscon systemd[1]: Reached target Host and Network Name Lookups.
Dec  6 08:50:42 phoscon systemd[1]: Reached target Multi-User System.
Dec  6 08:50:42 phoscon systemd[1]: Reached target Graphical Interface.
Dec  6 08:50:42 phoscon systemd[1]: Starting Update UTMP about System Runlevel Changes...
Dec  6 08:50:42 phoscon systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Dec  6 08:50:42 phoscon systemd[1]: Started Update UTMP about System Runlevel Changes.
Dec  6 08:50:42 phoscon systemd[1]: Startup finished in 2.400s (kernel) + 13.139s (userspace) = 15.539s.
Dec  6 08:50:43 phoscon ntpd[648]: bind(25) AF_INET6 fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2#123 flags 0x11 failed: Cannot assign requested address
Dec  6 08:50:43 phoscon ntpd[648]: unable to create socket on eth0 (8) for fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2#123
Dec  6 08:50:43 phoscon ntpd[648]: failed to init interface for address fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2
Dec  6 08:50:43 phoscon ntpd[648]: bind(25) AF_INET6 2001:9e8:1632:c200:68ff:fe2e:7818:8c22#123 flags 0x11 failed: Cannot assign requested address
Dec  6 08:50:43 phoscon ntpd[648]: unable to create socket on eth0 (9) for 2001:9e8:1632:c200:68ff:fe2e:7818:8c22#123
Dec  6 08:50:43 phoscon ntpd[648]: failed to init interface for address 2001:9e8:1632:c200:68ff:fe2e:7818:8c22
Dec  6 08:50:43 phoscon ntpd[648]: Soliciting pool server 185.21.101.59
Dec  6 08:50:44 phoscon ntpd[648]: Soliciting pool server 188.68.36.203
Dec  6 08:50:44 phoscon ntpd[648]: Soliciting pool server 213.202.247.29
Dec  6 08:50:45 phoscon ntpd[648]: Soliciting pool server 162.159.200.1
Dec  6 08:50:45 phoscon ntpd[648]: Soliciting pool server 129.70.132.32
Dec  6 08:50:45 phoscon deCONZ-update2.sh[344]: found deCONZ port 80
Dec  6 08:50:45 phoscon deCONZ-update2.sh[344]: use database file /home/pi/.local/share/dresden-elektronik/deCONZ/zll.db
Dec  6 08:50:45 phoscon ntpd[648]: Soliciting pool server 46.4.54.78
Dec  6 08:50:45 phoscon deCONZ-update2.sh[344]: process update state noupdates
Dec  6 08:50:46 phoscon ntpd[648]: Soliciting pool server 85.214.71.38
Dec  6 08:50:46 phoscon ntpd[648]: Soliciting pool server 81.7.16.52
Dec  6 08:50:46 phoscon ntpd[648]: Soliciting pool server 31.209.85.243
Dec  6 08:50:46 phoscon ntpd[648]: Soliciting pool server 193.158.22.13
Dec  6 08:50:47 phoscon ntpd[648]: Soliciting pool server 185.11.138.90
Dec  6 08:50:47 phoscon ntpd[648]: Soliciting pool server 213.172.105.106
Dec  6 08:50:47 phoscon ntpd[648]: Soliciting pool server 46.38.241.222
Dec  6 08:50:48 phoscon dhcpcd[635]: eth0: fe80::ce40:d0ff:fe49:8553 is reachable again
Dec  6 08:50:48 phoscon dhcpcd[635]: eth0: fe80::ce40:d0ff:fe49:8553 is reachable again
Dec  6 08:50:48 phoscon ntpd[648]: Soliciting pool server 54.36.110.36
Dec  6 08:50:48 phoscon ntpd[648]: Soliciting pool server 54.36.110.36
Dec  6 08:50:49 phoscon deCONZ-WIFI2.sh[336]: command failed: Network is down (-100)
Dec  6 08:50:50 phoscon ntpd[648]: Listen normally on 10 eth0 [fdb2:3e1d:9b68:0:e02b:9941:4d5:1dc2]:123
Dec  6 08:50:50 phoscon ntpd[648]: Listen normally on 11 eth0 [2001:9e8:1632:c200:68ff:fe2e:7818:8c22]:123
Dec  6 08:50:50 phoscon ntpd[648]: new interface(s) found: waking up resolver
Dec  6 08:51:06 phoscon ntpd[648]: receive: Unexpected origin timestamp 0xe73980ea.a991c419 does not match aorg 0000000000.00000000 from server@85.214.71.38 xmt 0xe73980fa.83528829
Dec  6 08:51:16 phoscon systemd[1]: Created slice User Slice of UID 1000.
Dec  6 08:51:16 phoscon systemd[1]: Starting User Runtime Directory /run/user/1000...
Dec  6 08:51:16 phoscon systemd[1]: Started User Runtime Directory /run/user/1000.
Dec  6 08:51:16 phoscon systemd[1]: Starting User Manager for UID 1000...
Dec  6 08:51:16 phoscon systemd[981]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Dec  6 08:51:16 phoscon systemd[981]: Reached target Timers.
Dec  6 08:51:16 phoscon systemd[981]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Dec  6 08:51:16 phoscon systemd[981]: Listening on GnuPG network certificate management daemon.
Dec  6 08:51:16 phoscon systemd[981]: Reached target Paths.
Dec  6 08:51:16 phoscon systemd[981]: Starting D-Bus User Message Bus Socket.
Dec  6 08:51:16 phoscon systemd[981]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Dec  6 08:51:16 phoscon systemd[981]: Listening on GnuPG cryptographic agent and passphrase cache.
Dec  6 08:51:16 phoscon systemd[981]: Listening on D-Bus User Message Bus Socket.
Dec  6 08:51:16 phoscon systemd[981]: Reached target Sockets.
Dec  6 08:51:16 phoscon systemd[981]: Reached target Basic System.
Dec  6 08:51:16 phoscon systemd[981]: Reached target Default.
Dec  6 08:51:16 phoscon systemd[981]: Startup finished in 181ms.
Dec  6 08:51:16 phoscon systemd[1]: Started User Manager for UID 1000.
Dec  6 08:51:16 phoscon systemd[1]: Started Session 1 of user pi.
Dec  6 08:51:20 phoscon systemd[1]: systemd-fsckd.service: Succeeded.
Dec  6 08:51:24 phoscon systemd[1]: systemd-timedated.service: Succeeded.
Dec  6 08:53:01 phoscon dhcpcd[635]: eth0: Router Advertisement from fe80::ce40:d0ff:fe49:8553
#4

Next try:

sudo GCFFlasher_internal -x 3 -t 60 -f deCONZ_RaspBeeII_0x26720700.bin.GCF

debug log of GCFFlasher
…
slip put 0xBE
slip put 0xC0
09:11:31:227 TX c08184000081020083002f157369825bb670e01f485593209ba3f80490817f71170e16f617b283b7e3023592ebceecd182a924e5181ed7af3eccd7df53f105722c58452b641e1dbf51c2613638aabc5e7584357f42de8176ae00e54eb68f077d2c85ff4eb2a14aa8ed2a5cc24b92a885959f952a70df751dd23b7155eca924a1c7c78a4ff6ae96b57c16ca022cbebec0
09:11:31:227 bootloader v3 finished all data
|09:11:32:241 verify application is running
09:11:32:242 query deCONZ firmware version
09:11:34:245 failed to query application
retry, failed

Was the flashing of the firmware successfull?

GCFFlasher_internal -l shows

GCFFlasher V3_17 (c) dresden elektronik ingenieurtechnik gmbh
Path | Vendor | Product | Serial | Type
-----------------±-------±--------±-----------±------
/dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee

After rebooting, the gateway still reports:

Version: 2.19.03 / 19.9.2022
Firmware: nicht verbunden (not connected)

#5

next try:

debug log of GCFFlasher

…
slip put 0xA6
slip put 0xAC
slip put 0xC0
09:30:37:357 TX c0818400007d02009e007cdc9f7ebb3d63780e92215ad3d71cbae1cbdbdd4d695c98449099d07f513e094826dcf9ace5459007a91c5c9997a1eee63f3fc6d2ba364c507b64084902b644e5990ba33fb4dbdd7a61ddd8a0e6820912f8adef00d1bfb43f353cae1760e2e7c6bf21bd39dbddd21de96be6c5e83139ba4d0d2d288efdf5f0a7902e720cb9b7f275da4e0cc3cc86c4a57453338a9ab65b8141a2dbddc3025f73d3a20100ffc5022ca6acc0
09:30:37:357 bootloader v3 finished all data
|09:30:38:308 verify application is running
09:30:38:309 query deCONZ firmware version
09:30:40:311 failed to query application
retry, failed

GCFFlasher_internal -l

GCFFlasher V3_17 (c) dresden elektronik ingenieurtechnik gmbh
Path | Vendor | Product | Serial | Type
-----------------±-------±--------±-----------±------
/dev/ttyAMA0 | 0x0000 | 0x0000 | | RaspBee

After rebooting, the gateway still reports:

Version: 2.19.03 / 19.9.2022
Firmware: nicht verbunden (not connected)

Firmware Update does not work
#6

The question is: Is the hardware ok?

Maybe not:

hwclock --test

hwclock from util-linux 2.33.1
System Time: 1670323323.009647
Trying to open: /dev/rtc0
Trying to open: /dev/rtc
Trying to open: /dev/misc/rtc
No usable clock interface found.
hwclock: Cannot access the Hardware Clock via any known method.

#7

sudo GCFFlasher_internal -r
GCFFlasher V3_17 (c) dresden elektronik ingenieurtechnik gmbh
Reboot device RaspBee (RaspBee)
action: reset device RaspBee
wiringPi 2.52 initialized
Bootloader version 0x00030003, app crc: 0x93C2CD88

#9

Please connect us via email → Technical support

#10

Why not here so everyone can benefit :)?

#11

If we need to replace the device, contact by mail is necessary anyway. The customer has done everything here that we would have recommended, so we will have a look at the device on site.

#12

FYI I‘m currently facing the same issues with a recently purchased Raspbee II on a Pi Zero W. I was also able to reproduce the issue on a Raspi 3B.

Furthermore, I just flashed a ConBee II sucessfully on the same Raspi 3B to the latest firmware.