BTRFS RAID1 mounting problems dietpi_userdata

Creating a bug report/issue

Required Information

  • DietPi version | cat /boot/dietpi/.version
G_DIETPI_VERSION_CORE=8
G_DIETPI_VERSION_SUB=17
G_DIETPI_VERSION_RC=2
G_GITBRANCH='master'
G_GITOWNER='MichaIng'Testo preformattato
G_LIVE_PATCH_STATUS[0]='applied'
G_LIVE_PATCH_STATUS[1]='applied'
  • Distro version | echo $G_DISTRO_NAME $G_RASPBIAN
    bullseye 0

  • Kernel version | uname -a
    Linux DietPi 6.1.21-v8+ #1642 SMP PREEMPT Mon Apr 3 17:24:16 BST 2023 aarch64 GNU/Linux

  • Architecture | dpkg --print-architecture
    arm64

  • SBC model | echo $G_HW_MODEL_NAME or (EG: RPi3)
    RPi 4 Model B (aarch64)

  • Power supply used | (EG: 5V 1A RAVpower)

AC ADAPTOR 
Out= 5.0V 3.0A

Raspberry Pi AC.
Out= 5.1V 3.0A
  • SD card used | (EG: SanDisk ultra)
KEXIN 64GB A1 V30
https://amzn.eu/d/hksDDG6
2x Hikvision SSD 120GB
https://amzn.eu/d/2gLM6z7
2x SATA to USB 3.0
https://amzn.eu/d/38E28LN

Additional Information

  • Software title
    BTRFS-progs , AdGuard-HOME

  • Was the software title installed freshly or updated/migrated?
    clean installation

  • Can this issue be replicated on a fresh installation of DietPi?
    on dietpi yes, I tried on Raspberry Pi OS_lite and the problem does not occur

  • If you sent a “dietpi-bugreport”, please paste the ID here -
    Bug report ID | echo $G_HW_UUID
    471ec7a6-9bf0-4297-b814-e5d46952a965

Steps to reproduce

  1. dietpi-config set ip static
  2. apt install btrfs-progs neofetch neovim
  3. lsblk -f
NAME        FSTYPE FSVER LABEL           UUID                                 FSAVAIL FSUSE% MOUNTPOINT
sda         ext4         ssd1            3fc139ea-a6e5-46ae-abc8-6b13476be498  110.6G              
sdb         ext4         ssd2            4fc129aa-b6e5-46ae-abc8-6b1342131231  110.6G      
mmcblk0                                                                                      
├─mmcblk0p1 vfat   FAT32                 87B6-65D6                                95M    25% /boot
└─mmcblk0p2 ext4   1.0                   d8262ac8-d5a2-4e45-9270-8b232b22a0c3   52.7G     4% /
  1. raid1 creation with btrfs
    mkfs.btrfs -f -L "BTRFS_RAID1_SSD" -m raid1 /dev/sda /dev/sdb -d raid1 /dev/sda /dev/sdb

  2. mount fs

mkdir /mnt/btrfsDATA
mount -t btrfs -o ssd,compress=zstd /dev/sda /mnt/btrfsDATA
cd /mnt/btrfsDATA
  1. create subvolum
btrfs subvolume create @
btrfs subvolume create @share
btrfs subvolume create @snapshots
btrfs subvolume create @dietpi-backup
btrfs subvolume create @dietpi_userdata
umount /mnt/btrfsDATA
  1. mount subvol (/dev/sda == sdb)
mount -o ssd,compress=zstd,subvol=@ /dev/sda /mnt/btrfsDATA
mkdir /mnt/btrfsDATA/share
mkdir /mnt/btrfsDATA/dietpi-backup
mkdir /mnt/btrfsDATA/snapshots
mkdir /mnt/btrfsDATA/dietpi_userdata
mount -o ssd,compress=zstd,subvol=@share /dev/sda /mnt/btrfsDATA/share
mount -o ssd,compress=zstd,subvol=@snapshots /dev/sda /mnt/btrfsDATA/snapshots
mount -o ssd,compress=zstd,subvol=@dietpi-backup /dev/sda /mnt/btrfsDATA/dietpi-backup
mount -o ssd,compress=zstd,subvol=@dietpi_userdata /dev/sda /mnt/btrfsDATA/dietpi_userdat
  1. create fstab (you can also use ‘arch-install-scripts’ which has genfstab inside it)
root@DietPi:~# cat /etc/fstab
# You can use "dietpi-drive_manager" to setup mounts.
tmpfs /tmp tmpfs size=1922M,noatime,lazytime,nodev,nosuid,mode=1777
tmpfs /var/log tmpfs size=50M,noatime,lazytime,nodev,nosuid
: ecryptfs, vboxsf, glusterfs, mergerfs, bind, Btrfs subvolume

# PHYSICAL DRIVES
PARTUUID=1fce20a9-02 / ext4 noatime,lazytime,rw 0 1

PARTUUID=1fce20a9-01 /boot vfat noatime,lazytime,rw 0 2

UUID=3fc139ea-a6e5-46ae-abc8-6b13476be498 /mnt/btrfsDATA btrfs defaults,ssd,relatime,lazytime,discard=async,space_cache,compress=zstd,subvol=/@,nofail,x-systemd.device-timeout=20 0 0

UUID=3fc139ea-a6e5-46ae-abc8-6b13476be498 /mnt/btrfsDATA/dietpi_userdata btrfs defaults,ssd,relatime,lazytime,discard=async,space_cache,compress=zstd,subvol=/@dietpi_userdata,nofail,x-systemd.device-timeout=20 0 0

UUID=3fc139ea-a6e5-46ae-abc8-6b13476be498 /mnt/btrfsDATA/dietpi-backup btrfs defaults,ssd,relatime,lazytime,discard=async,space_cache,compress=zstd,subvol=/@dietpi-backup,nofail,x-systemd.device-timeout=20 0 0

UUID=3fc139ea-a6e5-46ae-abc8-6b13476be498 /mnt/btrfsDATA/snapshots btrfs defaults,ssd,relatime,lazytime,discard=async,space_cache,compress=zstd,subvol=/@snapshots,nofail,x-systemd.device-timeout=20 0 0

UUID=3fc139ea-a6e5-46ae-abc8-6b13476be498 /mnt/btrfsDATA/share btrfs defaults,ssd,relatime,lazytime,discard=async,space_cache,compress=zstd,subvol=/@share,nofail,x-systemd.device-timeout=20 0 0

  1. I use dietpi-software to move the dietpi_userdata folder to raid1 btrfs /mnt/btrfsDATA/dietpi_userdata
    diet

  2. reboot

  3. open dietpi-software install adguard (or any other software that you are going to install/read files on the dietpi_userdata folder)

Expected behaviour

  • RAID1 should be mounted on /mnt/btrfsDATA and everything should work with all its subvols
  • services should work and the kernel should not give messages

Actual behaviour

  1. when booting the system and the raid1 is correctly mounted and the services present (such as adguard) start and work correctly, I see that with lsblk -f the two SSDs are seen correctly but after a few seconds/minutes they disappear and also all mounted partitions are forcibly unmounted and are no longer present on mount. there are errors returned by dmesg .

p.s the output is too long and exceeds the characters for this post, so I deleted the parts I considered less important and inserted the log file directly.
log.log (38,9 KB)

root@DietPi:~# dmesg 
[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd083]
[    0.000000] Linux version 6.1.21-v8+ (dom@buildbot) (aarch64-linux-gnu-gcc-8 (Ubuntu/Linaro 8.4.0-3ubuntu1) 8.4.0, GNU ld (GNU Binutils for Ubuntu) 2.34) #1642 SMP PREEMPT Mon Apr  3 17:24:16 BST 2023
[    0.000000] random: crng init done
[    0.000000] Machine model: Raspberry Pi 4 Model B Rev 1.2
[    0.000000] efi: UEFI not found.
[    0.000000] Reserved memory: created CMA memory pool at 0x000000002ac00000, size 64 MiB
[    0.000000] OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000003fffffff]
[    0.000000]   DMA32    [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000003e5fffff]
[    0.000000]   node   0: [mem 0x0000000040000000-0x00000000fbffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x00000000fbffffff]
[    0.000000] On node 0, zone DMA32: 6656 pages in unavailable ranges
[    0.000000] On node 0, zone DMA32: 16384 pages in unavailable ranges
[    0.000000] percpu: Embedded 29 pages/cpu s78504 r8192 d32088 u118784
[    0.000000] pcpu-alloc: s78504 r8192 d32088 u118784 alloc=29*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Detected PIPT I-cache on CPU0
snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_hdmi=0 bcm2708_fb.fbwidth=0 bcm2708_fb.fbheight=0 bcm2708_fb.fbdepth=16 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:B2:5E:F7 vc_mem.mem_base=0x3f000000 vc_mem.mem_size=0x3f600000  root=PARTUUID=1fce20a9-02 rootfstype=ext4 rootwait net.ifnames=0 logo.nologo console=tty1
max_idle_ns: 440795203123 ns
[    0.000000] sched_clock: 56 bits at 54MHz, resolution 18ns, wraps every 4398046511102ns
[    0.000160] Console: colour dummy device 80x25
[    0.000421] printk: console [tty1] enabled
[    0.000455] Calibrating delay loop (skipped), value calculated using timer frequency.. 108.00 BogoMIPS (lpj=216000)
[    0.000473] pid_max: default: 32768 minimum: 301
[    0.000537] LSM: Security Framework initializing
[    0.000651] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.000686] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.001310] cgroup: Disabling memory control group subsystem
[    0.002336] cblist_init_generic: Setting adjustable number of callback queues.
[    0.002353] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.002435] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.002517] cblist_init_generic: Setting shift to 2 and lim to 1.
[    0.002719] rcu: Hierarchical SRCU implementation.
024 (order: 4, 65536 bytes, linear)
[    0.063940] usbcore: registered new interface driver usbfs
[    0.063971] usbcore: registered new interface driver hub
[    0.064006] usbcore: registered new device driver usb
[    0.064151] usb_phy_generic phy: supply vcc not found, using dummy regulator
[    0.064282] usb_phy_generic phy: dummy supplies not allowed for exclusive requests
[    0.064440] pps_core: LinuxPPS API ver. 1 registered
[    0.064450] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti 
[    0.625942] bcm2708_fb soc:fb: Unable to determine number of FBs. Disabling driver.
[    0.625957] bcm2708_fb: probe of soc:fb failed with error -2
[    0.630648] iproc-rng200 fe104000.rng: hwrng registered
[    0.631449] gpiomem-bcm2835 fe200000.gpiomem: Initialised: Registers at 0xfe200000
[    0.637075] brd: module loaded
[    0.640971] loop: module loaded
[    0.641376] Loading iSCSI transport class v2.0-870.
[    0.643658] bcmgenet fd580000.ethernet: GENET 5.0 EPHY: 0x0000
[    0.701428] unimac-mdio unimac-mdio.-19: Broadcom UniMAC MDIO bus
[    0.701982] usbcore: registered new interface driver r8152
[    0.702032] usbcore: registered new interface driver lan78xx
[    0.702062] usbcore: registered new interface driver smsc95xx
[    0.703351] pci 0000:00:00.0: enabling device (0000 -> 0002)
[    0.703375] xhci_hcd 0000:01:00.0: enabling device (0000 -> 0002)
[    0.703435] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    0.703455] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 1
[    0.703884] xhci_hcd 0000:01:00.0: hcc params 0x002841eb hci version 0x100 quirks 0x0000e40000000890
[    0.704227] xhci_hcd 0000:01:00.0: xHCI Host Controller
[    0.704242] xhci_hcd 0000:01:00.0: new USB bus registered, assigned bus number 2
[    0.704257] xhci_hcd 0000:01:00.0: Host supports USB 3.0 SuperSpeed
[    0.704435] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.01
[    0.704450] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.704462] usb usb1: Product: xHCI Host Controller
[    0.704471] usb usb1: Manufacturer: Linux 6.1.21-v8+ xhci-hcd
[    0.704481] usb usb1: SerialNumber: 0000:01:00.0
[    0.704829] hub 1-0:1.0: USB hub found
[    0.704863] hub 1-0:1.0: 1 port detected
[    0.705269] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 6.01
[    0.705284] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.705296] usb usb2: Product: xHCI Host Controller
[    0.705305] usb usb2: Manufacturer: Linux 6.1.21-v8+ xhci-hcd
[    0.705314] usb usb2: SerialNumber: 0000:01:00.0
[    0.705624] hub 2-0:1.0: USB hub found
[    0.705687] hub 2-0:1.0: 4 ports detected
[    0.706471] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[    0.706587] dwc_otg: FIQ enabled
[    0.706592] dwc_otg: NAK holdoff enabled
[    0.706596] dwc_otg: FIQ split-transaction FSM enabled
[    0.706603] Module dwc_common_port init
[    0.706882] usbcore: registered new interface driver uas
[    0.706935] usbcore: registered new interface driver usb-storage
[    0.707063] mousedev: PS/2 mouse device common for all mice
[    0.709520] sdhci: Secure Digital Host Controller Interface driver
[    0.709538] sdhci: Copyright(c) Pierre Ossman
[    0.709754] sdhci-pltfm: SDHCI platform and OF driver helper
[    0.711894] ledtrig-cpu: registered to indicate activity on CPUs
[    0.712054] hid: raw HID events driver (C) Jiri Kosina
[    0.712136] usbcore: registered new interface driver usbhid
[    0.712147] usbhid: USB HID core driver
[    0.716272] NET: Registered PF_PACKET protocol family
[    0.716359] Key type dns_resolver registered
[    0.716989] registered taskstats version 1
[    0.717035] Loading compiled-in X.509 certificates
[    0.717529] Key type .fscrypt registered
[    0.717543] Key type fscrypt-provisioning registered
[    0.724425] uart-pl011 fe201000.serial: there is not valid maps for state default
[    0.724788] uart-pl011 fe201000.serial: cts_event_workaround enabled
[    0.724879] fe201000.serial: ttyAMA0 at MMIO 0xfe201000 (irq = 35, base_baud = 0) is a PL011 rev2
[    0.731087] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[    0.731301] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
[    0.732697] of_cfs_init
[    0.732775] of_cfs_init: OK
[    0.768782] mmc0: SDHCI controller on fe340000.mmc [fe340000.mmc] using ADMA
[    0.768957] Waiting for root device PARTUUID=1fce20a9-02...
[    0.878878] mmc0: new ultra high speed DDR50 SDXC card at address b36b
[    0.879455] mmcblk0: mmc0:b36b SDABC 58.3 GiB 
[    0.881314]  mmcblk0: p1 p2
[    0.881653] mmcblk0: mmc0:b36b SDABC 58.3 GiB
[    0.899382] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
[    0.899406] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
[    0.961394] usb 1-1: new high-speed USB device number 2 using xhci_hcd
[    1.085320] EXT4-fs (mmcblk0p2): recovery complete
[    1.086876] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Quota mode: none.
[    1.086946] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
[    1.087523] devtmpfs: mounted
[    1.091932] Freeing unused kernel memory: 4160K
[    1.092040] Run /sbin/init as init process
[    1.092050]   with arguments:
[    1.092054]     /sbin/init
[    1.092058]   with environment:
[    1.092062]     HOME=/
[    1.092066]     TERM=linux
[    1.111728] usb 1-1: New USB device found, idVendor=2109, idProduct=3431, bcdDevice= 4.21
[    1.111763] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    1.111774] usb 1-1: Product: USB2.0 Hub
[    1.113002] hub 1-1:1.0: USB hub found
[    1.113325] hub 1-1:1.0: 4 ports detected
[    1.237672] usb 2-1: new SuperSpeed USB device number 2 using xhci_hcd
[    1.259036] usb 2-1: New USB device found, idVendor=7825, idProduct=a2a4, bcdDevice=41.01
[    1.259068] usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    1.259080] usb 2-1: Product: Best USB Device
[    1.259089] usb 2-1: Manufacturer: ULT-Best
[    1.259098] usb 2-1: SerialNumber: 235678C218CA
[    1.267732] scsi host0: uas
[    1.268863] scsi 0:0:0:0: Direct-Access     HS-SSD-M inder(S) 120G    4101 PQ: 0 ANSI: 6
[    1.271667] sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/112 GiB)
[    1.271693] sd 0:0:0:0: [sda] 4096-byte physical blocks
[    1.271889] sd 0:0:0:0: [sda] Write Protect is off
[    1.271902] sd 0:0:0:0: [sda] Mode Sense: 53 00 00 08
[    1.272294] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.272708] sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
[    1.272721] sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
[    1.275012] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.393665] usb 2-2: new SuperSpeed USB device number 3 using xhci_hcd
[    1.406045] systemd[1]: System time before build time, advancing clock.
[    1.415111] usb 2-2: New USB device found, idVendor=7825, idProduct=a2a4, bcdDevice=41.01
[    1.415141] usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[    1.415152] usb 2-2: Product: Best USB Device
[    1.415161] usb 2-2: Manufacturer: ULT-Best
[    1.415170] usb 2-2: SerialNumber: 235678C218CA
[    1.424190] scsi host1: uas
[    1.425105] scsi 1:0:0:0: Direct-Access     HS-SSD-M inder(S) 120G    4101 PQ: 0 ANSI: 6
[    1.427914] sd 1:0:0:0: [sdb] 234441648 512-byte logical blocks: (120 GB/112 GiB)
[    1.427941] sd 1:0:0:0: [sdb] 4096-byte physical blocks
[    1.428145] sd 1:0:0:0: [sdb] Write Protect is off
[    1.428161] sd 1:0:0:0: [sdb] Mode Sense: 53 00 00 08
[    1.428531] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.428969] sd 1:0:0:0: [sdb] Preferred minimum I/O size 4096 bytes
[    1.428982] sd 1:0:0:0: [sdb] Optimal transfer size 33553920 bytes not a multiple of preferred 
[    3.424508] xor: measuring software checksum speed
[    3.425917]    8regs           :  7235 MB/sec
[    3.427191]    32regs          :  7838 MB/sec
[    3.430724]    arm64_neon      :  3080 MB/sec
[    3.430740] xor: using function: 32regs (7838 MB/sec)
[    3.570781] Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no
[    3.573476] BTRFS: device label BTRFS_RAID1_SSD devid 2 transid 131 /dev/sda scanned by systemd-udevd (182)
[    3.574323] BTRFS: device label BTRFS_RAID1_SSD devid 1 transid 131 /dev/sdb scanned by systemd-udevd (176)
[    3.658390] 8021q: 802.1Q VLAN Support v1.8
[    3.764732] bcmgenet fd580000.ethernet: configuring instance for external RGMII (RX delay)
[    3.765989] bcmgenet fd580000.ethernet eth0: Link is Down
[    4.044580] BTRFS info (device sdb): using crc32c (crc32c-generic) checksum algorithm
[    4.044644] BTRFS info (device sdb): enabling ssd optimizations
[    4.044654] BTRFS info (device sdb): turning on async discard
[    4.044665] BTRFS info (device sdb): use zstd compression, level 3
[    4.044678] BTRFS info (device sdb): disk space caching is enabled
[    4.773135] wireguard: WireGuard 1.0.0 loaded. See www.wireguard.com for information.
[    4.773150] wireguard: Copyright (C) 2015-2019 Jason A. Donenfeld <Jason@zx2c4.com>. All Rights Reserved.
[    7.869559] bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx
[    7.869604] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   35.845420] sd 1:0:0:0: [sdb] tag#28 uas_eh_abort_handler 0 uas-tag 5 inflight: CMD IN 
[   35.845444] sd 1:0:0:0: [sdb] tag#28 CDB: opcode=0x28 28 00 00 20 ea c8 00 01 48 00
[   35.845639] sd 1:0:0:0: [sdb] tag#27 uas_eh_abort_handler 0 uas-tag 4 inflight: CMD IN 
[   35.845647] sd 1:0:0:0: [sdb] tag#27 CDB: opcode=0x28 28 00 00 20 f1 88 00 01 48 00
[   35.845963] sd 1:0:0:0: [sdb] tag#26 uas_eh_abort_handler 0 uas-tag 3 inflight: CMD IN 
[   35.845971] sd 1:0:0:0: [sdb] tag#26 CDB: opcode=0x28 28 00 00 30 7d f0 00 00 80 00
[   35.846276] sd 1:0:0:0: [sdb] tag#25 uas_eh_abort_handler 0 uas-tag 2 inflight: CMD IN 
[   35.846283] sd 1:0:0:0: [sdb] tag#25 CDB: opcode=0x28 28 00 00 20 f0 10 00 01 78 00
[   35.846444] xhci_hcd 0000:01:00.0: WARNING: Host System Error
[   40.925405] xhci_hcd 0000:01:00.0: xHCI host not responding to stop endpoint command
[   40.925434] xhci_hcd 0000:01:00.0: xHCI host controller not responding, assume dead
[   40.925580] xhci_hcd 0000:01:00.0: HC died; cleaning up
[   40.925621] usb 1-1: USB disconnect, device number 2
[   40.926404] usb 2-1: USB disconnect, device number 2
[   40.926641] sd 1:0:0:0: [sdb] tag#24 uas_eh_abort_handler 0 uas-tag 1 inflight: CMD 
[   40.926652] sd 1:0:0:0: [sdb] tag#24 CDB: opcode=0x28 28 00 00 30 7d 90 00 00 60 00
[   40.926663] sd 1:0:0:0: [sdb] tag#14 uas_eh_abort_handler 0 uas-tag 20 inflight: CMD 
[   40.926668] sd 1:0:0:0: [sdb] tag#14 CDB: opcode=0x28 28 00 00 21 06 08 00 01 50 00
[   40.926678] sd 1:0:0:0: [sdb] tag#13 uas_eh_abort_handler 0 uas-tag 19 inflight: CMD 
[   40.926683] sd 1:0:0:0: [sdb] tag#13 CDB: opcode=0x28 28 00 00 30 83 90 00 00 b0 00
[   40.926693] sd 1:0:0:0: [sdb] tag#12 uas_eh_abort_handler 0 uas-tag 18 inflight: CMD 
[   40.926697] sd 1:0:0:0: [sdb] tag#12 CDB: opcode=0x28 28 00 00 21 05 08 00 01 00 00
[   40.926707] sd 1:0:0:0: [sdb] tag#11 uas_eh_abort_handler 0 uas-tag 17 inflight: CMD 
[   40.926712] sd 1:0:0:0: [sdb] tag#11 CDB: opcode=0x28 28 00 00 21 01 08 00 04 00 00
[   40.926722] sd 1:0:0:0: [sdb] tag#10 uas_eh_abort_handler 0 uas-tag 14 inflight: CMD 
[   40.926726] sd 1:0:0:0: [sdb] tag#10 CDB: opcode=0x28 28 00 00 20 fd c0 00 02 70 00
[   40.926736] sd 1:0:0:0: [sdb] tag#9 uas_eh_abort_handler 0 uas-tag 16 inflight: CMD 
[   40.926740] sd 1:0:0:0: [sdb] tag#9 CDB: opcode=0x28 28 00 00 21 00 30 00 00 d8 00
[   40.926750] sd 1:0:0:0: [sdb] tag#8 uas_eh_abort_handler 0 uas-tag 15 inflight: CMD 
[   40.926755] sd 1:0:0:0: [sdb] tag#8 CDB: opcode=0x28 28 00 00 30 83 10 00 00 80 00
[   40.926764] sd 1:0:0:0: [sdb] tag#7 uas_eh_abort_handler 0 uas-tag 13 inflight: CMD 
[   40.926768] sd 1:0:0:0: [sdb] tag#7 CDB: opcode=0x28 28 00 00 30 82 50 00 00 c0 00
[   40.926778] sd 1:0:0:0: [sdb] tag#6 uas_eh_abort_handler 0 uas-tag 12 inflight: CMD 
[   40.926782] sd 1:0:0:0: [sdb] tag#6 CDB: opcode=0x28 28 00 00 20 fc 90 00 01 30 00
[   40.926792] sd 1:0:0:0: [sdb] tag#5 uas_eh_abort_handler 0 uas-tag 11 inflight: CMD 
[   40.926796] sd 1:0:0:0: [sdb] tag#5 CDB: opcode=0x28 28 00 00 30 81 e0 00 00 70 00
[   40.926806] sd 1:0:0:0: [sdb] tag#4 uas_eh_abort_handler 0 uas-tag 10 inflight: CMD 
[   40.926810] sd 1:0:0:0: [sdb] tag#4 CDB: opcode=0x28 28 00 00 20 f3 e0 00 01 30 00
[   40.926820] sd 1:0:0:0: [sdb] tag#3 uas_eh_abort_handler 0 uas-tag 8 inflight: CMD 
[   40.926824] sd 1:0:0:0: [sdb] tag#3 CDB: opcode=0x28 28 00 00 20 f2 d0 00 01 10 00
[   40.926834] sd 1:0:0:0: [sdb] tag#2 uas_eh_abort_handler 0 uas-tag 7 inflight: CMD 
[   40.926838] sd 1:0:0:0: [sdb] tag#2 CDB: opcode=0x28 28 00 00 30 7e 70 00 00 58 00
[   40.926847] sd 1:0:0:0: [sdb] tag#1 uas_eh_abort_handler 0 uas-tag 6 inflight: CMD 
[   40.926852] sd 1:0:0:0: [sdb] tag#1 CDB: opcode=0x28 28 00 00 20 ec 10 00 04 00 00
[   40.926861] sd 1:0:0:0: [sdb] tag#0 uas_eh_abort_handler 0 uas-tag 9 inflight: CMD 
[   40.926866] sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 30 7e c8 00 00 70 00
[   40.977474] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[   41.221452] sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
[   41.221863] xhci_hcd 0000:01:00.0: WARN Can't disable streams for endpoint 0x82, streams are being disabled already
[   41.224306] usb 2-2: USB disconnect, device number 3
[   41.224492] sd 1:0:0:0: [sdb] tag#15 uas_zap_pending 0 uas-tag 21 inflight: CMD 
[   41.224501] sd 1:0:0:0: [sdb] tag#15 CDB: opcode=0x28 28 00 00 01 20 80 00 00 20 00
[   41.224557] sd 1:0:0:0: [sdb] tag#15 UNKNOWN(0x2003) Result: hostbyte=0x01 driverbyte=DRIVER_OK cmd_age=5s
[   41.224567] sd 1:0:0:0: [sdb] tag#15 CDB: opcode=0x28 28 00 00 01 20 80 00 00 20 00
[   41.224575] I/O error, dev sdb, sector 73856 op 0x0:(READ) flags 0x1000 phys_seg 4 prio class 2
[   41.224602] BTRFS error (device sdb): bdev /dev/sdb errs: wr 0, rd 1, flush 0, corrupt 0, gen 0
[   41.224681] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224689] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224695] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224700] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224706] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224711] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224716] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224721] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224726] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224732] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224737] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224742] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224747] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224752] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224758] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224763] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224768] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224773] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224778] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224784] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224888] BTRFS error (device sdb): bdev /dev/sda errs: wr 0, rd 1, flush 0, corrupt 0, gen 0
[   41.225790] BTRFS: error (device sdb: state A) in __btrfs_free_extent:3070: errno=-5 IO failure
[   41.225824] BTRFS info (device sdb: state EA): forced readonly
[   41.225835] BTRFS error (device sdb: state EA): failed to run delayed ref for logical 37093376 num_bytes 16384 type 176 action 2 ref_mod 1: -5
[   41.225854] BTRFS: error (device sdb: state EA) in btrfs_run_delayed_refs:2144: errno=-5 IO failure
[   41.225872] BTRFS warning (device sdb: state EA): Skipping commit of aborted transaction.
[   41.225881] BTRFS: error (device sdb: state EA) in cleanup_transaction:1958: errno=-5 IO failure
[   41.233546] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 4, flush 0, corrupt 0, gen 0
[   41.233555] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 6, flush 0, corrupt 0, gen 0
[   41.233556] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 6, flush 0, corrupt 0, gen 0
[   41.233579] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 8, flush 0, corrupt 0, gen 0
[   41.233580] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 8, flush 0, corrupt 0, gen 0
[   41.233598] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 9, flush 0, corrupt 0, gen 0
[   41.233606] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 10, flush 0, corrupt 0, gen 0
[   41.233619] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 11, flush 0, corrupt 0, gen 0
[   41.277444] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[   41.549469] sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
[   41.573694] xhci_hcd 0000:01:00.0: WARN Can't disable streams for endpoint 0x82, streams are being disabled already
  1. in the second case, the system boots but directly without mounting btrfs and without usb devices being recognised
[   41.224763] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224768] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224773] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224778] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224784] sd 1:0:0:0: Device offlined - not ready after error recovery
[   41.224888] BTRFS error (device sdb): bdev /dev/sda errs: wr 0, rd 1, flush 0, corrupt 0, gen 0
[   41.225790] BTRFS: error (device sdb: state A) in __btrfs_free_extent:3070: errno=-5 IO failure
[   41.225824] BTRFS info (device sdb: state EA): forced readonly
[   41.225835] BTRFS error (device sdb: state EA): failed to run delayed ref for logical 37093376 num_bytes 16384 type 176 action 2 ref_mod 1: -5
[   41.225854] BTRFS: error (device sdb: state EA) in btrfs_run_delayed_refs:2144: errno=-5 IO failure
[   41.225872] BTRFS warning (device sdb: state EA): Skipping commit of aborted transaction.
[   41.225881] BTRFS: error (device sdb: state EA) in cleanup_transaction:1958: errno=-5 IO failure
[   41.233546] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 4, flush 0, corrupt 0, gen 0
[   41.233555] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 6, flush 0, corrupt 0, gen 0
[   41.233556] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 6, flush 0, corrupt 0, gen 0
[   41.233579] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 8, flush 0, corrupt 0, gen 0
[   41.233580] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 8, flush 0, corrupt 0, gen 0
[   41.233598] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 9, flush 0, corrupt 0, gen 0
[   41.233606] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 10, flush 0, corrupt 0, gen 0
[   41.233619] BTRFS error (device sdb: state EA): bdev /dev/sda errs: wr 0, rd 11, flush 0, corrupt 0, gen 0
[   41.277444] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[   41.549469] sd 1:0:0:0: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
[   41.573694] xhci_hcd 0000:01:00.0: WARN Can't disable streams for endpoint 0x82, streams are being disabled already
root@DietPi:~# lsblk -f
NAME        FSTYPE FSVER LABEL UUID                                 FSAVAIL FSUSE% MOUNTPOINT
mmcblk0                                                                            
├─mmcblk0p1 vfat   FAT32       87B6-65D6                                95M    25% /boot
└─mmcblk0p2 ext4   1.0         d8262ac8-d5a2-4e45-9270-8b232b22a0c3   52.7G     4% /
root@DietPi:~# 
root@DietPi:~# 

Extra details

I wouldn’t know what other details you might need beyond these, so please ask me what I can bring to the table to understand this problem

Looks like I/O errors on your drives. Probably a voltage issue leading to data corruption and drives going offline. How are the drives powered? Do they have own PSU or just connected via USB to RPi4?

2 Likes

are connected via USB, I have also inserted the components used above. i don’t think it is a power supply problem because on debian and others it works without this problem.

Especially with the RPi4, the USB ports are not designed to power external drives (SSD/HDD). During the boot or start-up phase, the drives could consume more power than the USB ports can provide. @MichaIng could explain it more in detail.

1 Like

okey, but on normal debian it works and also on ubuntu_arm. even on dietpi it works for a few minutes after booting and then dies, so i believe it is not a problem with the power supply of the 2 ssds. besides i always had 2 ssds connected and never had any kind of problem. i had a raid1 with mdadm, with root and boot present on both ssds and i had no such problems. could it be something else ?

Not even a single SSD should be attached to RPi USB without external powering. Also RPi devs clearly state that. All USB ports share an overall power of 6W (1.2A), which can be easily exceeded by a single SSD on initial power up or usage peaks. What vendors state as long term power usage does not say much about peak power needs.

It is totally normal that it may work with one OS but not with another, or better with one kernel but not with another. It highly depends on how devices are initialised, in which order, concurrently or by chance one after another, which CPU governor is used on early boot, which one applied in userland at which time, whether initial_turbo is used on RPi, ARM/GPU/RAM clocks etc etc.

So it may work stable, unstable or not at all, it simply is a fragile setup which I would never recommend to run with any OS. Any system or kernel upgrade may have an effect on this and break your data or database if the resulting crash happens at an unlucky time.

1 Like