RPI 4B+ 4GB; ClusterHAT v2.4; usbboot; clusterctrl:False

718 views

Skip to first unread message

monateng

unread,

Dec 28, 2019, 6:38:27 PM12/28/19

to ClusterHAT

Hey Chris,
sorry to interrupt you with this question.

But since day's I get my ClusterHAT v2.4 not running with the provided images.
> ClusterCTRL-2019-09-26-lite-1-CBRIDGE.zip
> ClusterCTRL-2019-09-26-full-1-CBRIDGE.zip

I tested the ClusterHAT on two RPI 4B 4GB, one 3B+ and my oldest 2B v1.1.

The image is stored on my win10 and extract by 7zip and copied by Win32DiskImager.

My wish is to install a lite bridged version on my 4B 4GB RPI to bring up a clustered SQL DB.

As nodes I used RPI Zero WH v1.1. 1GHz with 512MB RAM.

I wan't to use usbboot to boot the RPI Zero WH's.

> ClusterCTRL-2019-09-26-lite-1-usbboot.tar.xz

pi@cbridge:~ $ sudo clusterctrl status
clusterhat:1
clusterctrl:False
maxpi:4
hat_version:2.4
hat_version_major:2
hat_version_minor:4
hat_size:4
hat_uuid:{UUID}
hat_vendor:8086 Consultancy
hat_product_id:0x0004
throttled:0x0
hat_alert:0
hat_hub:1
hat_wp:1
hat_led:1
hat_wplink:0
hat_xra1200p:True
p1:0
p2:0
p3:0
p4:0

All RPI Zero WH will boot by using an SDCard and not on the ClusterHAT itself.

The RPI Zero WH are all connected by the USB connector to the ClusterHAT.

The two RPI 4B 4GB and the four RPI Zero WH are new.

The shiped USB cable is okay but I tested with serveral types of USB cables.

I tested the image with and without installing any update.

But everytime I get the same result. The PI's never start on ClusterHat.

I follewed your instructions:

> https://clusterctrl.com/setup-software

> https://8086.support/content/13/107/en/what-does-the-output-of-_clusterctrl-status_-mean.html
> https://8086.support/content/23/97/en/how-do-i-boot-pi-zeros-without-sd-cards-cluster-hat_cluster-ctrl.html

If you need more details and / or some logs, please contact me.

Kind Regards,
Olli

Chris Burton

unread,

Dec 29, 2019, 4:05:48 PM12/29/19

to ClusterHAT

Hi,

All RPI Zero WH will boot by using an SDCard and not on the ClusterHAT itself.

If they don't boot with SD cards in the ClusterHAT it's unlikely they're going to boot with rpiboot.

Remove the SD card from the Pi Zeros. On the controller power on the Pi Zeros with "clusterctrl on " and run "tail -f tail -f /var/log/kern.log"

- If you don't see any "Product: BCM2710 Boot" entries within a minute or so then check the USB cable between the ClusterHAT and controller Pi, and the Pi Zeros are pushed far enough onto the connectors - see https://groups.google.com/forum/#!msg/clusterhat/GTu7baguXzE/bxQDz-WbDAAJ

- If you do see then then it's most likely an issue with the contents of the SD cards.

Once you have them working with SD cards, try again with rpiboot starting with a single Pi Zero following the guide you linked - I'd remove the files first to start fresh, extract the usbboot image with tar for say P1, run "usbboot-init 1" to setup, power on with "clusterctrl on p1" and "tail -f /var/log/kern.log /var/log/daemon.log". Do you now see the "BCM2710 Boot" USB device connect and are any files sent with rpiboot?

If you don't want to send the log entries to the public list you can send them to Sup...@8086.net.uk.

Chris.

monateng

unread,

Dec 29, 2019, 6:18:22 PM12/29/19

to ClusterHAT

Hey Chris,
I double check if I pushed the RPI Zeros far enough onto the connectors.

In all RPI Zeros is no SD card pluged in.
How can I check the ClusterHAT device itself?
On the ClusterHAT just two LEDs are on.
The red LED on the right side and the orange LED infront of p1.
No blinking and also no LED on the RPI Zero p1 itself will start blinking.

Multilpe reboots and also to flash every time a new / other image dont solf the
problems. Hopefully you find my mistake and give me a clue.

Olli

My steps after flashing a new image on the RPI 4B+ SD are:
01. Image "ClusterCTRL-2019-07-10-lite-4-CBRIDGE.img" to my RPI 4B+ SD card.
02. Login, change the password for user pi.
03. wget -P ~pi/ https://dist1.8086.net/clusterctrl/usbboot/stretch/2019-04-08/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz
04. sudo rm -rf /var/lib/clusterctrl/nfs/p{1,2,3,4}/{*,.*}
05. sudo tar -axf ~pi/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz -C /var/lib/clusterctrl/nfs/p1/
06. sudo usbboot-init 1
07. sudo touch /var/lib/clusterctrl/nfs/p1/boot/ssh
08. clusterctrl on p1 && tail -f /var/log/kern.log

[ Console Output ]
> ...
> pi@cbridge:~ $ wget https://dist1.8086.net/clusterctrl/usbboot/stretch/2019-04-08/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz
> --2019-12-29 22:40:40-- https://dist1.8086.net/clusterctrl/usbboot/stretch/2019-04-08/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz
> Resolving dist1.8086.net (dist1.8086.net)... 95.216.250.64
> Connecting to dist1.8086.net (dist1.8086.net)|95.216.250.64|:443... connected.
> HTTP request sent, awaiting response... 200 OK
> Length: 255265440 (243M) [application/x-tar]
> Saving to: ‘ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz’
>
> ClusterCTRL-2019-04-08-lite-4-usbboot.tar. 100%[=======================================================================================>] 243.44M 1.85MB/s    in 2m 10s
>
> 2019-12-29 22:42:50 (1.88 MB/s) - ‘ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz’ saved [255265440/255265440]
>
> pi@cbridge:~ $ sudo rm -rf /var/lib/clusterctrl/nfs/p{1,2,3,4}/{*,.*}
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/.'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/..'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/.'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/..'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/.'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/..'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/.'
> rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/..'
> pi@cbridge:~ $ sudo tar -axf ~pi/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz -C /var/lib/clusterctrl/nfs/p1/
> pi@cbridge:~ $ sudo usbboot-init 1
> pi@cbridge:~ $ sudo touch /var/lib/clusterctrl/nfs/p1/boot/ssh
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $ clusterctrl on p1 && tail -f /var/log/kern.log
> Jul 10 01:21:38 cbridge kernel: [   27.192107] br0: port 1(eth0) entered blocking state
> Jul 10 01:21:38 cbridge kernel: [   27.192119] br0: port 1(eth0) entered forwarding state
> Jul 10 01:21:38 cbridge kernel: [   27.192302] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
> Jul 10 01:21:43 cbridge kernel: [   32.076613] EXT4-fs (mmcblk0p2): resized to 11010048 blocks
> Jul 10 01:21:47 cbridge kernel: [   36.198408] NFSD: starting 90-second grace period (net f0000041)
> Dec 29 22:33:57 cbridge kernel: [   42.915681] EXT4-fs (mmcblk0p2): resized to 16252928 blocks
> Dec 29 22:34:07 cbridge kernel: [   53.017447] EXT4-fs (mmcblk0p2): resized to 20971520 blocks
> Dec 29 22:34:18 cbridge kernel: [   63.402660] EXT4-fs (mmcblk0p2): resized to 25690112 blocks
> Dec 29 22:34:28 cbridge kernel: [   73.856850] EXT4-fs (mmcblk0p2): resized to 30408704 blocks
> Dec 29 22:34:31 cbridge kernel: [   76.866013] EXT4-fs (mmcblk0p2): resized filesystem to 31149568
> Dec 29 22:45:43 cbridge kernel: [ 749.032796] usb 1-1.4.4: new full-speed USB device number 6 using xhci_hcd
> Dec 29 22:45:43 cbridge kernel: [ 749.168745] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
> Dec 29 22:45:43 cbridge kernel: [ 749.168762] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
> Dec 29 22:45:43 cbridge kernel: [ 749.168775] usb 1-1.4.4: Product: BCM2708 Boot
> Dec 29 22:45:43 cbridge kernel: [ 749.168787] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 22:45:46 cbridge kernel: [ 751.494832] usb 1-1.4.4: USB disconnect, device number 6
> Dec 29 22:45:47 cbridge kernel: [ 752.872770] usb 1-1.4.4: new full-speed USB device number 7 using xhci_hcd
> Dec 29 22:45:47 cbridge kernel: [ 753.004772] usb 1-1.4.4: not running at top speed; connect to a high speed hub
> Dec 29 22:45:47 cbridge kernel: [ 753.010777] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
> Dec 29 22:45:47 cbridge kernel: [ 753.010793] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
> Dec 29 22:45:47 cbridge kernel: [ 753.010806] usb 1-1.4.4: Product: BCM2710 Boot
> Dec 29 22:45:47 cbridge kernel: [ 753.010818] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 22:45:47 cbridge kernel: [ 753.010830] usb 1-1.4.4: SerialNumber: Broadcom
> ^C
> pi@cbridge:~ $ date
> Sun 29 Dec 22:52:21 GMT 2019
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $
> pi@cbridge:~ $ lsusb -t
> /: Bus 03.Port 1: Dev 1, Class=root_hub, Driver=dwc_otg/1p, 480M
> /: Bus 02.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/4p, 5000M
> /: Bus 01.Port 1: Dev 1, Class=root_hub, Driver=xhci_hcd/1p, 480M
>     |__ Port 1: Dev 2, If 0, Class=Hub, Driver=hub/4p, 480M
>         |__ Port 2: Dev 3, If 0, Class=Human Interface Device, Driver=usbhid, 1.5M
>         |__ Port 4: Dev 5, If 0, Class=Hub, Driver=hub/4p, 480M
>             |__ Port 4: Dev 7, If 0, Class=Vendor Specific Class, Driver=usbfs, 12M
> pi@cbridge:~ $

Minutes later I tested your steps again.
> pi@cbridge:~ $ clusterctrl on p1 && tail -f /var/log/kern.log /var/log/daemon.log
> ==> /var/log/kern.log <==
> Dec 29 22:45:43 cbridge kernel: [ 749.168787] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 22:45:46 cbridge kernel: [ 751.494832] usb 1-1.4.4: USB disconnect, device number 6
> Dec 29 22:45:47 cbridge kernel: [ 752.872770] usb 1-1.4.4: new full-speed USB device number 7 using xhci_hcd
> Dec 29 22:45:47 cbridge kernel: [ 753.004772] usb 1-1.4.4: not running at top speed; connect to a high speed hub
> Dec 29 22:45:47 cbridge kernel: [ 753.010777] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
> Dec 29 22:45:47 cbridge kernel: [ 753.010793] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
> Dec 29 22:45:47 cbridge kernel: [ 753.010806] usb 1-1.4.4: Product: BCM2710 Boot
> Dec 29 22:45:47 cbridge kernel: [ 753.010818] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 22:45:47 cbridge kernel: [ 753.010830] usb 1-1.4.4: SerialNumber: Broadcom
> Dec 29 22:56:48 cbridge kernel: [ 1413.347081] usb 1-1.4.4: USB disconnect, device number 7
>
> ==> /var/log/daemon.log <==
> Dec 29 22:46:07 cbridge rpiboot[395]: Received message GetFileSize: overlays/dwc2.dtbo
> Dec 29 22:46:07 cbridge rpiboot[395]: File size = 801 bytes
> Dec 29 22:46:07 cbridge rpiboot[395]: Received message ReadFile: overlays/dwc2.dtbo
> Dec 29 22:46:07 cbridge rpiboot[395]: File read: overlays/dwc2.dtbo
> Dec 29 22:46:07 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:48:58 cbridge systemd[1]: Starting Cleanup of Temporary Directories...
> Dec 29 22:48:58 cbridge systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
> Dec 29 22:48:58 cbridge systemd[1]: Started Cleanup of Temporary Directories.
> Dec 29 22:56:48 cbridge rpiboot[395]: Second stage boot server done
> Dec 29 22:56:49 cbridge rpiboot[395]: Waiting for BCM2835/6/7
>
> ==> /var/log/kern.log <==
> Dec 29 22:57:13 cbridge kernel: [ 1438.285549] usb 1-1.4.4: new full-speed USB device number 8 using xhci_hcd
> Dec 29 22:57:13 cbridge kernel: [ 1438.421514] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
> Dec 29 22:57:13 cbridge kernel: [ 1438.421530] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
> Dec 29 22:57:13 cbridge kernel: [ 1438.421542] usb 1-1.4.4: Product: BCM2708 Boot
> Dec 29 22:57:13 cbridge kernel: [ 1438.421554] usb 1-1.4.4: Manufacturer: Broadcom
>
> ==> /var/log/daemon.log <==
> Dec 29 22:57:13 cbridge rpiboot[395]: Device located successfully
> Dec 29 22:57:13 cbridge rpiboot[395]: libusb: error [udev_hotplug_event] ignoring udev action bind
> Dec 29 22:57:14 cbridge rpiboot[395]: Initialised device correctly
> Dec 29 22:57:14 cbridge rpiboot[395]: Found serial number 0
> Dec 29 22:57:14 cbridge rpiboot[395]: Sending bootcode.bin
> Dec 29 22:57:14 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:14 cbridge rpiboot[395]: Writing 52296 bytes
> Dec 29 22:57:14 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
>
> ==> /var/log/kern.log <==
> Dec 29 22:57:15 cbridge kernel: [ 1440.748005] usb 1-1.4.4: USB disconnect, device number 8
>
> ==> /var/log/daemon.log <==
> Dec 29 22:57:16 cbridge rpiboot[395]: Failed : 0x0Waiting for BCM2835/6/7
>
> ==> /var/log/kern.log <==
> Dec 29 22:57:16 cbridge kernel: [ 1442.125662] usb 1-1.4.4: new full-speed USB device number 9 using xhci_hcd
> Dec 29 22:57:17 cbridge kernel: [ 1442.257660] usb 1-1.4.4: not running at top speed; connect to a high speed hub
> Dec 29 22:57:17 cbridge kernel: [ 1442.263663] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
> Dec 29 22:57:17 cbridge kernel: [ 1442.263678] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
> Dec 29 22:57:17 cbridge kernel: [ 1442.263691] usb 1-1.4.4: Product: BCM2710 Boot
> Dec 29 22:57:17 cbridge kernel: [ 1442.263703] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 22:57:17 cbridge kernel: [ 1442.263714] usb 1-1.4.4: SerialNumber: Broadcom
>
> ==> /var/log/daemon.log <==
> Dec 29 22:57:17 cbridge rpiboot[395]: Device located successfully
> Dec 29 22:57:17 cbridge rpiboot[395]: libusb: error [udev_hotplug_event] ignoring udev action bind
> Dec 29 22:57:18 cbridge rpiboot[395]: Initialised device correctly
> Dec 29 22:57:18 cbridge rpiboot[395]: Found serial number 1
> Dec 29 22:57:18 cbridge rpiboot[395]: Second stage boot server
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message GetFileSize: autoboot.txt
> Dec 29 22:57:18 cbridge rpiboot[395]: Cannot open file autoboot.txt
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message GetFileSize: config.txt
> Dec 29 22:57:18 cbridge rpiboot[395]: File size = 1842 bytes
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message ReadFile: config.txt
> Dec 29 22:57:18 cbridge rpiboot[395]: File read: config.txt
> Dec 29 22:57:18 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message GetFileSize: recovery.elf
> Dec 29 22:57:18 cbridge rpiboot[395]: Cannot open file recovery.elf
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message GetFileSize: start.elf
> Dec 29 22:57:18 cbridge rpiboot[395]: File size = 2878340 bytes
> Dec 29 22:57:18 cbridge rpiboot[395]: Received message ReadFile: start.elf
> Dec 29 22:57:18 cbridge rpiboot[395]: File read: start.elf
> Dec 29 22:57:22 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: fixup.dat
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 6729 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message ReadFile: fixup.dat
> Dec 29 22:57:22 cbridge rpiboot[395]: File read: fixup.dat
> Dec 29 22:57:22 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: recovery.elf
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file recovery.elf
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 1842 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message ReadFile: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File read: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: dt-blob.bin
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file dt-blob.bin
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: recovery.elf
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file recovery.elf
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 1842 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message ReadFile: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File read: config.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: bootcfg.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file bootcfg.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: cmdline.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 237 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message ReadFile: cmdline.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: File read: cmdline.txt
> Dec 29 22:57:22 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: recovery.img
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file recovery.img
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: kernel.img
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 5026968 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: armstub.bin
> Dec 29 22:57:22 cbridge rpiboot[395]: Cannot open file armstub.bin
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message GetFileSize: kernel.img
> Dec 29 22:57:22 cbridge rpiboot[395]: File size = 5026968 bytes
> Dec 29 22:57:22 cbridge rpiboot[395]: Received message ReadFile: kernel.img
> Dec 29 22:57:22 cbridge rpiboot[395]: File read: kernel.img
> Dec 29 22:57:29 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:29 cbridge rpiboot[395]: Received message GetFileSize: initramfs.img
> Dec 29 22:57:29 cbridge rpiboot[395]: File size = 4612428 bytes
> Dec 29 22:57:29 cbridge rpiboot[395]: Received message ReadFile: initramfs.img
> Dec 29 22:57:29 cbridge rpiboot[395]: File read: initramfs.img
> Dec 29 22:57:36 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message GetFileSize: bcm2708-rpi-zero.dtb
> Dec 29 22:57:36 cbridge rpiboot[395]: File size = 23671 bytes
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message ReadFile: bcm2708-rpi-zero.dtb
> Dec 29 22:57:36 cbridge rpiboot[395]: File read: bcm2708-rpi-zero.dtb
> Dec 29 22:57:36 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message GetFileSize: config.txt
> Dec 29 22:57:36 cbridge rpiboot[395]: File size = 1842 bytes
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message ReadFile: config.txt
> Dec 29 22:57:36 cbridge rpiboot[395]: File read: config.txt
> Dec 29 22:57:36 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message GetFileSize: overlays/dwc2.dtbo
> Dec 29 22:57:36 cbridge rpiboot[395]: File size = 801 bytes
> Dec 29 22:57:36 cbridge rpiboot[395]: Received message ReadFile: overlays/dwc2.dtbo
> Dec 29 22:57:36 cbridge rpiboot[395]: File read: overlays/dwc2.dtbo
> Dec 29 22:57:36 cbridge rpiboot[395]: libusb_bulk_transfer returned 0
> ^C
> pi@cbridge:~ $ date
> Sun 29 Dec 23:03:38 GMT 2019
> pi@cbridge:~ $

Message has been deleted

monateng

unread,

Dec 29, 2019, 6:46:29 PM12/29/19

to ClusterHAT

The RPI Zeros are:
> https://www.reichelt.de/raspberry-pi-zero-v-1-3-1-ghz-512-mb-ram-rasp-pi-zero-p256439.html

After I update the raspbian image for RPI 4B+. I reboot the system and recheck, but this don't solve the problem.

> pi@cbridge:~ $
> pi@cbridge:~ $

> pi@cbridge:~ $ clusterctrl on p1 && tail -f /var/log/kern.log /var/log/daemon.log
> ==> /var/log/kern.log <==

> Dec 29 23:28:46 cbridge kernel: [   14.948272] Bluetooth: HCI UART protocol Broadcom registered
> Dec 29 23:28:46 cbridge kernel: [   15.222202] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
> Dec 29 23:28:46 cbridge kernel: [   15.222212] Bluetooth: BNEP filters: protocol multicast
> Dec 29 23:28:46 cbridge kernel: [   15.222231] Bluetooth: BNEP socket layer initialized
> Dec 29 23:28:48 cbridge kernel: [   17.111890] bcmgenet fd580000.genet eth0: Link is Up - 100Mbps/Full - flow control off
> Dec 29 23:28:48 cbridge kernel: [   17.111937] br0: port 1(eth0) entered blocking state
> Dec 29 23:28:48 cbridge kernel: [   17.111949] br0: port 1(eth0) entered forwarding state
> Dec 29 23:28:48 cbridge kernel: [   17.112129] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
> Dec 29 23:28:54 cbridge kernel: [   23.061357] NFSD: starting 90-second grace period (net f0000041)
> Dec 29 23:28:58 cbridge kernel: [   27.131872] usb 1-1.4.4: device descriptor read/64, error -110
>
> ==> /var/log/daemon.log <==
> Dec 29 23:28:58 cbridge systemd[729]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
> Dec 29 23:28:58 cbridge systemd[729]: Reached target Sockets.
> Dec 29 23:28:58 cbridge systemd[729]: Reached target Basic System.
> Dec 29 23:28:58 cbridge systemd[729]: Reached target Default.
> Dec 29 23:28:58 cbridge systemd[729]: Startup finished in 143ms.
> Dec 29 23:28:58 cbridge systemd[1]: Started User Manager for UID 1000.
> Dec 29 23:28:58 cbridge systemd[1]: Started Session c1 of user pi.
> Dec 29 23:29:02 cbridge dhcpcd[685]: br0: no IPv6 Routers available
> Dec 29 23:29:08 cbridge systemd[1]: systemd-fsckd.service: Succeeded.
> Dec 29 23:29:17 cbridge systemd[1]: systemd-hostnamed.service: Succeeded.
>
> ==> /var/log/kern.log <==
> Dec 29 23:29:41 cbridge kernel: [   56.221629] usb 1-1.4.4: new full-speed USB device number 11 using xhci_hcd
> Dec 29 23:29:42 cbridge kernel: [   56.357651] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
> Dec 29 23:29:42 cbridge kernel: [   56.357667] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
> Dec 29 23:29:42 cbridge kernel: [   56.357680] usb 1-1.4.4: Product: BCM2708 Boot
> Dec 29 23:29:42 cbridge kernel: [   56.357692] usb 1-1.4.4: Manufacturer: Broadcom
>
> ==> /var/log/daemon.log <==
> Dec 29 23:29:42 cbridge rpiboot[415]: Device located successfully
> Dec 29 23:29:42 cbridge rpiboot[415]: libusb: error [udev_hotplug_event] ignoring udev action bind
> Dec 29 23:29:43 cbridge rpiboot[415]: Initialised device correctly
> Dec 29 23:29:43 cbridge rpiboot[415]: Found serial number 0
> Dec 29 23:29:43 cbridge rpiboot[415]: Sending bootcode.bin
> Dec 29 23:29:43 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:43 cbridge rpiboot[415]: Writing 52296 bytes
> Dec 29 23:29:43 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
>
> ==> /var/log/kern.log <==
> Dec 29 23:29:44 cbridge kernel: [   58.683990] usb 1-1.4.4: USB disconnect, device number 11
>
> ==> /var/log/daemon.log <==
> Dec 29 23:29:45 cbridge rpiboot[415]: Failed : 0x0Waiting for BCM2835/6/7
>
> ==> /var/log/kern.log <==
> Dec 29 23:29:45 cbridge kernel: [   60.061629] usb 1-1.4.4: new full-speed USB device number 12 using xhci_hcd
> Dec 29 23:29:45 cbridge kernel: [   60.193636] usb 1-1.4.4: not running at top speed; connect to a high speed hub
> Dec 29 23:29:45 cbridge kernel: [   60.199636] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
> Dec 29 23:29:45 cbridge kernel: [   60.199651] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
> Dec 29 23:29:45 cbridge kernel: [   60.199664] usb 1-1.4.4: Product: BCM2710 Boot
> Dec 29 23:29:45 cbridge kernel: [   60.199675] usb 1-1.4.4: Manufacturer: Broadcom
> Dec 29 23:29:45 cbridge kernel: [   60.199687] usb 1-1.4.4: SerialNumber: Broadcom
>
> ==> /var/log/daemon.log <==
> Dec 29 23:29:45 cbridge rpiboot[415]: Device located successfully
> Dec 29 23:29:45 cbridge rpiboot[415]: libusb: error [udev_hotplug_event] ignoring udev action bind
> Dec 29 23:29:46 cbridge rpiboot[415]: Initialised device correctly
> Dec 29 23:29:46 cbridge rpiboot[415]: Found serial number 1
> Dec 29 23:29:46 cbridge rpiboot[415]: Second stage boot server
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message GetFileSize: autoboot.txt
> Dec 29 23:29:46 cbridge rpiboot[415]: Cannot open file autoboot.txt
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message GetFileSize: config.txt
> Dec 29 23:29:46 cbridge rpiboot[415]: File size = 1842 bytes
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message ReadFile: config.txt
> Dec 29 23:29:46 cbridge rpiboot[415]: File read: config.txt
> Dec 29 23:29:46 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message GetFileSize: recovery.elf
> Dec 29 23:29:46 cbridge rpiboot[415]: Cannot open file recovery.elf
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message GetFileSize: start.elf
> Dec 29 23:29:46 cbridge rpiboot[415]: File size = 2878340 bytes
> Dec 29 23:29:46 cbridge rpiboot[415]: Received message ReadFile: start.elf
> Dec 29 23:29:46 cbridge rpiboot[415]: File read: start.elf
> Dec 29 23:29:51 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: fixup.dat
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 6729 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message ReadFile: fixup.dat
> Dec 29 23:29:51 cbridge rpiboot[415]: File read: fixup.dat
> Dec 29 23:29:51 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: recovery.elf
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file recovery.elf
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 1842 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message ReadFile: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File read: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: dt-blob.bin
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file dt-blob.bin
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: recovery.elf
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file recovery.elf
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 1842 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message ReadFile: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File read: config.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: bootcfg.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file bootcfg.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: cmdline.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 237 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message ReadFile: cmdline.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: File read: cmdline.txt
> Dec 29 23:29:51 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: recovery.img
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file recovery.img
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: kernel.img
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 5026968 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: armstub.bin
> Dec 29 23:29:51 cbridge rpiboot[415]: Cannot open file armstub.bin
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message GetFileSize: kernel.img
> Dec 29 23:29:51 cbridge rpiboot[415]: File size = 5026968 bytes
> Dec 29 23:29:51 cbridge rpiboot[415]: Received message ReadFile: kernel.img
> Dec 29 23:29:51 cbridge rpiboot[415]: File read: kernel.img
> Dec 29 23:29:58 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:29:58 cbridge rpiboot[415]: Received message GetFileSize: initramfs.img
> Dec 29 23:29:58 cbridge rpiboot[415]: File size = 4612428 bytes
> Dec 29 23:29:58 cbridge rpiboot[415]: Received message ReadFile: initramfs.img
> Dec 29 23:29:58 cbridge rpiboot[415]: File read: initramfs.img
> Dec 29 23:30:05 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message GetFileSize: bcm2708-rpi-zero.dtb
> Dec 29 23:30:05 cbridge rpiboot[415]: File size = 23671 bytes
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message ReadFile: bcm2708-rpi-zero.dtb
> Dec 29 23:30:05 cbridge rpiboot[415]: File read: bcm2708-rpi-zero.dtb
> Dec 29 23:30:05 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message GetFileSize: config.txt
> Dec 29 23:30:05 cbridge rpiboot[415]: File size = 1842 bytes
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message ReadFile: config.txt
> Dec 29 23:30:05 cbridge rpiboot[415]: File read: config.txt
> Dec 29 23:30:05 cbridge rpiboot[415]: libusb_bulk_transfer returned 0
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message GetFileSize: overlays/dwc2.dtbo
> Dec 29 23:30:05 cbridge rpiboot[415]: File size = 801 bytes
> Dec 29 23:30:05 cbridge rpiboot[415]: Received message ReadFile: overlays/dwc2.dtbo
> Dec 29 23:30:05 cbridge rpiboot[415]: File read: overlays/dwc2.dtbo
> Dec 29 23:30:05 cbridge rpiboot[415]: libusb_bulk_transfer returned 0

> ^C
> pi@cbridge:~ $ date

> Sun 29 Dec 23:34:40 GMT 2019
> pi@cbridge:~ $

Chris Burton

unread,

Dec 30, 2019, 8:28:00 AM12/30/19

to ClusterHAT

Hi,

I double check if I pushed the RPI Zeros far enough onto the connectors.

From the logs you sent P1 looks plugged in OK.

In all RPI Zeros is no SD card pluged in.
How can I check the ClusterHAT device itself?

Follow the instructions from my previous reply and try booting with an SD card - all Cluster HAT are tested (with the cable you get) before being sent out with Pi Zeros booting from SD cards.

On the ClusterHAT just two LEDs are on.
The red LED on the right side and the orange LED infront of p1.
No blinking and also no LED on the RPI Zero p1 itself will start blinking.

On the Pi Zero the LED only comes on after the files have been transferred and it starts to boot.

Multilpe reboots and also to flash every time a new / other image dont solf the
problems. Hopefully you find my mistake and give me a clue.

> Dec 29 22:57:36 cbridge rpiboot[395]: Received message ReadFile: overlays/dwc2.dtbo
> Dec 29 22:57:36 cbridge rpiboot[395]: File read: overlays/dwc2.dtbo
> Dec 29 22:57:36 cbridge rpiboot[395]: libusb_bulk_transfer returned 0

When it gets stuck at this position if you unplug the USB cable and plug it back in again does show "Received message Done: overlays/dwc2.dtbo" in the logs and boot up?

If you have more than one Pi Zero does it work with a different one in the same position?

Chris.

monateng

unread,

Jan 1, 2020, 5:08:06 PM1/1/20

to ClusterHAT

Hi Chris,

hope you've made a good start into the new decade and sorry for this late answer.

With SDCard the p1 will start but not without an SDCard.

I do not find any answer why your tutorial to start the p1 without any SDCard is not useable for me.

> https://8086.support/content/23/97/en/how-do-i-boot-pi-zeros-without-sd-cards-cluster-hat_cluster-ctrl.html

[ console output with SDCard ]

pi@cbridge:~ $ wget -P ~pi/ https://dist1.8086.net/clusterctrl/usbboot/stretch/2019-04-08/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz

--2020-01-01 21:31:40--  https://dist1.8086.net/clusterctrl/usbboot/stretch/2019-04-08/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz


Resolving dist1.8086.net (dist1.8086.net)... 95.216.250.64
Connecting to dist1.8086.net (dist1.8086.net)|95.216.250.64|:443... connected.
HTTP request sent, awaiting response... 200 OK
Length: 255265440 (243M) [application/x-tar]

Saving to: ‘/home/pi/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz’

ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz    100%[====================================================================================================>] 243.44M  2.32MB/s    in 1m 57s

2020-01-01 21:33:38 (2.08 MB/s) - ‘/home/pi/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz’ saved [255265440/255265440]

pi@cbridge:~ $ sudo rm -rf /var/lib/clusterctrl/nfs/p{1,2,3,4}/{*,.*}

rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/..'

pi@cbridge:~ $ sudo tar -axf ~pi/ClusterCTRL-2019-04-08-lite-4-usbboot.tar.xz -C /var/lib/clusterctrl/nfs/p1/
pi@cbridge:~ $ sudo usbboot-init 1
pi@cbridge:~ $ sudo touch /var/lib/clusterctrl/nfs/p1/boot/ssh

pi@cbridge:~ $ clusterctrl on p1 && tail -f /var/log/kern.log /var/log/daemon.log

==> /var/log/kern.log <==
Sep 26 01:24:46 cbridge kernel: [   27.432067] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
Sep 26 01:24:50 cbridge kernel: [   31.965069] EXT4-fs (mmcblk0p2): resized to 11010048 blocks
Sep 26 01:24:58 cbridge kernel: [   39.626832] NFSD: starting 90-second grace period (net f0000041)
Jan  1 21:24:00 cbridge kernel: [   41.999366] EXT4-fs (mmcblk0p2): resized to 15728640 blocks
Jan  1 21:24:10 cbridge kernel: [   52.039909] EXT4-fs (mmcblk0p2): resized to 20447232 blocks
Jan  1 21:24:21 cbridge kernel: [   62.637764] EXT4-fs (mmcblk0p2): resized to 25165824 blocks
Jan  1 21:24:31 cbridge kernel: [   72.720790] EXT4-fs (mmcblk0p2): resized to 29360128 blocks
Jan  1 21:24:36 cbridge kernel: [   77.523122] EXT4-fs (mmcblk0p2): resized filesystem to 31150592
Jan  1 21:28:38 cbridge kernel: [  319.845124] Process accounting resumed
Jan  1 21:28:39 cbridge kernel: [  320.914414] Process accounting resumed

==> /var/log/daemon.log <==
Jan  1 21:30:04 cbridge systemd[1]: getty@tty1.service: Succeeded.
Jan  1 21:30:04 cbridge systemd[1]: getty@tty1.service: Service has no hold-off time (RestartSec=0), scheduling restart.
Jan  1 21:30:04 cbridge systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 2.
Jan  1 21:30:04 cbridge systemd[1]: Stopped Getty on tty1.
Jan  1 21:30:04 cbridge systemd[1]: Started Getty on tty1.
Jan  1 21:30:16 cbridge systemd[1]: getty@tty1.service: Succeeded.
Jan  1 21:30:16 cbridge systemd[1]: getty@tty1.service: Service has no hold-off time (RestartSec=0), scheduling restart.
Jan  1 21:30:16 cbridge systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 3.
Jan  1 21:30:16 cbridge systemd[1]: Stopped Getty on tty1.
Jan  1 21:30:16 cbridge systemd[1]: Started Getty on tty1.

==> /var/log/kern.log <==
Jan  1 21:36:33 cbridge kernel: [  794.304949] usb 1-1.4.4: new high-speed USB device number 6 using xhci_hcd
Jan  1 21:36:38 cbridge kernel: [  799.455128] usb 1-1.4.4: device descriptor read/64, error -110
Jan  1 21:36:45 cbridge kernel: [  806.224986] usb 1-1.4.4: device descriptor read/64, error -71
Jan  1 21:36:45 cbridge kernel: [  806.444690] usb 1-1.4.4: new high-speed USB device number 7 using xhci_hcd
Jan  1 21:36:45 cbridge kernel: [  806.575811] usb 1-1.4.4: New USB device found, idVendor=3171, idProduct=0020, bcdDevice= 1.00
Jan  1 21:36:45 cbridge kernel: [  806.575827] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jan  1 21:36:45 cbridge kernel: [  806.575840] usb 1-1.4.4: Product: ClusterCTRL
Jan  1 21:36:45 cbridge kernel: [  806.575851] usb 1-1.4.4: Manufacturer: 8086 Consultancy
Jan  1 21:36:45 cbridge kernel: [  806.575863] usb 1-1.4.4: SerialNumber: 1
Jan  1 21:36:45 cbridge kernel: [  806.648309] usbcore: registered new interface driver cdc_ether
Jan  1 21:36:45 cbridge kernel: [  806.654377] rndis_host 1-1.4.4:1.0 eth1: register 'rndis_host' at usb-0000:01:00.0-1.4.4, RNDIS device, 00:22:82:ff:fe:01
Jan  1 21:36:45 cbridge kernel: [  806.654705] usbcore: registered new interface driver rndis_host
Jan  1 21:36:45 cbridge kernel: [  806.660791] usbcore: registered new interface driver rndis_wlan
Jan  1 21:36:45 cbridge kernel: [  806.665806] cdc_acm 1-1.4.4:1.2: ttyACM0: USB ACM device
Jan  1 21:36:45 cbridge kernel: [  806.674596] cdc_acm 1-1.4.4:1.4: ttyACM1: USB ACM device
Jan  1 21:36:45 cbridge kernel: [  806.677410] usbcore: registered new interface driver cdc_acm
Jan  1 21:36:45 cbridge kernel: [  806.677422] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters

==> /var/log/daemon.log <==
Jan  1 21:36:45 cbridge rpiboot[434]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan  1 21:36:45 cbridge systemd-udevd[1536]: Using default interface naming scheme 'v240'.

==> /var/log/kern.log <==
Jan  1 21:36:45 cbridge kernel: [  806.730869] rndis_host 1-1.4.4:1.0 ethpi1: renamed from eth1

==> /var/log/daemon.log <==
Jan  1 21:36:45 cbridge systemd-udevd[1532]: Using default interface naming scheme 'v240'.
Jan  1 21:36:45 cbridge systemd[1]: Found device ClusterCTRL.
Jan  1 21:36:45 cbridge systemd[1]: Started ifup for ethpi1.
Jan  1 21:36:45 cbridge sh[1546]: ifup: interface br0 already configured

==> /var/log/kern.log <==
Jan  1 21:36:45 cbridge kernel: [  806.988266] br0: port 2(ethpi1) entered blocking state
Jan  1 21:36:45 cbridge kernel: [  806.988272] br0: port 2(ethpi1) entered disabled state
Jan  1 21:36:45 cbridge kernel: [  806.988434] device ethpi1 entered promiscuous mode
Jan  1 21:36:45 cbridge kernel: [  807.019827] br0: port 2(ethpi1) entered blocking state
Jan  1 21:36:45 cbridge kernel: [  807.019835] br0: port 2(ethpi1) entered forwarding state

==> /var/log/daemon.log <==
Jan  1 21:36:46 cbridge sh[1546]: ethpi1=ethpi1
Jan  1 21:36:47 cbridge avahi-daemon[314]: Joining mDNS multicast group on interface ethpi1.IPv6 with address fe80::222:82ff:feff:fe01.
Jan  1 21:36:47 cbridge avahi-daemon[314]: New relevant interface ethpi1.IPv6 for mDNS.
Jan  1 21:36:47 cbridge avahi-daemon[314]: Registering new address record for fe80::222:82ff:feff:fe01 on ethpi1.*.
^C
pi@cbridge:~ $

[ console output without SDCard ]

pi@cbridge:~ $ clusterctrl off p1

pi@cbridge:~ $ clusterctrl on p1 && tail -f /var/log/kern.log /var/log/daemon.log

==> /var/log/kern.log <==
Jan  1 21:36:45 cbridge kernel: [  806.988266] br0: port 2(ethpi1) entered blocking state
Jan  1 21:36:45 cbridge kernel: [  806.988272] br0: port 2(ethpi1) entered disabled state
Jan  1 21:36:45 cbridge kernel: [  806.988434] device ethpi1 entered promiscuous mode
Jan  1 21:36:45 cbridge kernel: [  807.019827] br0: port 2(ethpi1) entered blocking state
Jan  1 21:36:45 cbridge kernel: [  807.019835] br0: port 2(ethpi1) entered forwarding state
Jan  1 21:38:35 cbridge kernel: [  916.136024] usb 1-1.4.4: USB disconnect, device number 7
Jan  1 21:38:35 cbridge kernel: [  916.136314] rndis_host 1-1.4.4:1.0 ethpi1: unregister 'rndis_host' usb-0000:01:00.0-1.4.4, RNDIS device
Jan  1 21:38:35 cbridge kernel: [  916.145983] br0: port 2(ethpi1) entered disabled state
Jan  1 21:38:35 cbridge kernel: [  916.146422] device ethpi1 left promiscuous mode
Jan  1 21:38:35 cbridge kernel: [  916.146428] br0: port 2(ethpi1) entered disabled state

==> /var/log/daemon.log <==
Jan  1 21:36:47 cbridge avahi-daemon[314]: Registering new address record for fe80::222:82ff:feff:fe01 on ethpi1.*.
Jan  1 21:38:22 cbridge systemd[1]: Starting Cleanup of Temporary Directories...
Jan  1 21:38:22 cbridge systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Jan  1 21:38:22 cbridge systemd[1]: Started Cleanup of Temporary Directories.
Jan  1 21:38:35 cbridge avahi-daemon[314]: Interface ethpi1.IPv6 no longer relevant for mDNS.
Jan  1 21:38:35 cbridge avahi-daemon[314]: Leaving mDNS multicast group on interface ethpi1.IPv6 with address fe80::222:82ff:feff:fe01.
Jan  1 21:38:35 cbridge avahi-daemon[314]: Withdrawing address record for fe80::222:82ff:feff:fe01 on ethpi1.
Jan  1 21:38:35 cbridge systemd[1]: Stopping ifup for ethpi1...
Jan  1 21:38:35 cbridge systemd[1]: ifup@ethpi1.service: Succeeded.
Jan  1 21:38:35 cbridge systemd[1]: Stopped ifup for ethpi1.

==> /var/log/kern.log <==
Jan  1 21:39:11 cbridge kernel: [  952.592867] usb 1-1.4.4: new full-speed USB device number 8 using xhci_hcd
Jan  1 21:39:11 cbridge kernel: [  952.728832] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
Jan  1 21:39:11 cbridge kernel: [  952.728848] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jan  1 21:39:11 cbridge kernel: [  952.728862] usb 1-1.4.4: Product: BCM2708 Boot
Jan  1 21:39:11 cbridge kernel: [  952.728874] usb 1-1.4.4: Manufacturer: Broadcom

==> /var/log/daemon.log <==
Jan  1 21:39:11 cbridge rpiboot[434]: Device located successfully
Jan  1 21:39:11 cbridge rpiboot[434]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan  1 21:39:12 cbridge rpiboot[434]: Initialised device correctly
Jan  1 21:39:12 cbridge rpiboot[434]: Found serial number 0
Jan  1 21:39:12 cbridge rpiboot[434]: Sending bootcode.bin
Jan  1 21:39:12 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:12 cbridge rpiboot[434]: Writing 52296 bytes
Jan  1 21:39:12 cbridge rpiboot[434]: libusb_bulk_transfer returned 0

==> /var/log/kern.log <==
Jan  1 21:39:13 cbridge kernel: [  955.054717] usb 1-1.4.4: USB disconnect, device number 8

==> /var/log/daemon.log <==
Jan  1 21:39:14 cbridge rpiboot[434]: Failed : 0x0Waiting for BCM2835/6/7

==> /var/log/kern.log <==
Jan  1 21:39:15 cbridge kernel: [  956.432849] usb 1-1.4.4: new full-speed USB device number 9 using xhci_hcd
Jan  1 21:39:15 cbridge kernel: [  956.564862] usb 1-1.4.4: not running at top speed; connect to a high speed hub
Jan  1 21:39:15 cbridge kernel: [  956.570861] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
Jan  1 21:39:15 cbridge kernel: [  956.570876] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
Jan  1 21:39:15 cbridge kernel: [  956.570888] usb 1-1.4.4: Product: BCM2710 Boot
Jan  1 21:39:15 cbridge kernel: [  956.570900] usb 1-1.4.4: Manufacturer: Broadcom
Jan  1 21:39:15 cbridge kernel: [  956.570911] usb 1-1.4.4: SerialNumber: Broadcom

==> /var/log/daemon.log <==
Jan  1 21:39:15 cbridge rpiboot[434]: Device located successfully
Jan  1 21:39:15 cbridge rpiboot[434]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan  1 21:39:16 cbridge rpiboot[434]: Initialised device correctly
Jan  1 21:39:16 cbridge rpiboot[434]: Found serial number 1
Jan  1 21:39:16 cbridge rpiboot[434]: Second stage boot server
Jan  1 21:39:16 cbridge rpiboot[434]: Received message GetFileSize: autoboot.txt
Jan  1 21:39:16 cbridge rpiboot[434]: Cannot open file autoboot.txt
Jan  1 21:39:16 cbridge rpiboot[434]: Received message GetFileSize: config.txt
Jan  1 21:39:16 cbridge rpiboot[434]: File size = 1842 bytes
Jan  1 21:39:16 cbridge rpiboot[434]: Received message ReadFile: config.txt
Jan  1 21:39:16 cbridge rpiboot[434]: File read: config.txt
Jan  1 21:39:16 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:16 cbridge rpiboot[434]: Received message GetFileSize: recovery.elf
Jan  1 21:39:16 cbridge rpiboot[434]: Cannot open file recovery.elf
Jan  1 21:39:16 cbridge rpiboot[434]: Received message GetFileSize: start.elf
Jan  1 21:39:16 cbridge rpiboot[434]: File size = 2878340 bytes
Jan  1 21:39:16 cbridge rpiboot[434]: Received message ReadFile: start.elf
Jan  1 21:39:16 cbridge rpiboot[434]: File read: start.elf
Jan  1 21:39:20 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: fixup.dat
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 6729 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message ReadFile: fixup.dat
Jan  1 21:39:20 cbridge rpiboot[434]: File read: fixup.dat
Jan  1 21:39:20 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: recovery.elf
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file recovery.elf
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 1842 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message ReadFile: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File read: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: dt-blob.bin
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file dt-blob.bin
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: recovery.elf
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file recovery.elf
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 1842 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message ReadFile: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File read: config.txt
Jan  1 21:39:20 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: bootcfg.txt
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file bootcfg.txt
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: cmdline.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 237 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message ReadFile: cmdline.txt
Jan  1 21:39:20 cbridge rpiboot[434]: File read: cmdline.txt
Jan  1 21:39:20 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: recovery.img
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file recovery.img
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: kernel.img
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 5026968 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: armstub.bin
Jan  1 21:39:20 cbridge rpiboot[434]: Cannot open file armstub.bin
Jan  1 21:39:20 cbridge rpiboot[434]: Received message GetFileSize: kernel.img
Jan  1 21:39:20 cbridge rpiboot[434]: File size = 5026968 bytes
Jan  1 21:39:20 cbridge rpiboot[434]: Received message ReadFile: kernel.img
Jan  1 21:39:20 cbridge rpiboot[434]: File read: kernel.img
Jan  1 21:39:28 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:28 cbridge rpiboot[434]: Received message GetFileSize: initramfs.img
Jan  1 21:39:28 cbridge rpiboot[434]: File size = 4612428 bytes
Jan  1 21:39:28 cbridge rpiboot[434]: Received message ReadFile: initramfs.img
Jan  1 21:39:28 cbridge rpiboot[434]: File read: initramfs.img
Jan  1 21:39:34 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:34 cbridge rpiboot[434]: Received message GetFileSize: bcm2708-rpi-zero.dtb
Jan  1 21:39:34 cbridge rpiboot[434]: File size = 23671 bytes
Jan  1 21:39:34 cbridge rpiboot[434]: Received message ReadFile: bcm2708-rpi-zero.dtb
Jan  1 21:39:34 cbridge rpiboot[434]: File read: bcm2708-rpi-zero.dtb
Jan  1 21:39:34 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:34 cbridge rpiboot[434]: Received message GetFileSize: config.txt
Jan  1 21:39:34 cbridge rpiboot[434]: File size = 1842 bytes
Jan  1 21:39:34 cbridge rpiboot[434]: Received message ReadFile: config.txt
Jan  1 21:39:34 cbridge rpiboot[434]: File read: config.txt
Jan  1 21:39:34 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:39:34 cbridge rpiboot[434]: Received message GetFileSize: overlays/dwc2.dtbo
Jan  1 21:39:34 cbridge rpiboot[434]: File size = 801 bytes
Jan  1 21:39:34 cbridge rpiboot[434]: Received message ReadFile: overlays/dwc2.dtbo
Jan  1 21:39:34 cbridge rpiboot[434]: File read: overlays/dwc2.dtbo
Jan  1 21:39:34 cbridge rpiboot[434]: libusb_bulk_transfer returned 0

[ console output with SDCard ]

clusterctrl on p1 && tail -f /var/log/kern.log /var/log/daemon.log

==> /var/log/kern.log <==
Jan  1 21:45:22 cbridge kernel: [ 1323.467503] usb 1-1.4.4: Manufacturer: Broadcom
Jan  1 21:45:24 cbridge kernel: [ 1325.793450] usb 1-1.4.4: USB disconnect, device number 10
Jan  1 21:45:26 cbridge kernel: [ 1327.171466] usb 1-1.4.4: new full-speed USB device number 11 using xhci_hcd
Jan  1 21:45:26 cbridge kernel: [ 1327.303365] usb 1-1.4.4: not running at top speed; connect to a high speed hub
Jan  1 21:45:26 cbridge kernel: [ 1327.309365] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
Jan  1 21:45:26 cbridge kernel: [ 1327.309380] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
Jan  1 21:45:26 cbridge kernel: [ 1327.309392] usb 1-1.4.4: Product: BCM2710 Boot
Jan  1 21:45:26 cbridge kernel: [ 1327.309404] usb 1-1.4.4: Manufacturer: Broadcom
Jan  1 21:45:26 cbridge kernel: [ 1327.309416] usb 1-1.4.4: SerialNumber: Broadcom
Jan  1 21:47:20 cbridge kernel: [ 1441.265501] usb 1-1.4.4: USB disconnect, device number 11

==> /var/log/daemon.log <==
Jan  1 21:45:45 cbridge rpiboot[434]: Received message ReadFile: config.txt
Jan  1 21:45:45 cbridge rpiboot[434]: File read: config.txt
Jan  1 21:45:45 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:45:45 cbridge rpiboot[434]: Received message GetFileSize: overlays/dwc2.dtbo
Jan  1 21:45:45 cbridge rpiboot[434]: File size = 801 bytes
Jan  1 21:45:45 cbridge rpiboot[434]: Received message ReadFile: overlays/dwc2.dtbo
Jan  1 21:45:45 cbridge rpiboot[434]: File read: overlays/dwc2.dtbo
Jan  1 21:45:45 cbridge rpiboot[434]: libusb_bulk_transfer returned 0
Jan  1 21:47:20 cbridge rpiboot[434]: Second stage boot server done
Jan  1 21:47:21 cbridge rpiboot[434]: Waiting for BCM2835/6/7

==> /var/log/kern.log <==
Jan  1 21:49:51 cbridge kernel: [ 1592.440947] usb 1-1.4.4: new high-speed USB device number 12 using xhci_hcd
Jan  1 21:49:56 cbridge kernel: [ 1597.611209] usb 1-1.4.4: device descriptor read/64, error -110
Jan  1 21:50:02 cbridge kernel: [ 1603.801197] usb 1-1.4.4: device descriptor read/64, error -71
Jan  1 21:50:02 cbridge kernel: [ 1604.020899] usb 1-1.4.4: new high-speed USB device number 13 using xhci_hcd
Jan  1 21:50:03 cbridge kernel: [ 1604.152106] usb 1-1.4.4: New USB device found, idVendor=3171, idProduct=0020, bcdDevice= 1.00
Jan  1 21:50:03 cbridge kernel: [ 1604.152122] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jan  1 21:50:03 cbridge kernel: [ 1604.152135] usb 1-1.4.4: Product: ClusterCTRL
Jan  1 21:50:03 cbridge kernel: [ 1604.152146] usb 1-1.4.4: Manufacturer: 8086 Consultancy
Jan  1 21:50:03 cbridge kernel: [ 1604.152158] usb 1-1.4.4: SerialNumber: 1
Jan  1 21:50:03 cbridge kernel: [ 1604.164441] rndis_host 1-1.4.4:1.0 eth1: register 'rndis_host' at usb-0000:01:00.0-1.4.4, RNDIS device, 00:22:82:ff:fe:01
Jan  1 21:50:03 cbridge kernel: [ 1604.174891] cdc_acm 1-1.4.4:1.2: ttyACM0: USB ACM device
Jan  1 21:50:03 cbridge kernel: [ 1604.177194] cdc_acm 1-1.4.4:1.4: ttyACM1: USB ACM device

==> /var/log/daemon.log <==
Jan  1 21:50:03 cbridge systemd-udevd[1791]: Using default interface naming scheme 'v240'.

==> /var/log/kern.log <==
Jan  1 21:50:03 cbridge kernel: [ 1604.242381] rndis_host 1-1.4.4:1.0 ethpi1: renamed from eth1

==> /var/log/daemon.log <==
Jan  1 21:50:03 cbridge rpiboot[434]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan  1 21:50:03 cbridge systemd-udevd[1793]: Using default interface naming scheme 'v240'.
Jan  1 21:50:03 cbridge systemd[1]: Found device ClusterCTRL.
Jan  1 21:50:03 cbridge systemd[1]: Started ifup for ethpi1.
Jan  1 21:50:03 cbridge sh[1805]: ifup: interface br0 already configured

==> /var/log/kern.log <==
Jan  1 21:50:03 cbridge kernel: [ 1604.518083] br0: port 2(ethpi1) entered blocking state
Jan  1 21:50:03 cbridge kernel: [ 1604.518091] br0: port 2(ethpi1) entered disabled state
Jan  1 21:50:03 cbridge kernel: [ 1604.518344] device ethpi1 entered promiscuous mode
Jan  1 21:50:03 cbridge kernel: [ 1604.550280] br0: port 2(ethpi1) entered blocking state
Jan  1 21:50:03 cbridge kernel: [ 1604.550288] br0: port 2(ethpi1) entered forwarding state

==> /var/log/daemon.log <==
Jan  1 21:50:03 cbridge sh[1805]: ethpi1=ethpi1
Jan  1 21:50:05 cbridge avahi-daemon[314]: Joining mDNS multicast group on interface ethpi1.IPv6 with address fe80::222:82ff:feff:fe01.
Jan  1 21:50:05 cbridge avahi-daemon[314]: New relevant interface ethpi1.IPv6 for mDNS.
Jan  1 21:50:05 cbridge avahi-daemon[314]: Registering new address record for fe80::222:82ff:feff:fe01 on ethpi1.*.
^C

Matt

unread,

Jan 1, 2020, 9:35:48 PM1/1/20

to ClusterHAT

I'm having a similar issue, clusterhat v2 using usbboot. I'm using image ClusterCTRL-2019-09-26-lite-1-usbboot.tar.xz having untar'd and usbboot-init'd p1-4.

Linux usul 4.19.75-v7l+ #1270 SMP Tue Sep 24 18:51:41 BST 2019 armv7l GNU/Linux

pi@usul:~ $ clusterhat status

clusterhat:1

clusterctrl:False

maxpi:4

hat_version:2.3

hat_version_major:2

hat_version_minor:3

hat_size:4

hat_uuid:7a840d46-de0a-44e0-9057-f949d0d5e848

hat_vendor:8086 Consultancy

hat_product_id:0x0004

throttled:0x0

hat_alert:0

hat_hub:1

hat_wp:1

hat_led:1

hat_wplink:0

hat_xra1200p:True

p1:1

p2:1

p3:0

p4:0

Removing the USB cord between the hat and the RPi 4, as you suggested, does allow booting to continue past that point and I get a usable p1 (populates the device tree with 2 devs for p1). If I try to boot p2, it seems to halt at a similar spot, and un-plugging / re-plugging the board allows p2 to continue, and it eventually boots and the /dev/serial/by-id/ tree populates correctly.

I've tested each Zero individually with a default Rasbian image, boot and run the OS with no issues, and swapping the Zeros between the different ports doesn't seem to have any effect. Is there a boot issue with the USB Gadget file transfer?

Weirdly, before I swapped the Zeros around, the P1 used to boot with no issues, but after I changed them it seems to have the issue described above.

Peter Cross

unread,

Jan 1, 2020, 10:15:29 PM1/1/20

to clust...@googlegroups.com

Not to confuse the issue... just a random thought...

Where did both of you purchase the zero’s? I read an article the other day about counterfeit raspberry pi’s being found by consumers. It was about 3B’s and 3B+’s but it’s making me wonder about y’all’s issue as well.

Cheers!

Peter J. Cross

San Antonio, TX

Saepius Exertus, Semper Fidelis

On Jan 1, 2020, at 20:35, Matt <ma...@hom3.us> wrote:

--
You received this message because you are subscribed to the Google Groups "ClusterHAT" group.
To unsubscribe from this group and stop receiving emails from it, send an email to clusterhat+...@googlegroups.com.
To view this discussion on the web, visit https://groups.google.com/d/msgid/clusterhat/af347e80-ad4e-40ac-9efd-134844c7970a%40googlegroups.com.

Matt Reynolds

unread,

Jan 1, 2020, 10:26:06 PM1/1/20

to clust...@googlegroups.com

Mine came as part of the kit I bought from PiShop ( https://www.pishop.us/product/cluster-hat-kit-includes-4-x-raspberry-pi-zero-w/ ) on an RPi 4 I got from Amazon (from the "raspberry" seller, which seems mostly legit, but it's hard to verify) . It's worth stating that I can pull each Zero out individually and get them to boot successfully, and using the un-plug/re-plug trick, I can get the boot to progress for at least 2 zeros (will test more later), I'm less suspicious of the modules themselves and more to the boot process.

To view this discussion on the web, visit https://groups.google.com/d/msgid/clusterhat/1881B98F-82EA-48CD-88F8-0821865A414F%40gmail.com.

monateng

unread,

Jan 2, 2020, 6:57:17 AM1/2/20

to ClusterHAT

Hi Peter,

I bought the ClusterHat by PIMORONI GMBH

> https://shop.pimoroni.de/products/cluster-hat

And the Pi Zeros 1.3 and Raspberry Pi 4B+ by reichelt elektronik GmbH & Co. KG.

> RASP PI 4 B 4GB
> https://www.reichelt.de/raspberry-pi-4-b-4x-1-5-ghz-4-gb-ram-wlan-bt-rasp-pi-4-b-4gb-p259920.html > RASP PI ZERO > https://www.reichelt.de/raspberry-pi-zero-w-v-1-1-1-ghz-512-mb-ram-wlan-bt-rasp-pi-zero-w-p256438.html

Both german sellers who each have a name to lose and hopefully check their delivery channels.

Please provide me a link so I can ask these companies about your suspicion.

Kind Regards

Peter J. Cross

unread,

Jan 2, 2020, 8:58:07 AM1/2/20

to clust...@googlegroups.com

Here’s the article I read:

https://raspberryinsider.com/can-you-detect-a-knock-off-raspberry-pi/

Sent from my iPhone, please excuse any typos.

On Jan 2, 2020, at 05:57, 'monateng' via ClusterHAT <clust...@googlegroups.com> wrote:

--

You received this message because you are subscribed to the Google Groups "ClusterHAT" group.
To unsubscribe from this group and stop receiving emails from it, send an email to clusterhat+...@googlegroups.com.

To view this discussion on the web, visit https://groups.google.com/d/msgid/clusterhat/09e1d3bc-2c53-4065-a2fd-248c5e6a208b%40googlegroups.com.

monateng

unread,

Jan 2, 2020, 2:03:50 PM1/2/20

to ClusterHAT

Hey Peter,

I check all my RPIs and I found no fake version.

But I can't find any instruction to install pinout as a extra software. Could you please inform me where to find and how to install.

@Chris;

I will provide a script to detect if the RPI is a orignal.

But I do not know anything why the ClusterHat doesn't work as you mentioned.

pi@p1:~ $ cat /proc/cpuinfo

processor       : 0
model name      : ARMv6-compatible processor rev 7 (v6l)
BogoMIPS        : 997.08
Features        : half thumb fastmult vfp edsp java tls
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x0
CPU part        : 0xb76
CPU revision    : 7

Hardware        : BCM2835
Revision        : 900093
Serial          : 000000009c{CODE}
Model           : Raspberry Pi Zero Rev 1.3

pi@p1:~ $ gpio -v

gpio version: 2.50
Copyright (c) 2012-2018 Gordon Henderson
This is free software with ABSOLUTELY NO WARRANTY.
For details type: gpio -warranty

Raspberry Pi Details:
  Type: Pi Zero, Revision: 03, Memory: 512MB, Maker: Sony
  * Device tree is enabled.
  *--> Raspberry Pi Zero Rev 1.3
  * This Raspberry Pi supports user-level GPIO access.

- - - - -

pi@cbridge:~ $ cat /proc/cpuinfo

processor       : 0
model name      : ARMv7 Processor rev 3 (v7l)
BogoMIPS        : 108.00
Features        : half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt vfpd32 lpae evtstrm crc32
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x0
CPU part        : 0xd08
CPU revision    : 3

processor       : 1
model name      : ARMv7 Processor rev 3 (v7l)
BogoMIPS        : 108.00
Features        : half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt vfpd32 lpae evtstrm crc32
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x0
CPU part        : 0xd08
CPU revision    : 3

processor       : 2
model name      : ARMv7 Processor rev 3 (v7l)
BogoMIPS        : 108.00
Features        : half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt vfpd32 lpae evtstrm crc32
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x0
CPU part        : 0xd08
CPU revision    : 3

processor       : 3
model name      : ARMv7 Processor rev 3 (v7l)
BogoMIPS        : 108.00
Features        : half thumb fastmult vfp edsp neon vfpv3 tls vfpv4 idiva idivt vfpd32 lpae evtstrm crc32
CPU implementer : 0x41
CPU architecture: 7
CPU variant     : 0x0
CPU part        : 0xd08
CPU revision    : 3

Hardware        : BCM2835
Revision        : c03111
Serial          : 100000008f54bb45
Model           : Raspberry Pi 4 Model B Rev 1.1

pi@cbridge:~ $ gpio -v

gpio version: 2.50
Copyright (c) 2012-2018 Gordon Henderson
This is free software with ABSOLUTELY NO WARRANTY.
For details type: gpio -warranty

Raspberry Pi Details:
  Type: Unknown17, Revision: 01, Memory: 0MB, Maker: Sony
  * Device tree is enabled.
  *--> Raspberry Pi 4 Model B Rev 1.1
  * This Raspberry Pi supports user-level GPIO access.

monateng

unread,

Jan 2, 2020, 7:05:46 PM1/2/20

to ClusterHAT

Hey Chris,

do you have also these errors during boot your images on RPI 4B+?

pi@cbridge:~ $ sudo journalctl -p 3 -xb -b

-- Logs begin at Thu 2020-01-02 21:42:47 GMT, end at Thu 2020-01-02 23:59:11 GMT. --
Jan 02 21:42:47 cbridge blkmapd[131]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory
Jan 02 21:42:48 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 02 21:42:48 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 02 21:42:48 cbridge kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Feb 27 2018 03:15:32 version 7.45.154 (r684107 CY) FWID 01-4fbe0b04
Jan 02 21:42:57 cbridge bluetoothd[635]: Sap driver initialization failed.
Jan 02 21:42:57 cbridge bluetoothd[635]: sap-server: Operation not permitted (1)
Jan 02 21:42:57 cbridge bluetoothd[635]: Failed to set privacy: Rejected (0x0b)
Jan 02 23:51:07 cbridge blkmapd[131]: exit on signal(15)
Jan 02 23:51:07 cbridge blkmapd[851]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory

And after the run of raspi-config the requested service is not installed:

pi@cbridge:~ $ sudo apt-get install pigpio

But also after solf these errors I can not boot without the SDCards.

I do not why and how to solve it by my own.

Regards

Chris Burton

unread,

Jan 3, 2020, 3:57:00 PM1/3/20

to ClusterHAT

On Friday, 3 January 2020 00:05:46 UTC, monateng wrote:

Hey Chris,
do you have also these errors during boot your images on RPI 4B+?

Yes.

And after the run of raspi-config the requested service is not installed:pi@cbridge:~ $ sudo apt-get install pigpio

You'd need to talk to the authors of raspi-config if it doesn't do what you'd expect, similar for pigpio which I don't use.

But also after solf these errors I can not boot without the SDCards.
I do not why and how to solve it by my own.

From my point of view answering the questions I asked earlier would be a good start.

Chris.

monateng

unread,

Jan 12, 2020, 8:43:09 AM1/12/20

to ClusterHAT

Am Freitag, 3. Januar 2020 21:57:00 UTC+1 schrieb Chris Burton:

{....}

But also after solf these errors I can not boot without the SDCards.
I do not why and how to solve it by my own.

From my point of view answering the questions I asked earlier would be a good start.

Chris.

Hi Chris,
start a new experiment today. I'm sorry I didn't answer all your questions last time.

Yes I get a Product: BCM2710 Boot on cbridge

Jan 12 12:58:25 cbridge kernel: [ 4282.892230] usb 1-1.4.4: Product: BCM2710 Boot

With an SD card I can boot all RPi Zeros WH without any problems. But not by using your Instructions here
> https://8086.support/content/23/97/en/how-do-i-boot-pi-zeros-without-sd-cards-cluster-hat_cluster-ctrl.html

I start a fresh install today.

I bought new SD cards SDCard 64GB SanDisk Ultra SDSQUAR-032G-GN6MA

Create the ClusterCTRL-2019-09-26-lite-1-CBRIDGE.img for booting the RPi 4B+.

I use the ClusterCTRL-2019-09-26-lite-1-p1.img for the RPi Zero WH p1.

I use the ClusterCTRL-2019-09-26-lite-1-p2.img for the RPi Zero WH p2.

And so on...

[ RPi 4B+ ]

To use ssh I create on all SD cards a new textfile with "ssh" in the boot folder and boot the RPi 4B+ up and login.

> # update and upgrade

> sudo apt update && sudo apt dist-upgrade

> # reboot

> sudo shutdown -r now

> { ... }
> { relogin }

> clusterctrl init

> clusterctrl on p1 && tail -F /var/log/daemon.log /var/log/kern.log

[ RPi zero WH ]

> # reboot
> sudo shutdown -h now

[ RPi 4B+ ]

> # remove all old files

> sudo rm -rf /var/lib/clusterctrl/nfs/p{1,2,3,4}/{*,.*}

> # download image from server

> wget -c -P ~pi/ https://dist1.8086.net/clusterctrl/usbboot/buster/2019-09-26/ClusterCTRL-2019-09-26-lite-1-usbboot.tar.xz

> # extract image

> sudo tar -axf ~pi/ClusterCTRL-*-usbboot.tar.xz -C /var/lib/clusterctrl/nfs/p1/

> # activate usbboot

> sudo usbboot-init 1

> # create ssh file to activate SSH-Server on p1 after boot

> sudo touch /var/lib/clusterctrl/nfs/p1/boot/ssh

> # first boot of p1 and hopefully use usbboot

> clusterctrl on p1 && tail -F /var/log/daemon.log /var/log/kern.log

==> /var/log/daemon.log <==
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS 140-2(2001-10-10) Monobit: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS 140-2(2001-10-10) Poker: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS 140-2(2001-10-10) Runs: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS 140-2(2001-10-10) Long run: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS 140-2(2001-10-10) Continuous run: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: HRNG source speed: (min=539.358; avg=541.587; max=543.577)Kibits/s
Jan 12 12:47:38 cbridge rngd[780]: stats: FIPS tests speed: (min=12.540; avg=14.789; max=31.268)Mibits/s
Jan 12 12:47:38 cbridge rngd[780]: stats: Lowest ready-buffers level: 2
Jan 12 12:47:38 cbridge rngd[780]: stats: Entropy starvations: 0
Jan 12 12:47:38 cbridge rngd[780]: stats: Time spent starving for entropy: (min=0; avg=0.000; max=0)us

==> /var/log/kern.log <==
Jan 12 12:40:24 cbridge kernel: [ 3201.038564] br0: port 2(ethpi1) entered blocking state
Jan 12 12:40:24 cbridge kernel: [ 3201.038572] br0: port 2(ethpi1) entered disabled state
Jan 12 12:40:24 cbridge kernel: [ 3201.038826] device ethpi1 entered promiscuous mode
Jan 12 12:40:24 cbridge kernel: [ 3201.071485] br0: port 2(ethpi1) entered blocking state
Jan 12 12:40:24 cbridge kernel: [ 3201.071493] br0: port 2(ethpi1) entered forwarding state
Jan 12 12:45:40 cbridge kernel: [ 3517.134194] usb 1-1.4.4: USB disconnect, device number 10
Jan 12 12:45:40 cbridge kernel: [ 3517.134616] rndis_host 1-1.4.4:1.0 ethpi1: unregister 'rndis_host' usb-0000:01:00.0-1.4.4, RNDIS device
Jan 12 12:45:40 cbridge kernel: [ 3517.158937] br0: port 2(ethpi1) entered disabled state
Jan 12 12:45:40 cbridge kernel: [ 3517.159962] device ethpi1 left promiscuous mode
Jan 12 12:45:40 cbridge kernel: [ 3517.159979] br0: port 2(ethpi1) entered disabled state
Jan 12 12:58:22 cbridge kernel: [ 4279.071887] usb 1-1.4.4: new full-speed USB device number 11 using xhci_hcd
Jan 12 12:58:22 cbridge kernel: [ 4279.207902] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
Jan 12 12:58:22 cbridge kernel: [ 4279.207917] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jan 12 12:58:22 cbridge kernel: [ 4279.207930] usb 1-1.4.4: Product: BCM2708 Boot
Jan 12 12:58:22 cbridge kernel: [ 4279.207942] usb 1-1.4.4: Manufacturer: Broadcom

==> /var/log/daemon.log <==
Jan 12 12:58:22 cbridge rpiboot[427]: Device located successfully
Jan 12 12:58:22 cbridge rpiboot[427]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 12 12:58:23 cbridge rpiboot[427]: Initialised device correctly
Jan 12 12:58:23 cbridge rpiboot[427]: Found serial number 0
Jan 12 12:58:23 cbridge rpiboot[427]: Sending bootcode.bin
Jan 12 12:58:23 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:23 cbridge rpiboot[427]: Writing 52296 bytes
Jan 12 12:58:23 cbridge rpiboot[427]: libusb_bulk_transfer returned 0

==> /var/log/kern.log <==
Jan 12 12:58:24 cbridge kernel: [ 4281.533780] usb 1-1.4.4: USB disconnect, device number 11

==> /var/log/daemon.log <==
Jan 12 12:58:25 cbridge rpiboot[427]: Failed : 0x0Waiting for BCM2835/6/7

==> /var/log/kern.log <==
Jan 12 12:58:25 cbridge kernel: [ 4282.751900] usb 1-1.4.4: new full-speed USB device number 12 using xhci_hcd
Jan 12 12:58:25 cbridge kernel: [ 4282.883918] usb 1-1.4.4: not running at top speed; connect to a high speed hub
Jan 12 12:58:25 cbridge kernel: [ 4282.892201] usb 1-1.4.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
Jan 12 12:58:25 cbridge kernel: [ 4282.892217] usb 1-1.4.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
Jan 12 12:58:25 cbridge kernel: [ 4282.892230] usb 1-1.4.4: Product: BCM2710 Boot
Jan 12 12:58:25 cbridge kernel: [ 4282.892242] usb 1-1.4.4: Manufacturer: Broadcom
Jan 12 12:58:25 cbridge kernel: [ 4282.892253] usb 1-1.4.4: SerialNumber: Broadcom

==> /var/log/daemon.log <==
Jan 12 12:58:25 cbridge rpiboot[427]: Device located successfully
Jan 12 12:58:26 cbridge rpiboot[427]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 12 12:58:26 cbridge rpiboot[427]: Initialised device correctly
Jan 12 12:58:26 cbridge rpiboot[427]: Found serial number 1
Jan 12 12:58:26 cbridge rpiboot[427]: Second stage boot server
Jan 12 12:58:26 cbridge rpiboot[427]: Received message GetFileSize: autoboot.txt
Jan 12 12:58:26 cbridge rpiboot[427]: Cannot open file autoboot.txt
Jan 12 12:58:26 cbridge rpiboot[427]: Received message GetFileSize: config.txt
Jan 12 12:58:26 cbridge rpiboot[427]: File size = 2036 bytes
Jan 12 12:58:26 cbridge rpiboot[427]: Received message ReadFile: config.txt
Jan 12 12:58:26 cbridge rpiboot[427]: File read: config.txt
Jan 12 12:58:26 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:26 cbridge rpiboot[427]: Received message GetFileSize: recovery.elf
Jan 12 12:58:26 cbridge rpiboot[427]: Cannot open file recovery.elf
Jan 12 12:58:27 cbridge rpiboot[427]: Received message GetFileSize: start.elf
Jan 12 12:58:27 cbridge rpiboot[427]: File size = 2877988 bytes
Jan 12 12:58:27 cbridge rpiboot[427]: Received message ReadFile: start.elf
Jan 12 12:58:27 cbridge rpiboot[427]: File read: start.elf
Jan 12 12:58:31 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: fixup.dat
Jan 12 12:58:31 cbridge rpiboot[427]: File size = 6736 bytes
Jan 12 12:58:31 cbridge rpiboot[427]: Received message ReadFile: fixup.dat
Jan 12 12:58:31 cbridge rpiboot[427]: File read: fixup.dat
Jan 12 12:58:31 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: recovery.elf
Jan 12 12:58:31 cbridge rpiboot[427]: Cannot open file recovery.elf
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File size = 2036 bytes
Jan 12 12:58:31 cbridge rpiboot[427]: Received message ReadFile: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File read: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: dt-blob.bin
Jan 12 12:58:31 cbridge rpiboot[427]: Cannot open file dt-blob.bin
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: recovery.elf
Jan 12 12:58:31 cbridge rpiboot[427]: Cannot open file recovery.elf
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File size = 2036 bytes
Jan 12 12:58:31 cbridge rpiboot[427]: Received message ReadFile: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File read: config.txt
Jan 12 12:58:31 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: bootcfg.txt
Jan 12 12:58:31 cbridge rpiboot[427]: Cannot open file bootcfg.txt
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: cmdline.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File size = 216 bytes
Jan 12 12:58:31 cbridge rpiboot[427]: Received message ReadFile: cmdline.txt
Jan 12 12:58:31 cbridge rpiboot[427]: File read: cmdline.txt
Jan 12 12:58:31 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:31 cbridge rpiboot[427]: Received message GetFileSize: initramfs.img
Jan 12 12:58:31 cbridge rpiboot[427]: File size = 5628912 bytes
Jan 12 12:58:31 cbridge rpiboot[427]: Received message ReadFile: initramfs.img
Jan 12 12:58:31 cbridge rpiboot[427]: File read: initramfs.img
Jan 12 12:58:39 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:39 cbridge rpiboot[427]: Received message GetFileSize: bcm2708-rpi-zero.dtb
Jan 12 12:58:39 cbridge rpiboot[427]: File size = 23671 bytes
Jan 12 12:58:39 cbridge rpiboot[427]: Received message ReadFile: bcm2708-rpi-zero.dtb
Jan 12 12:58:39 cbridge rpiboot[427]: File read: bcm2708-rpi-zero.dtb
Jan 12 12:58:39 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:39 cbridge rpiboot[427]: Received message GetFileSize: config.txt
Jan 12 12:58:39 cbridge rpiboot[427]: File size = 2036 bytes
Jan 12 12:58:39 cbridge rpiboot[427]: Received message ReadFile: config.txt
Jan 12 12:58:39 cbridge rpiboot[427]: File read: config.txt
Jan 12 12:58:39 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
Jan 12 12:58:39 cbridge rpiboot[427]: Received message GetFileSize: overlays/dwc2.dtbo
Jan 12 12:58:39 cbridge rpiboot[427]: File size = 801 bytes
Jan 12 12:58:39 cbridge rpiboot[427]: Received message ReadFile: overlays/dwc2.dtbo
Jan 12 12:58:39 cbridge rpiboot[427]: File read: overlays/dwc2.dtbo
Jan 12 12:58:39 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
^C

The system run for 1 hour and so far the p1 does not come online via usbboot.

I can't recognize my mistake.

Hey Chris, do you have any questions?

monateng

unread,

Jan 12, 2020, 5:39:05 PM1/12/20

to ClusterHAT

Hi Chris,
I check all logs but I can't find solutions for:
> Jan 12 21:58:45 cbridge rpiboot[399]: Failed : 0x0Waiting for BCM2835/6/7

With an updated initramfs, the same error comes up again.

Boot is not possible with usbboot and your images.

> sudo journalctl -b -u *rpiboot*

-- Logs begin at Sun 2020-01-12 21:54:44 GMT, end at Sun 2020-01-12 22:19:52 GMT. --
Jan 12 21:54:50 cbridge systemd[1]: Started ClusterCTRL rpiboot for SD cardless booting.
Jan 12 21:54:50 cbridge rpiboot[399]: Waiting for BCM2835/6/7
Jan 12 21:54:51 cbridge rpiboot[399]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 12 21:58:42 cbridge rpiboot[399]: Device located successfully
Jan 12 21:58:42 cbridge rpiboot[399]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 12 21:58:43 cbridge rpiboot[399]: Initialised device correctly
Jan 12 21:58:43 cbridge rpiboot[399]: Found serial number 0
Jan 12 21:58:43 cbridge rpiboot[399]: Sending bootcode.bin
Jan 12 21:58:43 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:43 cbridge rpiboot[399]: Writing 52296 bytes
Jan 12 21:58:43 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:45 cbridge rpiboot[399]: Failed : 0x0Waiting for BCM2835/6/7
Jan 12 21:58:46 cbridge rpiboot[399]: Device located successfully
Jan 12 21:58:46 cbridge rpiboot[399]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 12 21:58:47 cbridge rpiboot[399]: Initialised device correctly
Jan 12 21:58:47 cbridge rpiboot[399]: Found serial number 1
Jan 12 21:58:47 cbridge rpiboot[399]: Second stage boot server
Jan 12 21:58:47 cbridge rpiboot[399]: Received message GetFileSize: autoboot.txt
Jan 12 21:58:47 cbridge rpiboot[399]: Cannot open file autoboot.txt
Jan 12 21:58:47 cbridge rpiboot[399]: Received message GetFileSize: config.txt
Jan 12 21:58:47 cbridge rpiboot[399]: File size = 2082 bytes
Jan 12 21:58:47 cbridge rpiboot[399]: Received message ReadFile: config.txt
Jan 12 21:58:47 cbridge rpiboot[399]: File read: config.txt
Jan 12 21:58:47 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:47 cbridge rpiboot[399]: Received message GetFileSize: recovery.elf
Jan 12 21:58:47 cbridge rpiboot[399]: Cannot open file recovery.elf
Jan 12 21:58:47 cbridge rpiboot[399]: Received message GetFileSize: start.elf
Jan 12 21:58:47 cbridge rpiboot[399]: File size = 2877988 bytes
Jan 12 21:58:47 cbridge rpiboot[399]: Received message ReadFile: start.elf
Jan 12 21:58:47 cbridge rpiboot[399]: File read: start.elf
Jan 12 21:58:51 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: fixup.dat
Jan 12 21:58:51 cbridge rpiboot[399]: File size = 6736 bytes
Jan 12 21:58:51 cbridge rpiboot[399]: Received message ReadFile: fixup.dat
Jan 12 21:58:51 cbridge rpiboot[399]: File read: fixup.dat
Jan 12 21:58:51 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: recovery.elf
Jan 12 21:58:51 cbridge rpiboot[399]: Cannot open file recovery.elf
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File size = 2082 bytes
Jan 12 21:58:51 cbridge rpiboot[399]: Received message ReadFile: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File read: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: dt-blob.bin
Jan 12 21:58:51 cbridge rpiboot[399]: Cannot open file dt-blob.bin
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: recovery.elf
Jan 12 21:58:51 cbridge rpiboot[399]: Cannot open file recovery.elf
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File size = 2082 bytes
Jan 12 21:58:51 cbridge rpiboot[399]: Received message ReadFile: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File read: config.txt
Jan 12 21:58:51 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: bootcfg.txt
Jan 12 21:58:51 cbridge rpiboot[399]: Cannot open file bootcfg.txt
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: cmdline.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File size = 216 bytes
Jan 12 21:58:51 cbridge rpiboot[399]: Received message ReadFile: cmdline.txt
Jan 12 21:58:51 cbridge rpiboot[399]: File read: cmdline.txt
Jan 12 21:58:51 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:51 cbridge rpiboot[399]: Received message GetFileSize: initramfs.img
Jan 12 21:58:51 cbridge rpiboot[399]: File size = 5591860 bytes
Jan 12 21:58:51 cbridge rpiboot[399]: Received message ReadFile: initramfs.img
Jan 12 21:58:51 cbridge rpiboot[399]: File read: initramfs.img
Jan 12 21:58:59 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:58:59 cbridge rpiboot[399]: Received message GetFileSize: bcm2708-rpi-zero.dtb
Jan 12 21:58:59 cbridge rpiboot[399]: File size = 23671 bytes
Jan 12 21:58:59 cbridge rpiboot[399]: Received message ReadFile: bcm2708-rpi-zero.dtb
Jan 12 21:58:59 cbridge rpiboot[399]: File read: bcm2708-rpi-zero.dtb
Jan 12 21:59:00 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:59:00 cbridge rpiboot[399]: Received message GetFileSize: config.txt
Jan 12 21:59:00 cbridge rpiboot[399]: File size = 2082 bytes
Jan 12 21:59:00 cbridge rpiboot[399]: Received message ReadFile: config.txt
Jan 12 21:59:00 cbridge rpiboot[399]: File read: config.txt
Jan 12 21:59:00 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 21:59:00 cbridge rpiboot[399]: Received message GetFileSize: overlays/dwc2.dtbo
Jan 12 21:59:00 cbridge rpiboot[399]: File size = 801 bytes
Jan 12 21:59:00 cbridge rpiboot[399]: Received message ReadFile: overlays/dwc2.dtbo
Jan 12 21:59:00 cbridge rpiboot[399]: File read: overlays/dwc2.dtbo
Jan 12 21:59:00 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 22:18:22 cbridge rpiboot[399]: Second stage boot server done
Jan 12 22:18:23 cbridge rpiboot[399]: Waiting for BCM2835/6/7
lines 34-82/82 (END)

To solve some errors I deactivate bluetooth by adding to /boot/config.txt for my RPi 4B+ (cbridge):

# Disable Bluetooth
dtoverlay=disable-bt

> pi@cbridge:~ $ sudo journalctl -p err -b

-- Logs begin at Sun 2020-01-12 21:54:44 GMT, end at Sun 2020-01-12 22:33:22 GMT. --
Jan 12 21:54:44 cbridge blkmapd[134]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory
Jan 12 21:54:45 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 12 21:54:46 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 12 21:54:46 cbridge kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Feb 27 2018 03:15:32 version 7.45.154 (r684107 CY) FWID 01-4fbe0b04

Hope that anyone could find a solution together with me.

Message has been deleted

Chris Burton

unread,

Jan 13, 2020, 12:31:24 PM1/13/20

to ClusterHAT

Hi,

I check all logs but I can't find solutions for:
> Jan 12 21:58:45 cbridge rpiboot[399]: Failed : 0x0Waiting for BCM2835/6/7

With an updated initramfs, the same error comes up again.
Boot is not possible with usbboot and your images

...

Jan 12 12:58:39 cbridge rpiboot[427]: Received message ReadFile: overlays/dwc2.dtbo
Jan 12 12:58:39 cbridge rpiboot[427]: File read: overlays/dwc2.dtbo
Jan 12 12:58:39 cbridge rpiboot[427]: libusb_bulk_transfer returned 0
^C

Can you try with this alternate rpiboot (has a longer timeout).

sudo mv /usr/bin/rpiboot /usr/bin/rpiboot.orig
sudo wget -O /usr/bin/rpiboot https://dist.8086.net/clusterctrl/testing/tmp/rpiboot
sudo chown root:root /usr/bin/rpiboot
sudo chmod 755 /usr/bin/rpiboot
sudo reboot

And to revert back to the original

sudo mv -f /usr/bin/rpiboot.orig /usr/bin/rpiboot

With an updated initramfs, the same error comes up again

How did you update it?

Jan 12 21:59:00 cbridge rpiboot[399]: File read: overlays/dwc2.dtbo
Jan 12 21:59:00 cbridge rpiboot[399]: libusb_bulk_transfer returned 0
Jan 12 22:18:22 cbridge rpiboot[399]: Second stage boot server done

Jan 12 22:18:23 cbridge rpiboot[399]: Waiting for BCM2835/6/7.

Do you have anything you could hook up to the Pi Zero to see the serial console as if it gets here then it would normally indicate it has booted and if you don't see the USB devices then there's a problem with the initramfs or cmdline options.

If this doesn't help send me your name/address details and the ClusterHAT serial number to Sup...@8086.net.uk and I'll sort out a replacement.

Chris.

monateng

unread,

Jan 13, 2020, 5:23:33 PM1/13/20

to ClusterHAT

Hi Chris,

Am Montag, 13. Januar 2020 18:31:24 UTC+1 schrieb Chris Burton:

[ ... ]

Can you try with this alternate rpiboot (has a longer timeout).

sudo mv /usr/bin/rpiboot /usr/bin/rpiboot.orig sudo wget -O /usr/bin/rpiboot https://dist.8086.net/clusterctrl/testing/tmp/rpiboot sudo chown root:root /usr/bin/rpiboot sudo chmod 755 /usr/bin/rpiboot sudo reboot

# 01

First I check if your version of rpiboot is a solution for my problem....

pi@cbridge:~ $ sudo reboot
Using username "pi".
pi@192.168.188.23's password:
Send automatic password
Linux cbridge 4.19.93-v7l+ #1290 SMP Fri Jan 10 16:45:11 GMT 2020 armv7l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.
Last login: Mon Jan 13 00:46:20 2020 from 192.168.188.22
pi@cbridge:~ $ uname -a
Linux cbridge 4.19.93-v7l+ #1290 SMP Fri Jan 10 16:45:11 GMT 2020 armv7l GNU/Linux


pi@cbridge:~ $ 

pi@cbridge:~ $ 

pi@cbridge:~ $

pi@cbridge:~ $ sudo journalctl -p err -b -f
-- Logs begin at Mon 2020-01-13 21:41:02 GMT. --
Jan 13 21:41:02 cbridge blkmapd[137]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory
Jan 13 21:41:03 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 13 21:41:04 cbridge kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6
Jan 13 21:41:04 cbridge kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Feb 27 2018 03:15:32 version 7.45.154 (r684107 CY) FWID 01-4fbe0b04






pi@cbridge:~ $ file /usr/bin/rpiboot*
/usr/bin/rpiboot:      ELF 32-bit LSB executable, ARM, EABI5 version 1 (SYSV), dynamically linked, interpreter /lib/ld-linux-armhf.so.3, for GNU/Linux 3.2.0, BuildID[sha1]=e1344e8901df383ea1790ce53dbadccf83c8de0b, with debug_info, not stripped
/usr/bin/rpiboot.orig: ELF 32-bit LSB executable, ARM, EABI5 version 1 (SYSV), dynamically linked, interpreter /lib/ld-linux-armhf.so.3, for GNU/Linux 3.2.0, BuildID[sha1]=afe65a3519f95f5424bbc08625d1f8bbed196ead, stripped


pi@cbridge:~ $
pi@cbridge:~ $
pi@cbridge:~ $

pi@cbridge:~ $ ldd /usr/bin/rpiboot*
/usr/bin/rpiboot:
        linux-vdso.so.1 (0xbedc0000)
        /usr/lib/arm-linux-gnueabihf/libarmmem-${PLATFORM}.so => /usr/lib/arm-linux-gnueabihf/libarmmem-v7l.so (0xb6f84000)
        libusb-1.0.so.0 => /lib/arm-linux-gnueabihf/libusb-1.0.so.0 (0xb6f5f000)
        libc.so.6 => /lib/arm-linux-gnueabihf/libc.so.6 (0xb6e11000)
        libudev.so.1 => /lib/arm-linux-gnueabihf/libudev.so.1 (0xb6de1000)
        libpthread.so.0 => /lib/arm-linux-gnueabihf/libpthread.so.0 (0xb6db7000)
        /lib/ld-linux-armhf.so.3 (0xb6f99000)
        librt.so.1 => /lib/arm-linux-gnueabihf/librt.so.1 (0xb6da0000)
/usr/bin/rpiboot.orig:
        linux-vdso.so.1 (0xbeeb6000)
        /usr/lib/arm-linux-gnueabihf/libarmmem-${PLATFORM}.so => /usr/lib/arm-linux-gnueabihf/libarmmem-v7l.so (0xb6edc000)
        libusb-1.0.so.0 => /lib/arm-linux-gnueabihf/libusb-1.0.so.0 (0xb6eb7000)
        libc.so.6 => /lib/arm-linux-gnueabihf/libc.so.6 (0xb6d69000)
        libudev.so.1 => /lib/arm-linux-gnueabihf/libudev.so.1 (0xb6d39000)
        libpthread.so.0 => /lib/arm-linux-gnueabihf/libpthread.so.0 (0xb6d0f000)
        /lib/ld-linux-armhf.so.3 (0xb6ef1000)
        librt.so.1 => /lib/arm-linux-gnueabihf/librt.so.1 (0xb6cf8000)


pi@cbridge:~ $
pi@cbridge:~ $
pi@cbridge:~ $

pi@cbridge:~ $ sudo rm -rf /var/lib/clusterctrl/nfs/p{1,2,3,4}/{*,.*}
rm: refusing to remove '

.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p1/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p2/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p3/..'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/.'
rm: refusing to remove '.' or '..' directory: skipping '/var/lib/clusterctrl/nfs/p4/..'
pi@cbridge:~ $ sudo tar -axf ~pi/ClusterCTRL-*-usbboot.tar.xz -C /var/lib/clusterctrl/nfs/p1/


pi@cbridge:~ $ sudo usbboot-init 1
pi@cbridge:~ $ sudo touch /var/lib/clusterctrl/nfs/p1/boot/ssh

pi@cbridge:~ $ clusterctrl on p1 && tail -F /var/log/daemon.log /var/log/kern.log
==> /var/log/daemon.log <==
Jan 13 21:42:27 cbridge systemd[732]: Reached target Timers.
Jan 13 21:42:27 cbridge systemd[732]: Reached target Paths.
Jan 13 21:42:27 cbridge systemd[732]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jan 13 21:42:27 cbridge systemd[732]: Listening on GnuPG network certificate management daemon.
Jan 13 21:42:27 cbridge systemd[732]: Reached target Sockets.
Jan 13 21:42:27 cbridge systemd[732]: Reached target Basic System.
Jan 13 21:42:27 cbridge systemd[732]: Reached target Default.
Jan 13 21:42:27 cbridge systemd[732]: Startup finished in 175ms.
Jan 13 21:42:27 cbridge systemd[1]: Started User Manager for UID 1000.
Jan 13 21:42:27 cbridge systemd[1]: Started Session c1 of user pi.

==> /var/log/kern.log <==
Jan 13 21:41:10 cbridge kernel: [   11.954403] IPv6: ADDRCONF(NETDEV_UP): br0: link is not ready
Jan 13 21:41:11 cbridge kernel: [   12.951863] bcmgenet fd580000.genet eth0: Link is Down
Jan 13 21:41:16 cbridge kernel: [   18.151889] bcmgenet fd580000.genet eth0: Link is Up - 1Gbps/Full - flow control off
Jan 13 21:41:16 cbridge kernel: [   18.151947] br0: port 1(eth0) entered blocking state
Jan 13 21:41:16 cbridge kernel: [   18.151960] br0: port 1(eth0) entered forwarding state
Jan 13 21:41:16 cbridge kernel: [   18.152127] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
Jan 13 21:42:11 cbridge kernel: [   73.031716] random: crng init done
Jan 13 21:42:11 cbridge kernel: [   73.031726] random: 7 urandom warning(s) missed due to ratelimiting
Jan 13 21:42:11 cbridge kernel: [   73.218876] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 13 21:42:17 cbridge kernel: [   78.989618] NFSD: starting 90-second grace period (net f0000041)
Jan 13 21:46:19 cbridge kernel: [  308.072357] usb 1-1.1.4: new full-speed USB device number 5 using xhci_hcd
Jan 13 21:46:19 cbridge kernel: [  308.208271] usb 1-1.1.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
Jan 13 21:46:19 cbridge kernel: [  308.208286] usb 1-1.1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jan 13 21:46:19 cbridge kernel: [  308.208299] usb 1-1.1.4: Product: BCM2708 Boot
Jan 13 21:46:19 cbridge kernel: [  308.208311] usb 1-1.1.4: Manufacturer: Broadcom

==> /var/log/daemon.log <==
Jan 13 21:46:20 cbridge rpiboot[410]: Device located successfully
Jan 13 21:46:20 cbridge rpiboot[410]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 13 21:46:21 cbridge rpiboot[410]: Initialised device correctly
Jan 13 21:46:21 cbridge rpiboot[410]: Found serial number 0
Jan 13 21:46:21 cbridge rpiboot[410]: Sending bootcode.bin
Jan 13 21:46:21 cbridge rpiboot[410]: libusb_bulk_transfer sent 24 bytes; returned 0
Jan 13 21:46:21 cbridge rpiboot[410]: Writing 52304 bytes
Jan 13 21:46:21 cbridge rpiboot[410]: libusb_bulk_transfer sent 52304 bytes; returned 0

==> /var/log/kern.log <==
Jan 13 21:46:22 cbridge kernel: [  310.534141] usb 1-1.1.4: USB disconnect, device number 5

==> /var/log/daemon.log <==
Jan 13 21:46:23 cbridge rpiboot[410]: Failed : 0x0Waiting for BCM2835/6/7/2711...

==> /var/log/kern.log <==
Jan 13 21:46:23 cbridge kernel: [  311.772494] usb 1-1.1.4: new full-speed USB device number 6 using xhci_hcd
Jan 13 21:46:23 cbridge kernel: [  311.904404] usb 1-1.1.4: not running at top speed; connect to a high speed hub
Jan 13 21:46:23 cbridge kernel: [  311.910406] usb 1-1.1.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
Jan 13 21:46:23 cbridge kernel: [  311.910421] usb 1-1.1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
Jan 13 21:46:23 cbridge kernel: [  311.910434] usb 1-1.1.4: Product: BCM2710 Boot
Jan 13 21:46:23 cbridge kernel: [  311.910446] usb 1-1.1.4: Manufacturer: Broadcom
Jan 13 21:46:23 cbridge kernel: [  311.910458] usb 1-1.1.4: SerialNumber: Broadcom

==> /var/log/daemon.log <==
Jan 13 21:46:23 cbridge rpiboot[410]: Device located successfully
Jan 13 21:46:23 cbridge rpiboot[410]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 13 21:46:24 cbridge rpiboot[410]: Initialised device correctly
Jan 13 21:46:24 cbridge rpiboot[410]: Found serial number 1
Jan 13 21:46:24 cbridge rpiboot[410]: Second stage boot server
Jan 13 21:46:24 cbridge rpiboot[410]: Received message GetFileSize: autoboot.txt
Jan 13 21:46:24 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:24 cbridge rpiboot[410]: Cannot open file autoboot.txt
Jan 13 21:46:24 cbridge rpiboot[410]: Received message GetFileSize: config.txt
Jan 13 21:46:24 cbridge rpiboot[410]: File size = 2036 bytes
Jan 13 21:46:24 cbridge rpiboot[410]: Received message ReadFile: config.txt
Jan 13 21:46:24 cbridge rpiboot[410]: File read: config.txt
Jan 13 21:46:24 cbridge rpiboot[410]: libusb_bulk_transfer sent 2036 bytes; returned 0
Jan 13 21:46:24 cbridge rpiboot[410]: Received message GetFileSize: recovery.elf
Jan 13 21:46:24 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:24 cbridge rpiboot[410]: Cannot open file recovery.elf
Jan 13 21:46:24 cbridge rpiboot[410]: Received message GetFileSize: start.elf
Jan 13 21:46:24 cbridge rpiboot[410]: File size = 2877988 bytes
Jan 13 21:46:24 cbridge rpiboot[410]: Received message ReadFile: start.elf
Jan 13 21:46:24 cbridge rpiboot[410]: File read: start.elf
Jan 13 21:46:28 cbridge rpiboot[410]: libusb_bulk_transfer sent 2877988 bytes; returned 0
Jan 13 21:46:28 cbridge rpiboot[410]: Received message GetFileSize: fixup.dat
Jan 13 21:46:28 cbridge rpiboot[410]: File size = 6736 bytes
Jan 13 21:46:28 cbridge rpiboot[410]: Received message ReadFile: fixup.dat
Jan 13 21:46:28 cbridge rpiboot[410]: File read: fixup.dat
Jan 13 21:46:28 cbridge rpiboot[410]: libusb_bulk_transfer sent 6736 bytes; returned 0
Jan 13 21:46:28 cbridge rpiboot[410]: Received message GetFileSize: recovery.elf
Jan 13 21:46:28 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:28 cbridge rpiboot[410]: Cannot open file recovery.elf
Jan 13 21:46:28 cbridge rpiboot[410]: Received message GetFileSize: config.txt
Jan 13 21:46:28 cbridge rpiboot[410]: File size = 2036 bytes
Jan 13 21:46:28 cbridge rpiboot[410]: Received message ReadFile: config.txt
Jan 13 21:46:28 cbridge rpiboot[410]: File read: config.txt
Jan 13 21:46:28 cbridge rpiboot[410]: libusb_bulk_transfer sent 2036 bytes; returned 0
Jan 13 21:46:28 cbridge rpiboot[410]: Received message GetFileSize: dt-blob.bin
Jan 13 21:46:28 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:28 cbridge rpiboot[410]: Cannot open file dt-blob.bin
Jan 13 21:46:29 cbridge rpiboot[410]: Received message GetFileSize: recovery.elf
Jan 13 21:46:29 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:29 cbridge rpiboot[410]: Cannot open file recovery.elf
Jan 13 21:46:29 cbridge rpiboot[410]: Received message GetFileSize: config.txt
Jan 13 21:46:29 cbridge rpiboot[410]: File size = 2036 bytes
Jan 13 21:46:29 cbridge rpiboot[410]: Received message ReadFile: config.txt
Jan 13 21:46:29 cbridge rpiboot[410]: File read: config.txt
Jan 13 21:46:29 cbridge rpiboot[410]: libusb_bulk_transfer sent 2036 bytes; returned 0
Jan 13 21:46:29 cbridge rpiboot[410]: Received message GetFileSize: bootcfg.txt
Jan 13 21:46:29 cbridge rpiboot[410]: libusb_bulk_transfer sent 0 bytes; returned 0
Jan 13 21:46:29 cbridge rpiboot[410]: Cannot open file bootcfg.txt
Jan 13 21:46:29 cbridge rpiboot[410]: Received message GetFileSize: cmdline.txt
Jan 13 21:46:29 cbridge rpiboot[410]: File size = 216 bytes
Jan 13 21:46:29 cbridge rpiboot[410]: Received message ReadFile: cmdline.txt
Jan 13 21:46:29 cbridge rpiboot[410]: File read: cmdline.txt
Jan 13 21:46:29 cbridge rpiboot[410]: libusb_bulk_transfer sent 216 bytes; returned 0
Jan 13 21:46:29 cbridge rpiboot[410]: Received message GetFileSize: initramfs.img
Jan 13 21:46:29 cbridge rpiboot[410]: File size = 5628912 bytes
Jan 13 21:46:29 cbridge rpiboot[410]: Received message ReadFile: initramfs.img
Jan 13 21:46:29 cbridge rpiboot[410]: File read: initramfs.img
Jan 13 21:46:37 cbridge rpiboot[410]: libusb_bulk_transfer sent 5628912 bytes; returned 0
Jan 13 21:46:37 cbridge rpiboot[410]: Received message GetFileSize: bcm2708-rpi-zero.dtb
Jan 13 21:46:37 cbridge rpiboot[410]: File size = 23671 bytes
Jan 13 21:46:37 cbridge rpiboot[410]: Received message ReadFile: bcm2708-rpi-zero.dtb
Jan 13 21:46:37 cbridge rpiboot[410]: File read: bcm2708-rpi-zero.dtb
Jan 13 21:46:37 cbridge rpiboot[410]: libusb_bulk_transfer sent 23671 bytes; returned 0
Jan 13 21:46:37 cbridge rpiboot[410]: Received message GetFileSize: config.txt
Jan 13 21:46:37 cbridge rpiboot[410]: File size = 2036 bytes
Jan 13 21:46:37 cbridge rpiboot[410]: Received message ReadFile: config.txt
Jan 13 21:46:37 cbridge rpiboot[410]: File read: config.txt
Jan 13 21:46:37 cbridge rpiboot[410]: libusb_bulk_transfer sent 2036 bytes; returned 0
Jan 13 21:46:37 cbridge rpiboot[410]: Received message GetFileSize: overlays/dwc2.dtbo
Jan 13 21:46:37 cbridge rpiboot[410]: File size = 801 bytes
Jan 13 21:46:37 cbridge rpiboot[410]: Received message ReadFile: overlays/dwc2.dtbo
Jan 13 21:46:37 cbridge rpiboot[410]: File read: overlays/dwc2.dtbo
Jan 13 21:46:37 cbridge rpiboot[410]: libusb_bulk_transfer sent 801 bytes; returned 0
Jan 13 21:50:59 cbridge systemd[1]: Started Session c2 of user pi.
Jan 13 21:56:13 cbridge systemd[1]: Starting Cleanup of Temporary Directories...

# 02

[ ... ]

And to revert back to the original

sudo mv -f /usr/bin/rpiboot.orig /usr/bin/rpiboot

pi@cbridge:~ $ clusterctrl off 

pi@cbridge:~ $ sudo mv -f /usr/bin/rpiboot.orig /usr/bin/rpiboot
pi@cbridge:~ $ sudo reboot
Using username "pi".
pi@192.168.188.23's password:
Send automatic password
Linux cbridge 4.19.93-v7l+ #1290 SMP Fri Jan 10 16:45:11 GMT 2020 armv7l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.
Last login: Mon Jan 13 22:06:23 2020 from 192.168.188.22


pi@cbridge:~ $
pi@cbridge:~ $
pi@cbridge:~ $

pi@cbridge:~ $ clusterctrl off && clusterctrl init && sudo usbboot-init 1 && clusterctrl on p1 && tail -F /var/log/daemon.log /var/log/kern.log
==> /var/log/daemon.log <==
Jan 13 22:06:23 cbridge systemd[730]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jan 13 22:06:23 cbridge systemd[730]: Reached target Paths.
Jan 13 22:06:23 cbridge systemd[730]: Listening on GnuPG network certificate management daemon.
Jan 13 22:06:23 cbridge systemd[730]: Reached target Sockets.
Jan 13 22:06:23 cbridge systemd[730]: Reached target Basic System.
Jan 13 22:06:23 cbridge systemd[730]: Reached target Default.
Jan 13 22:06:23 cbridge systemd[1]: Started User Manager for UID 1000.
Jan 13 22:06:23 cbridge systemd[730]: Startup finished in 148ms.
Jan 13 22:06:23 cbridge systemd[1]: Started Session c1 of user pi.
Jan 13 22:06:24 cbridge systemd[1]: Started Session c2 of user pi.

==> /var/log/kern.log <==
Jan 13 22:03:15 cbridge kernel: [   13.225621] usb 1-1.1.4: device descriptor read/8, error -61
Jan 13 22:03:15 cbridge kernel: [   13.342155] usb 1-1.1-port4: unable to enumerate USB device
Jan 13 22:03:20 cbridge kernel: [   18.391857] bcmgenet fd580000.genet eth0: Link is Up - 1Gbps/Full - flow control off
Jan 13 22:03:20 cbridge kernel: [   18.391904] br0: port 1(eth0) entered blocking state
Jan 13 22:03:20 cbridge kernel: [   18.391917] br0: port 1(eth0) entered forwarding state
Jan 13 22:03:20 cbridge kernel: [   18.392096] IPv6: ADDRCONF(NETDEV_CHANGE): br0: link becomes ready
Jan 13 22:04:14 cbridge kernel: [   72.471719] random: crng init done
Jan 13 22:04:14 cbridge kernel: [   72.471730] random: 7 urandom warning(s) missed due to ratelimiting
Jan 13 22:04:15 cbridge kernel: [   72.687366] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 13 22:04:21 cbridge kernel: [   78.592087] NFSD: starting 90-second grace period (net f0000041)
Jan 13 22:07:13 cbridge kernel: [  236.841462] usb 1-1.1.4: new full-speed USB device number 13 using xhci_hcd
Jan 13 22:07:13 cbridge kernel: [  236.977458] usb 1-1.1.4: New USB device found, idVendor=0a5c, idProduct=2763, bcdDevice= 0.00
Jan 13 22:07:13 cbridge kernel: [  236.977474] usb 1-1.1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jan 13 22:07:13 cbridge kernel: [  236.977487] usb 1-1.1.4: Product: BCM2708 Boot
Jan 13 22:07:13 cbridge kernel: [  236.977500] usb 1-1.1.4: Manufacturer: Broadcom

==> /var/log/daemon.log <==
Jan 13 22:07:13 cbridge rpiboot[409]: Device located successfully
Jan 13 22:07:13 cbridge rpiboot[409]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 13 22:07:14 cbridge rpiboot[409]: Initialised device correctly
Jan 13 22:07:14 cbridge rpiboot[409]: Found serial number 0
Jan 13 22:07:14 cbridge rpiboot[409]: Sending bootcode.bin
Jan 13 22:07:14 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:14 cbridge rpiboot[409]: Writing 52304 bytes
Jan 13 22:07:14 cbridge rpiboot[409]: libusb_bulk_transfer returned 0

==> /var/log/kern.log <==
Jan 13 22:07:15 cbridge kernel: [  239.304253] usb 1-1.1.4: USB disconnect, device number 13

==> /var/log/daemon.log <==
Jan 13 22:07:16 cbridge rpiboot[409]: Failed : 0x0Waiting for BCM2835/6/7

==> /var/log/kern.log <==
Jan 13 22:07:17 cbridge kernel: [  240.541202] usb 1-1.1.4: new full-speed USB device number 14 using xhci_hcd
Jan 13 22:07:17 cbridge kernel: [  240.673094] usb 1-1.1.4: not running at top speed; connect to a high speed hub
Jan 13 22:07:17 cbridge kernel: [  240.679091] usb 1-1.1.4: New USB device found, idVendor=0a5c, idProduct=2764, bcdDevice= 0.00
Jan 13 22:07:17 cbridge kernel: [  240.679106] usb 1-1.1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=1
Jan 13 22:07:17 cbridge kernel: [  240.679119] usb 1-1.1.4: Product: BCM2710 Boot
Jan 13 22:07:17 cbridge kernel: [  240.679132] usb 1-1.1.4: Manufacturer: Broadcom
Jan 13 22:07:17 cbridge kernel: [  240.679144] usb 1-1.1.4: SerialNumber: Broadcom

==> /var/log/daemon.log <==
Jan 13 22:07:17 cbridge rpiboot[409]: Device located successfully
Jan 13 22:07:17 cbridge rpiboot[409]: libusb: error [udev_hotplug_event] ignoring udev action bind
Jan 13 22:07:18 cbridge rpiboot[409]: Initialised device correctly
Jan 13 22:07:18 cbridge rpiboot[409]: Found serial number 1
Jan 13 22:07:18 cbridge rpiboot[409]: Second stage boot server
Jan 13 22:07:18 cbridge rpiboot[409]: Received message GetFileSize: autoboot.txt
Jan 13 22:07:18 cbridge rpiboot[409]: Cannot open file autoboot.txt
Jan 13 22:07:18 cbridge rpiboot[409]: Received message GetFileSize: config.txt
Jan 13 22:07:18 cbridge rpiboot[409]: File size = 2036 bytes
Jan 13 22:07:18 cbridge rpiboot[409]: Received message ReadFile: config.txt
Jan 13 22:07:18 cbridge rpiboot[409]: File read: config.txt
Jan 13 22:07:18 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:18 cbridge rpiboot[409]: Received message GetFileSize: recovery.elf
Jan 13 22:07:18 cbridge rpiboot[409]: Cannot open file recovery.elf
Jan 13 22:07:18 cbridge rpiboot[409]: Received message GetFileSize: start.elf
Jan 13 22:07:18 cbridge rpiboot[409]: File size = 2877988 bytes
Jan 13 22:07:18 cbridge rpiboot[409]: Received message ReadFile: start.elf
Jan 13 22:07:18 cbridge rpiboot[409]: File read: start.elf
Jan 13 22:07:22 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: fixup.dat
Jan 13 22:07:22 cbridge rpiboot[409]: File size = 6736 bytes
Jan 13 22:07:22 cbridge rpiboot[409]: Received message ReadFile: fixup.dat
Jan 13 22:07:22 cbridge rpiboot[409]: File read: fixup.dat
Jan 13 22:07:22 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: recovery.elf
Jan 13 22:07:22 cbridge rpiboot[409]: Cannot open file recovery.elf
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File size = 2036 bytes
Jan 13 22:07:22 cbridge rpiboot[409]: Received message ReadFile: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File read: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: dt-blob.bin
Jan 13 22:07:22 cbridge rpiboot[409]: Cannot open file dt-blob.bin
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: recovery.elf
Jan 13 22:07:22 cbridge rpiboot[409]: Cannot open file recovery.elf
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File size = 2036 bytes
Jan 13 22:07:22 cbridge rpiboot[409]: Received message ReadFile: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File read: config.txt
Jan 13 22:07:22 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: bootcfg.txt
Jan 13 22:07:22 cbridge rpiboot[409]: Cannot open file bootcfg.txt
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: cmdline.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File size = 216 bytes
Jan 13 22:07:22 cbridge rpiboot[409]: Received message ReadFile: cmdline.txt
Jan 13 22:07:22 cbridge rpiboot[409]: File read: cmdline.txt
Jan 13 22:07:22 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:22 cbridge rpiboot[409]: Received message GetFileSize: initramfs.img
Jan 13 22:07:22 cbridge rpiboot[409]: File size = 5628912 bytes
Jan 13 22:07:22 cbridge rpiboot[409]: Received message ReadFile: initramfs.img
Jan 13 22:07:22 cbridge rpiboot[409]: File read: initramfs.img
Jan 13 22:07:30 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:31 cbridge rpiboot[409]: Received message GetFileSize: bcm2708-rpi-zero.dtb
Jan 13 22:07:31 cbridge rpiboot[409]: File size = 23671 bytes
Jan 13 22:07:31 cbridge rpiboot[409]: Received message ReadFile: bcm2708-rpi-zero.dtb
Jan 13 22:07:31 cbridge rpiboot[409]: File read: bcm2708-rpi-zero.dtb
Jan 13 22:07:31 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:31 cbridge rpiboot[409]: Received message GetFileSize: config.txt
Jan 13 22:07:31 cbridge rpiboot[409]: File size = 2036 bytes
Jan 13 22:07:31 cbridge rpiboot[409]: Received message ReadFile: config.txt
Jan 13 22:07:31 cbridge rpiboot[409]: File read: config.txt
Jan 13 22:07:31 cbridge rpiboot[409]: libusb_bulk_transfer returned 0
Jan 13 22:07:31 cbridge rpiboot[409]: Received message GetFileSize: overlays/dwc2.dtbo
Jan 13 22:07:31 cbridge rpiboot[409]: File size = 801 bytes
Jan 13 22:07:31 cbridge rpiboot[409]: Received message ReadFile: overlays/dwc2.dtbo
Jan 13 22:07:31 cbridge rpiboot[409]: File read: overlays/dwc2.dtbo
Jan 13 22:07:31 cbridge rpiboot[409]: libusb_bulk_transfer returned 0

# 03

[ ... ]

With an updated initramfs, the same error comes up again

How did you update it?

I use a sctpit like you provide here:
> https://groups.google.com/forum/#!topic/clusterhat/hPssK5brs_w

But with the change of the PATH. The update process of initramfs it is just a check if this is a solution.

# 04

[ ... ]

Do you have anything you could hook up to the Pi Zero to see the serial console as if it gets here then it would normally indicate it has booted and if you don't see the USB devices then there's a problem with the initramfs or cmdline options.

No, I have to bought a cable tomorow. Do you have a solution without a cable or extra hardware?

# 05

Why I get "False" back if I check "clusterctrl status"?

pi@cbridge:~ $ clusterctrl status
clusterhat:1
clusterctrl:False
maxpi:4


hat_version:2.4
hat_version_major:2
hat_version_minor:4
hat_size:4


hat_uuid:de91a4ce-ac7f-11e9-a2a3-2a2ae2dbcce4


hat_vendor:8086 Consultancy
hat_product_id:0x0004
throttled:0x0
hat_alert:0
hat_hub:1
hat_wp:1
hat_led:1
hat_wplink:0
hat_xra1200p:True
p1:1


p2:0
p3:0
p4:0

# 06

Also USB-C Cable and power supply unit checked.

Kind Regards

Chris Burton

unread,

Jan 14, 2020, 10:23:35 AM1/14/20

to ClusterHAT

Hi,

As I said if this doesn't help send me your name/address details and the ClusterHAT serial number to Sup...@8086.net.uk and I'll sort out a replacement.