@GeoffA Hello again, and thanks for an excellent report. I can chip in with some elements of this.
This is a known upstream issue, see:
opened 02:22PM - 20 Jul 19 UTC
I'm not sure if this is the same problem as #2802 . I'm not using an SD card in … the Pi Zero (booting with rpiboot, USB Gadget Ethernet and NFS root) but I'm seeing the timeout. The Pi Zero had just been set idle after booting Buster (Lite) over USB.
System Information
------------------
Raspberry Pi Zero Rev 1.3
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
Raspberry Pi reference 2019-07-10
Generated using pi-gen, https://github.com/RPi-Distro/pi-gen, 175dfb027ffabd4b8d5080097af0e51ed9a4a56c, stage2
Linux p1 4.19.57+ #1244 Thu Jul 4 18:42:50 BST 2019 armv6l GNU/Linux
Hardware : BCM2835
Revision : 900093
Serial : 000000000bd39641
Throttled flag : throttled=0x0
Camera : supported=0 detected=0
Videocore information
---------------------
Jul 9 2019 14:40:53
Copyright (c) 2012 Broadcom
version 6c3fe3f096a93de3b34252ad98cdccadeb534be2 (clean) (release) (start)
alloc failures: 0
compactions: 0
legacy block fails: 0
Filesystem information
----------------------
Filesystem 1K-blocks Used Available Use% Mounted on
udev 214596 0 214596 0% /dev
tmpfs 44312 1980 42332 5% /run
172.19.180.254:/var/lib/clusterctrl/nfs/p1 30442880 7979136 21194624 28% /
tmpfs 221552 0 221552 0% /dev/shm
tmpfs 5120 4 5116 1% /run/lock
tmpfs 221552 0 221552 0% /sys/fs/cgroup
tmpfs 44308 0 44308 0% /run/user/1000
Filename Type Size Used Priority
Package version information
---------------------------
raspberrypi-ui-mods:
Installed: (none)
raspberrypi-sys-mods:
Installed: 20190429
openbox:
Installed: (none)
lxpanel:
Installed: (none)
pcmanfm:
Installed: (none)
rpd-plym-splash:
Installed: (none)
Networking Information
----------------------
lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536
inet x.x.x.x netmask x.x.x.x
inet6 ::1 prefixlen 128 scopeid 0x10<host>
loop txqueuelen 1000 (Local Loopback)
RX packets 0 bytes 0 (0.0 B)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 0 bytes 0 (0.0 B)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
usb0: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500
inet x.x.x.x netmask x.x.x.x broadcast x.x.x.x
inet6 y::y.y.y.y prefixlen 64 scopeid 0x20<link>
ether m.m.m.m txqueuelen 1000 (Ethernet)
RX packets 176631 bytes 190785402 (181.9 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 65111 bytes 19274294 (18.3 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
usb0.10: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1496
inet x.x.x.x netmask x.x.x.x broadcast x.x.x.x
inet6 y::y.y.y.y prefixlen 64 scopeid 0x20<link>
ether m.m.m.m txqueuelen 1000 (Ethernet)
RX packets 172639 bytes 189693275 (180.9 MiB)
RX errors 0 dropped 0 overruns 0 frame 0
TX packets 62562 bytes 15433120 (14.7 MiB)
TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0
USB Information
---------------
config.txt
----------
aphy_params_current=547
arm_freq=1000
audio_pwm_mode=514
config_hdmi_boost=5
core_freq=400
disable_auto_turbo=1
disable_commandline_tags=2
display_hdmi_rotate=-1
display_lcd_rotate=-1
dphy_params_current=547
enable_uart=1
force_eeprom_read=1
force_pwm_open=1
framebuffer_ignore_alpha=1
framebuffer_swap=1
gpu_freq=300
ignore_lcd=1
init_uart_clock=0x2dc6c00
over_voltage_avs=0x249f0
pause_burst_frames=1
program_serial_random=1
ramfsaddr=-1
sdram_freq=450
hdmi_force_cec_address:0=65535
hdmi_force_cec_address:1=65535
hdmi_pixel_freq_limit:0=0x9a7ec80
hdmi_pixel_freq_limit:1=0x9a7ec80
device_tree=-
ramfsfile=initramfs.img
hdmi_cvt:0=
hdmi_cvt:1=
hdmi_edid_filename:0=
hdmi_edid_filename:1=
hdmi_timings:0=
hdmi_timings:1=
cmdline.txt
-----------
coherent_pool=1M bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:D3:96:41 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 console=tty1 root=/dev/nfs nfsroot=172.19.180.254:/var/lib/clusterctrl/nfs/p1 rw ip=172.19.180.1:172.19.180.254::255.255.255.0:p1:usb0.10:static elevator=deadline fsck.mode=skip rootwait quiet
raspi-gpio settings
-------------------
./raspinfo: line 97: raspi-gpio: command not found
vcdbg log messages
------------------
013726.466: brfs: File read: /mfs/sd/config.txt
013727.457: brfs: File read: 1987 bytes
013739.563: HDMI:EDID error reading EDID block 0 attempt 0
013740.865: HDMI:EDID error reading EDID block 0 attempt 1
013742.158: HDMI:EDID error reading EDID block 0 attempt 2
013743.454: HDMI:EDID error reading EDID block 0 attempt 3
013744.746: HDMI:EDID error reading EDID block 0 attempt 4
013746.042: HDMI:EDID error reading EDID block 0 attempt 5
013747.334: HDMI:EDID error reading EDID block 0 attempt 6
013748.630: HDMI:EDID error reading EDID block 0 attempt 7
013749.922: HDMI:EDID error reading EDID block 0 attempt 8
013751.217: HDMI:EDID error reading EDID block 0 attempt 9
013752.274: HDMI:EDID giving up on reading EDID block 0
013752.633: HDMI:EDID error reading EDID block 0 attempt 0
013753.932: HDMI:EDID error reading EDID block 0 attempt 1
013755.230: HDMI:EDID error reading EDID block 0 attempt 2
013756.528: HDMI:EDID error reading EDID block 0 attempt 3
013757.827: HDMI:EDID error reading EDID block 0 attempt 4
013759.125: HDMI:EDID error reading EDID block 0 attempt 5
013760.424: HDMI:EDID error reading EDID block 0 attempt 6
013761.723: HDMI:EDID error reading EDID block 0 attempt 7
013763.022: HDMI:EDID error reading EDID block 0 attempt 8
013764.320: HDMI:EDID error reading EDID block 0 attempt 9
013765.382: HDMI:EDID giving up on reading EDID block 0
013788.701: brfs: File read: /mfs/sd/config.txt
013789.582: gpioman: gpioman_get_pin_num: pin LEDS_PWR_OK not defined
013799.533: gpioman: gpioman_get_pin_num: pin WL_LPO_CLK not defined
013799.599: gpioman: gpioman_get_pin_num: pin BT_ON not defined
013799.656: gpioman: gpioman_get_pin_num: pin WL_ON not defined
013821.946: gpioman: gpioman_get_pin_num: pin LEDS_PWR_OK not defined
013822.037: *** Restart logging
013822.102: brfs: File read: 1987 bytes
013824.705: hdmi: HDMI:EDID error reading EDID block 0 attempt 0
013826.014: hdmi: HDMI:EDID error reading EDID block 0 attempt 1
013827.317: hdmi: HDMI:EDID error reading EDID block 0 attempt 2
013828.620: hdmi: HDMI:EDID error reading EDID block 0 attempt 3
013829.925: hdmi: HDMI:EDID error reading EDID block 0 attempt 4
013831.228: hdmi: HDMI:EDID error reading EDID block 0 attempt 5
013832.531: hdmi: HDMI:EDID error reading EDID block 0 attempt 6
013833.835: hdmi: HDMI:EDID error reading EDID block 0 attempt 7
013835.138: hdmi: HDMI:EDID error reading EDID block 0 attempt 8
013836.441: hdmi: HDMI:EDID error reading EDID block 0 attempt 9
013837.508: hdmi: HDMI:EDID giving up on reading EDID block 0
013837.883: hdmi: HDMI:EDID error reading EDID block 0 attempt 0
013839.183: hdmi: HDMI:EDID error reading EDID block 0 attempt 1
013840.482: hdmi: HDMI:EDID error reading EDID block 0 attempt 2
013841.781: hdmi: HDMI:EDID error reading EDID block 0 attempt 3
013843.080: hdmi: HDMI:EDID error reading EDID block 0 attempt 4
013844.380: hdmi: HDMI:EDID error reading EDID block 0 attempt 5
013845.679: hdmi: HDMI:EDID error reading EDID block 0 attempt 6
013846.979: hdmi: HDMI:EDID error reading EDID block 0 attempt 7
013848.279: hdmi: HDMI:EDID error reading EDID block 0 attempt 8
013849.579: hdmi: HDMI:EDID error reading EDID block 0 attempt 9
013850.641: hdmi: HDMI:EDID giving up on reading EDID block 0
013850.726: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
013850.799: hdmi: HDMI:hdmi_get_state is deprecated, use hdmi_get_display_state instead
013857.459: brfs: File read: /mfs/sd/cmdline.txt
013857.553: Read command line from file 'cmdline.txt':
013857.624: 'dwc_otg.lpm_enable=0 console=serial0,115200 console=tty1 root=/dev/nfs nfsroot=172.19.180.254:/var/lib/clusterctrl/nfs/p1 rw ip=172.19.180.1:172.19.180.254::255.255.255.0:p1:usb0.10:static elevator=deadline fsck.mode=skip rootwait quiet'
013857.970: brfs: File read: 237 bytes
018801.372: brfs: File read: /mfs/sd/kernel.img
018801.437: Loading 'kernel.img' to 0x8000 size 0x4c8e10
018801.509: brfs: File read: 5017104 bytes
024031.965: brfs: File read: /mfs/sd/initramfs.img
024032.024: Loading 'initramfs.img' to 0x4d0e10 size 0x520d30
024358.277: No kernel trailer - assuming DT-capable
024358.372: brfs: File read: 5377328 bytes
024390.304: brfs: File read: /mfs/sd/bcm2708-rpi-zero.dtb
024390.365: Loading 'bcm2708-rpi-zero.dtb' to 0x4d0e10 size 0x5c77
024479.543: brfs: File read: 23671 bytes
024488.653: brfs: File read: /mfs/sd/config.txt
024489.003: dtparam: i2c_arm=on
024500.012: dtparam: audio=on
024512.926: brfs: File read: 1987 bytes
024520.790: brfs: File read: /mfs/sd/overlays/dwc2.dtbo
024529.417: Loaded overlay 'dwc2'
024529.471: dtparam: dr_mode=peripheral
026485.954: gpioman: gpioman_get_pin_num: pin EMMC_ENABLE not defined
026512.341: Device tree loaded to 0x1bac8e00 (size 0x6194)
032018.812: vchiq_core: vchiq_init_state: slot_zero = 0x5b180000, is_master = 1
077861.864: brfs: File read: 801 bytes
dmesg log
---------
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Linux version 4.19.57+ (dom@buildbot) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611)) #1244 Thu Jul 4 18:42:50 BST 2019
[ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
[ 0.000000] OF: fdt: Machine model: Raspberry Pi Zero Rev 1.3
[ 0.000000] Memory policy: Data cache writeback
[ 0.000000] cma: Reserved 8 MiB at 0x1b000000
[ 0.000000] On node 0 totalpages: 114688
[ 0.000000] Normal zone: 1008 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 114688 pages, LIFO batch:31
[ 0.000000] random: get_random_bytes called from start_kernel+0x8c/0x49c with crng_init=0
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 113680
[ 0.000000] Kernel command line: coherent_pool=1M bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 smsc95xx.macaddr=m.m.m.m vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 console=tty1 root=/dev/nfs nfsroot=172.19.180.254:/var/lib/clusterctrl/nfs/p1 rw ip=172.19.180.1:172.19.180.y::y.y.y.y.255.255.0:p1:usb0.10:static elevator=deadline fsck.mode=skip rootwait quiet
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Memory: 429196K/458752K available (6954K kernel code, 635K rwdata, 2076K rodata, 464K init, 797K bss, 21364K reserved, 8192K cma-reserved)
[ 0.000000] Virtual kernel memory layout:
vector : 0xffff0000 - 0xffff1000 ( 4 kB)
fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
vmalloc : 0xdc800000 - 0xff800000 ( 560 MB)
lowmem : 0xc0000000 - 0xdc000000 ( 448 MB)
modules : 0xbf000000 - 0xc0000000 ( 16 MB)
.text : 0x(ptrval) - 0x(ptrval) (6955 kB)
.init : 0x(ptrval) - 0x(ptrval) ( 464 kB)
.data : 0x(ptrval) - 0x(ptrval) ( 636 kB)
.bss : 0x(ptrval) - 0x(ptrval) ( 798 kB)
[ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] ftrace: allocating 25148 entries in 74 pages
[ 0.000000] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 0.000032] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
[ 0.000078] clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
[ 0.000194] bcm2835: system timer (irq = 27)
[ 0.000608] Console: colour dummy device 80x30
[ 0.000636] console [tty1] enabled
[ 0.000699] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
[ 0.060344] pid_max: default: 32768 minimum: 301
[ 0.060897] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.060919] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.062358] CPU: Testing write buffer coherency: ok
[ 0.063693] Setting up static identity map for 0x8200 - 0x8238
[ 0.065110] devtmpfs: initialized
[ 0.076340] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[ 0.076763] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.076793] futex hash table entries: 256 (order: -1, 3072 bytes)
[ 0.078145] pinctrl core: initialized pinctrl subsystem
[ 0.079723] NET: Registered protocol family 16
[ 0.083008] DMA: preallocated 1024 KiB pool for atomic coherent allocations
[ 0.090831] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[ 0.090848] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 0.090998] Serial: AMBA PL011 UART driver
[ 0.094264] bcm2835-mbox 2000b880.mailbox: mailbox enabled
[ 0.139865] bcm2835-dma 20007000.dma: DMA legacy API manager at (ptrval), dmachans=0x1
[ 0.142580] SCSI subsystem initialized
[ 0.142857] usbcore: registered new interface driver usbfs
[ 0.142979] usbcore: registered new interface driver hub
[ 0.143211] usbcore: registered new device driver usb
[ 0.160969] raspberrypi-firmware soc:firmware: Attached to firmware from 2019-07-09 14:40, variant start
[ 0.170992] raspberrypi-firmware soc:firmware: Firmware hash is 6c3fe3f096a93de3b34252ad98cdccadeb534be2
[ 0.183459] clocksource: Switched to clocksource timer
[ 0.287592] VFS: Disk quotas dquot_6.6.0
[ 0.287726] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.288052] FS-Cache: Loaded
[ 0.288396] CacheFiles: Loaded
[ 0.308316] NET: Registered protocol family 2
[ 0.309653] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 4096 bytes)
[ 0.309720] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.309802] TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.309897] TCP: Hash tables configured (established 4096 bind 4096)
[ 0.310066] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 0.310101] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 0.310499] NET: Registered protocol family 1
[ 0.311598] RPC: Registered named UNIX socket transport module.
[ 0.311611] RPC: Registered udp transport module.
[ 0.311616] RPC: Registered tcp transport module.
[ 0.311622] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.312050] Trying to unpack rootfs image as initramfs...
[ 2.513537] random: fast init done
[ 4.536402] Freeing initrd memory: 5252K
[ 4.563737] hw perfevents: no irqs for PMU, sampling events not supported
[ 4.563807] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
[ 4.568177] Initialise system trusted keyrings
[ 4.568654] workingset: timestamp_bits=14 max_order=17 bucket_order=3
[ 4.584326] FS-Cache: Netfs 'nfs' registered for caching
[ 4.585634] NFS: Registering the id_resolver key type
[ 4.585684] Key type id_resolver registered
[ 4.585693] Key type id_legacy registered
[ 4.585720] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
[ 4.591399] Key type asymmetric registered
[ 4.591418] Asymmetric key parser 'x509' registered
[ 4.591530] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
[ 4.591992] io scheduler noop registered
[ 4.592008] io scheduler deadline registered (default)
[ 4.592615] io scheduler cfq registered
[ 4.592632] io scheduler mq-deadline registered (default)
[ 4.592640] io scheduler kyber registered
[ 4.595503] bcm2708_fb soc:fb: FB found 1 display(s)
[ 4.604806] Console: switching to colour frame buffer device 82x26
[ 4.609542] bcm2708_fb soc:fb: Registered framebuffer for display 0, size 656x416
[ 4.613323] bcm2835-rng 20104000.rng: hwrng registered
[ 4.613889] vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB)
[ 4.615053] vc-sm: Videocore shared memory driver
[ 4.615731] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
[ 4.637058] brd: module loaded
[ 4.651048] loop: module loaded
[ 4.651954] Loading iSCSI transport class v2.0-870.
[ 4.652933] usbcore: registered new interface driver smsc95xx
[ 4.652965] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
[ 4.653162] dwc_otg: FIQ enabled
[ 4.653174] dwc_otg: NAK holdoff enabled
[ 4.653180] dwc_otg: FIQ split-transaction FSM enabled
[ 4.653197] Module dwc_common_port init
[ 4.653797] usbcore: registered new interface driver usb-storage
[ 4.654257] mousedev: PS/2 mouse device common for all mice
[ 4.655697] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
[ 4.656179] bcm2835-cpufreq: min=700000 max=1000000
[ 4.656955] sdhci: Secure Digital Host Controller Interface driver
[ 4.656966] sdhci: Copyright(c) Pierre Ossman
[ 4.657630] sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
[ 4.657894] sdhci-pltfm: SDHCI platform and OF driver helper
[ 4.658544] ledtrig-cpu: registered to indicate activity on CPUs
[ 4.658690] hidraw: raw HID events driver (C) Jiri Kosina
[ 4.658966] usbcore: registered new interface driver usbhid
[ 4.658976] usbhid: USB HID core driver
[ 4.660083] vchiq: vchiq_init_state: slot_zero = (ptrval), is_master = 0
[ 4.662224] [vc_sm_connected_init]: start
[ 4.671813] [vc_sm_connected_init]: end - returning 0
[ 4.673761] Initializing XFRM netlink socket
[ 4.673842] NET: Registered protocol family 17
[ 4.674016] Key type dns_resolver registered
[ 4.676008] registered taskstats version 1
[ 4.676040] Loading compiled-in X.509 certificates
[ 4.686742] uart-pl011 20201000.serial: cts_event_workaround enabled
[ 4.686904] 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
[ 4.687002] console [ttyAMA0] enabled
[ 4.690450] sdhost: log_buf @ (ptrval) (5b110000)
[ 4.737889] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
[ 4.739608] of_cfs_init
[ 4.739778] of_cfs_init: OK
[ 17.081188] random: crng init done
[ 17.208082] Freeing unused kernel memory: 464K
[ 17.208095] This architecture does not have kernel memory protection.
[ 17.208102] Run /init as init process
[ 19.327710] dwc2 20980000.usb: 20980000.usb supply vusb_d not found, using dummy regulator
[ 19.327875] dwc2 20980000.usb: Linked as a consumer to regulator.0
[ 19.327904] dwc2 20980000.usb: 20980000.usb supply vusb_a not found, using dummy regulator
[ 19.431060] dwc2 20980000.usb: dwc2_check_params: Invalid parameter lpm=1
[ 19.431082] dwc2 20980000.usb: dwc2_check_params: Invalid parameter lpm_clock_gating=1
[ 19.431095] dwc2 20980000.usb: dwc2_check_params: Invalid parameter besl=1
[ 19.431107] dwc2 20980000.usb: dwc2_check_params: Invalid parameter hird_threshold_en=1
[ 19.431148] dwc2 20980000.usb: EPs: 8, dedicated fifos, 4080 entries in SPRAM
[ 20.410785] 8021q: 802.1Q VLAN Support v1.8
[ 20.809450] NET: Registered protocol family 10
[ 20.816390] Segment Routing with IPv6
[ 21.050196] using random self ethernet address
[ 21.050217] using random host ethernet address
[ 21.214940] usb0: HOST MAC m.m.m.m
[ 21.215163] usb0: MAC m.m.m.m
[ 21.215298] dwc2 20980000.usb: bound driver configfs-gadget
[ 21.303002] IPv6: ADDRCONF(NETDEV_UP): usb0.10: link is not ready
[ 21.303204] IPv6: ADDRCONF(NETDEV_UP): usb0: link is not ready
[ 22.982921] dwc2 20980000.usb: new device is high-speed
[ 23.082921] dwc2 20980000.usb: new device is high-speed
[ 23.171856] dwc2 20980000.usb: new address 5
[ 23.208374] configfs-gadget gadget: high-speed config #1: c
[ 23.209028] IPv6: ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready
[ 23.209769] IPv6: ADDRCONF(NETDEV_CHANGE): usb0.10: link becomes ready
[ 26.835544] systemd[1]: System time before build time, advancing clock.
[ 27.084289] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[ 27.085524] systemd[1]: Detected architecture arm.
[ 27.118586] systemd[1]: Set hostname to <p1>.
[ 27.125678] systemd[1]: Failed to bump fs.file-max, ignoring: Invalid argument
[ 29.333614] uart-pl011 20201000.serial: no DMA platform data
[ 29.754900] systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
[ 29.754953] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[ 30.874505] systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly.
[ 31.451980] systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
[ 31.453089] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 31.457425] systemd[1]: Listening on Journal Socket (/dev/log).
[ 32.295067] systemd[1]: Mounting Kernel Debug File System...
[ 32.480488] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 32.482911] systemd[1]: Listening on udev Control Socket.
[ 32.526521] systemd[1]: Reached target Local Encrypted Volumes.
[ 32.809059] systemd[1]: Starting Restore / save the current clock...
[ 32.925193] i2c /dev entries driver
[ 32.930751] systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
[ 33.007655] systemd[1]: Starting udev Coldplug all Devices...
[ 33.198698] systemd[1]: Mounting POSIX Message Queue File System...
[ 33.257133] systemd[1]: Condition check resulted in Kernel Module supporting RPCSEC_GSS being skipped.
[ 33.422233] systemd[1]: Mounted RPC Pipe File System.
[ 36.104749] systemd-journald[175]: Received request to flush runtime journal from PID 1
[ 46.030134] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[ 48.108497] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[ 49.318050] vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned.
[ 49.320284] bcm2835_vc_sm_cma_probe: Videocore shared memory driver
[ 49.320302] [vc_sm_connected_init]: start
[ 49.441418] [vc_sm_connected_init]: installed successfully
[ 49.665806] media: Linux media interface: v0.10
[ 50.030158] videodev: Linux video capture interface: v2.00
[ 50.339671] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
[ 50.466772] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
[ 50.588981] bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
[ 50.637286] bcm2835-codec bcm2835-codec: Device registered as /dev/video10
[ 50.637306] bcm2835-codec bcm2835-codec: Loaded V4L2 decode
[ 50.674306] bcm2835-codec bcm2835-codec: Device registered as /dev/video11
[ 50.674322] bcm2835-codec bcm2835-codec: Loaded V4L2 encode
[ 50.720688] bcm2835-codec bcm2835-codec: Device registered as /dev/video12
[ 50.720704] bcm2835-codec bcm2835-codec: Loaded V4L2 isp
[ 51.130667] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
[ 51.297756] bcm2835_audio soc:audio: card created with 8 channels
[33806.721055] mmc0: timeout waiting for hardware interrupt.
[33806.721077] [20a8b81d] TSK< d8e69e08 0
[33806.721083] [20a8b828] TSK> d8e69e08 0
[33806.721089] [20a8b83f] REQ< d8e69e08 10800
[33806.721094] [20a8b840] CMD< 34 80000c08
[33806.721099] [20a8b844] FCM< d8e69e08 d8e69e68
[33806.721104] [20a8c226] CMD 34 0
[33806.721109] [20a8c226] REQ> d8e69e08 0
[33806.721114] [20a8c234] TSK< d8e69e08 0
[33806.721120] [20a8c23d] TSK> d8e69e08 0
[33806.721124] [20a8c24e] IOS< 61a80 0
[33806.721130] [20a8c990] REQ< d8e69e30 10800
[33806.721135] [20a8c991] CMD< 0 0
[33806.721140] [20a8c997] FCM< d8e69e30 d8e69e90
[33806.721145] [20a8ca39] FCM> d8e69e30 0
[33806.721150] [20a8ca3a] CMD 0 0
[33806.721155] [20a8ca3a] REQ> d8e69e30 0
[33806.721160] [20a8ca49] TSK< d8e69e30 0
[33806.721165] [20a8ca50] TSK> d8e69e30 0
[33806.721170] [20a8cf6c] IOS< 61a80 0
[33806.721175] [20a8d47e] REQ< d8e69e30 10800
[33806.721180] [20a8d47f] CMD< 8 1aa
[33806.721185] [20a8d484] FCM< d8e69e30 d8e69e90
[33806.721189] [20a8d78c] CMD 8 0
[33806.721194] [20a8d78d] REQ> d8e69e30 0
[33806.721200] [20a8d79b] TSK< d8e69e30 0
[33806.721205] [20a8d7a2] TSK> d8e69e30 0
[33806.721210] [20a8d7b7] REQ< d8e69dd8 10800
[33806.721215] [20a8d7b8] CMD< 5 0
[33806.721220] [20a8d7bc] FCM< d8e69dd8 d8e69e38
[33806.721225] [20a8daf9] CMD 5 0
[33806.721230] [20a8daf9] REQ> d8e69dd8 0
[33806.721235] [20a8db08] TSK< d8e69dd8 0
[33806.721240] [20a8db0c] TSK> d8e69dd8 0
[33806.721245] [20a8db1d] REQ< d8e69dd8 10800
[33806.721250] [20a8db1e] CMD< 5 0
[33806.721255] [20a8db22] FCM< d8e69dd8 d8e69e38
[33806.721260] [20a8de2f] CMD 5 0
[33806.721265] [20a8de30] REQ> d8e69dd8 0
[33806.721270] [20a8de3b] TSK< d8e69dd8 0
[33806.721275] [20a8de40] TSK> d8e69dd8 0
[33806.721280] [20a8de4f] REQ< d8e69dd8 10800
[33806.721285] [20a8de50] CMD< 5 0
[33806.721290] [20a8de54] FCM< d8e69dd8 d8e69e38
[33806.721295] [20a8e160] CMD 5 0
[33806.721300] [20a8e160] REQ> d8e69dd8 0
[33806.721305] [20a8e16b] TSK< d8e69dd8 0
[33806.721310] [20a8e170] TSK> d8e69dd8 0
[33806.721315] [20a8e17e] REQ< d8e69dd8 10800
[33806.721319] [20a8e17f] CMD< 5 0
[33806.721325] [20a8e184] FCM< d8e69dd8 d8e69e38
[33806.721330] [20a8e4a4] CMD 5 0
[33806.721335] [20a8e4a5] REQ> d8e69dd8 0
[33806.721340] [20a8e4b1] TSK< d8e69dd8 0
[33806.721345] [20a8e4b9] TSK> d8e69dd8 0
[33806.721350] [20a8e4d4] REQ< d8e69d38 10800
[33806.721355] [20a8e4d5] CMD< 37 0
[33806.721360] [20a8e4d9] FCM< d8e69d38 d8e69d98
[33806.721365] [20a8e7e4] CMD 37 0
[33806.721370] [20a8e7e4] REQ> d8e69d38 0
[33806.721375] [20a8e7f0] TSK< d8e69d38 0
[33806.721380] [20a8e7f9] TSK> d8e69d38 0
[33806.721385] [20a8e80c] REQ< d8e69d38 10800
[33806.721391] [20a8e80d] CMD< 37 0
[33806.721396] [20a8e811] FCM< d8e69d38 d8e69d98
[33806.721401] [20a8eb11] CMD 37 0
[33806.721406] [20a8eb11] REQ> d8e69d38 0
[33806.721411] [20a8eb1e] TSK< d8e69d38 0
[33806.721416] [20a8eb26] TSK> d8e69d38 0
[33806.721421] [20a8eb3b] REQ< d8e69d38 10800
[33806.721426] [20a8eb3c] CMD< 37 0
[33806.721431] [20a8eb41] FCM< d8e69d38 d8e69d98
[33806.721436] [20a8ee73] CMD 37 0
[33806.721441] [20a8ee73] REQ> d8e69d38 0
[33806.721446] [20a8ee7f] TSK< d8e69d38 0
[33806.721451] [20a8ee87] TSK> d8e69d38 0
[33806.721457] [20a8ee9a] REQ< d8e69d38 10800
[33806.721461] [20a8ee9b] CMD< 37 0
[33806.721467] [20a8ee9f] FCM< d8e69d38 d8e69d98
[33806.721471] [20a8f1cc] CMD 37 0
[33806.721476] [20a8f1cd] REQ> d8e69d38 0
[33806.721481] [20a8f1d8] TSK< d8e69d38 0
[33806.721486] [20a8f1e0] TSK> d8e69d38 0
[33806.721491] [20a8f1f0] IOS< 61a80 0
[33806.721496] [20a8f1f8] REQ< d8e69e00 10800
[33806.721501] [20a8f1f9] CMD< 1 0
[33806.721506] [20a8f1fd] FCM< d8e69e00 d8e69e60
[33806.721511] [20a8f531] CMD 1 0
[33806.721516] [20a8f531] REQ> d8e69e00 0
[33806.721521] [20a8f53d] TSK< d8e69e00 0
[33806.721526] [20a8f545] TSK> d8e69e00 0
[33806.721531] [20a8f556] IOS< 0 0
[33806.721536] [20a8fc80] IOS< 0 0
[33806.721540] [20a92fa3] IOS< 493e0 0
[33806.721545] [20a962d2] RST< 0 0
[33806.721550] [20a9b102] REQ< d8e69e08 10800
[33806.721555] [20a9b104] CMD< 34 c00
[33806.721560] [20a9b10a] FCM< d8e69e08 d8e69e68
[33806.721565] [20a9bb03] CMD 34 0
[33806.721570] [20a9bb03] REQ> d8e69e08 0
[33806.721575] [20a9bb14] TSK< d8e69e08 0
[33806.721581] [20a9bb1e] TSK> d8e69e08 0
[33806.721586] [20a9bb36] REQ< d8e69e08 10800
[33806.721591] [20a9bb37] CMD< 34 80000c08
[33806.721596] [20a9bb3d] FCM< d8e69e08 d8e69e68
[33806.721601] [20a9c531] CMD 34 0
[33806.721606] [20a9c532] REQ> d8e69e08 0
[33806.721611] [20a9c53f] TSK< d8e69e08 0
[33806.721616] [20a9c547] TSK> d8e69e08 0
[33806.721621] [20a9c558] IOS< 493e0 0
[33806.721626] [20a9ccad] REQ< d8e69e30 10800
[33806.721630] [20a9ccae] CMD< 0 0
[33806.721635] [20a9ccb5] FCM< d8e69e30 d8e69e90
[33806.721640] [20a9cd93] FCM> d8e69e30 0
[33806.721646] [20a9cd94] CMD 0 0
[33806.721651] [20a9cd94] REQ> d8e69e30 0
[33806.721655] [20a9cda4] TSK< d8e69e30 0
[33806.721660] [20a9cdac] TSK> d8e69e30 0
[33806.721665] [20a9d2db] IOS< 493e0 0
[33806.721670] [20a9d7ee] REQ< d8e69e30 10800
[33806.721675] [20a9d7f0] CMD< 8 1aa
[33806.721680] [20a9d7f4] FCM< d8e69e30 d8e69e90
[33806.721685] [20a9dc14] CMD 8 0
[33806.721690] [20a9dc15] REQ> d8e69e30 0
[33806.721695] [20a9dc22] TSK< d8e69e30 0
[33806.721700] [20a9dc2a] TSK> d8e69e30 0
[33806.721705] [20a9dc3e] REQ< d8e69dd8 10800
[33806.721710] [20a9dc3f] CMD< 5 0
[33806.721716] [20a9dc45] FCM< d8e69dd8 d8e69e38
[33806.721720] [20a9e060] CMD 5 0
[33806.721725] [20a9e061] REQ> d8e69dd8 0
[33806.721730] [20a9e06d] TSK< d8e69dd8 0
[33806.721735] [20a9e072] TSK> d8e69dd8 0
[33806.721740] [20a9e081] REQ< d8e69dd8 10800
[33806.721745] [20a9e081] CMD< 5 0
[33806.721750] [20a9e086] FCM< d8e69dd8 d8e69e38
[33806.721755] [20a9e4a6] CMD 5 0
[33806.721760] [20a9e4a6] REQ> d8e69dd8 0
[33806.721765] [20a9e4b2] TSK< d8e69dd8 0
[33806.721770] [20a9e4b9] TSK> d8e69dd8 0
[33806.721775] [20a9e4c7] REQ< d8e69dd8 10800
[33806.721780] [20a9e4c8] CMD< 5 0
[33806.721785] [20a9e4cc] FCM< d8e69dd8 d8e69e38
[33806.721790] [20a9e8f0] CMD 5 0
[33806.721795] [20a9e8f1] REQ> d8e69dd8 0
[33806.721800] [20a9e8fd] TSK< d8e69dd8 0
[33806.721805] [20a9e901] TSK> d8e69dd8 0
[33806.721810] [20a9e910] REQ< d8e69dd8 10800
[33806.721815] [20a9e910] CMD< 5 0
[33806.721820] [20a9e914] FCM< d8e69dd8 d8e69e38
[33806.721825] [20a9ed30] CMD 5 0
[33806.721830] [20a9ed30] REQ> d8e69dd8 0
[33806.721836] [20a9ed3c] TSK< d8e69dd8 0
[33806.721841] [20a9ed44] TSK> d8e69dd8 0
[33806.721846] [20a9ed5b] REQ< d8e69d38 10800
[33806.721851] [20a9ed5b] CMD< 37 0
[33806.721856] [20a9ed60] FCM< d8e69d38 d8e69d98
[33806.721861] [20a9f1a1] CMD 37 0
[33806.721866] [20a9f1a1] REQ> d8e69d38 0
[33806.721871] [20a9f1af] TSK< d8e69d38 0
[33806.721876] [20a9f1b7] TSK> d8e69d38 0
[33806.721881] [20a9f1ca] REQ< d8e69d38 10800
[33806.721886] [20a9f1cb] CMD< 37 0
[33806.721891] [20a9f1d0] FCM< d8e69d38 d8e69d98
[33806.721896] [20a9f5f6] CMD 37 0
[33806.721901] [20a9f5f7] REQ> d8e69d38 0
[33806.721906] [20a9f604] TSK< d8e69d38 0
[33806.721911] [20a9f60c] TSK> d8e69d38 0
[33806.721916] [20a9f61f] REQ< d8e69d38 10800
[33806.721921] [20a9f620] CMD< 37 0
[33806.721926] [20a9f625] FCM< d8e69d38 d8e69d98
[33806.721931] [20a9fa31] CMD 37 0
[33806.721936] [20a9fa31] REQ> d8e69d38 0
[33806.721941] [20a9fa3d] TSK< d8e69d38 0
[33806.721946] [20a9fa45] TSK> d8e69d38 0
[33806.721951] [20a9fa58] REQ< d8e69d38 10800
[33806.721956] [20a9fa59] CMD< 37 0
[33806.721961] [20a9fa5d] FCM< d8e69d38 d8e69d98
[33806.721966] [20a9fe6b] CMD 37 0
[33806.721971] [20a9fe6c] REQ> d8e69d38 0
[33806.721976] [20a9fe78] TSK< d8e69d38 0
[33806.721981] [20a9fe7f] TSK> d8e69d38 0
[33806.721986] [20a9fe91] IOS< 493e0 0
[33806.721991] [20a9fe99] REQ< d8e69e00 10800
[33806.721996] [20a9fe9a] CMD< 1 0
[33806.722001] [20a9fe9f] FCM< d8e69e00 d8e69e60
[33806.722005] [20aa02b8] CMD 1 0
[33806.722010] [20aa02b8] REQ> d8e69e00 0
[33806.722015] [20aa02c7] TSK< d8e69e00 0
[33806.722020] [20aa02cf] TSK> d8e69e00 0
[33806.722025] [20aa02e0] IOS< 0 0
[33806.722030] [20aa0a14] IOS< 0 0
[33806.722035] [20aa3d2c] IOS< 30d40 0
[33806.722040] [20aa703c] RST< 0 0
[33806.722045] [20aabe61] REQ< d8e69e08 10800
[33806.722050] [20aabe62] CMD< 34 c00
[33806.722055] [20aabe69] FCM< d8e69e08 d8e69e68
[33806.722060] [20aac858] CMD 34 0
[33806.722065] [20aac858] REQ> d8e69e08 0
[33806.722070] [20aac86a] TSK< d8e69e08 0
[33806.722075] [20aac872] TSK> d8e69e08 0
[33806.722080] [20aac887] REQ< d8e69e08 10800
[33806.722085] [20aac888] CMD< 34 80000c08
[33806.722090] [20aac88c] FCM< d8e69e08 d8e69e68
[33806.722095] [20aad26b] CMD 34 0
[33806.722100] [20aad26c] REQ> d8e69e08 0
[33806.722105] [20aad279] TSK< d8e69e08 0
[33806.722110] [20aad281] TSK> d8e69e08 0
[33806.722115] [20aad294] IOS< 30d40 0
[33806.722120] [20aad9d0] REQ< d8e69e30 10800
[33806.722125] [20aad9d1] CMD< 0 0
[33806.722130] [20aad9d7] FCM< d8e69e30 d8e69e90
[33806.722135] [20aadb27] FCM> d8e69e30 0
[33806.722140] [20aadb28] CMD 0 0
[33806.722144] [20aadb28] REQ> d8e69e30 0
[33806.722149] [20aadb37] TSK< d8e69e30 0
[33806.722154] [20aadb40] TSK> d8e69e30 0
[33806.722159] [20aae06b] IOS< 30d40 0
[33806.722164] [20aae57d] REQ< d8e69e30 10800
[33806.722169] [20aae57e] CMD< 8 1aa
[33806.722174] [20aae582] FCM< d8e69e30 d8e69e90
[33806.722179] [20aaeb9e] CMD 8 0
[33806.722184] [20aaeb9f] REQ> d8e69e30 0
[33806.722189] [20aaebab] TSK< d8e69e30 0
[33806.722194] [20aaebb3] TSK> d8e69e30 0
[33806.722199] [20aaebc9] REQ< d8e69dd8 10800
[33806.722204] [20aaebca] CMD< 5 0
[33806.722209] [20aaebce] FCM< d8e69dd8 d8e69e38
[33806.722214] [20aaf1e9] CMD 5 0
[33806.722219] [20aaf1ea] REQ> d8e69dd8 0
[33806.722224] [20aaf1f6] TSK< d8e69dd8 0
[33806.722229] [20aaf1fb] TSK> d8e69dd8 0
[33806.722235] [20aaf208] REQ< d8e69dd8 10800
[33806.722239] [20aaf209] CMD< 5 0
[33806.722244] [20aaf20d] FCM< d8e69dd8 d8e69e38
[33806.722249] [20aaf81b] CMD 5 0
[33806.722254] [20aaf81c] REQ> d8e69dd8 0
[33806.722259] [20aaf828] TSK< d8e69dd8 0
[33806.722264] [20aaf82c] TSK> d8e69dd8 0
[33806.722269] [20aaf83a] REQ< d8e69dd8 10800
[33806.722274] [20aaf83b] CMD< 5 0
[33806.722279] [20aaf83f] FCM< d8e69dd8 d8e69e38
[33806.722284] [20aafe46] CMD 5 0
[33806.722289] [20aafe47] REQ> d8e69dd8 0
[33806.722294] [20aafe53] TSK< d8e69dd8 0
[33806.722299] [20aafe57] TSK> d8e69dd8 0
[33806.722304] [20aafe65] REQ< d8e69dd8 10800
[33806.722309] [20aafe66] CMD< 5 0
[33806.722314] [20aafe6a] FCM< d8e69dd8 d8e69e38
[33806.722319] [20ab0477] CMD 5 0
[33806.722324] [20ab0477] REQ> d8e69dd8 0
[33806.722329] [20ab0484] TSK< d8e69dd8 0
[33806.722333] [20ab048c] TSK> d8e69dd8 0
[33806.722339] [20ab04a3] REQ< d8e69d38 10800
[33806.722344] [20ab04a4] CMD< 37 0
[33806.722349] [20ab04a8] FCM< d8e69d38 d8e69d98
[33806.722354] [20ab1101] TIM< 0 0
[33806.722366] mmc0:>cmd op 55 arg 0x0 flags 0xf5 - resp 00000000 00000000 00000000 00000000, err 0
[33806.722370] mmc0: =========== REGISTER DUMP ===========
[33806.722374] mmc0: SDCMD 0x00004037
[33806.722378] mmc0: SDARG 0x00000000
[33806.722381] mmc0: SDTOUT 0x000186a0
[33806.722385] mmc0: SDCDIV 0x000007ce
[33806.722389] mmc0: SDRSP0 0xffffffff
[33806.722393] mmc0: SDRSP1 0x0000ff7f
[33806.722397] mmc0: SDRSP2 0xffffffff
[33806.722400] mmc0: SDRSP3 0xffffffff
[33806.722404] mmc0: SDHSTS 0x00000040
[33806.722408] mmc0: SDVDD 0x00000001
[33806.722412] mmc0: SDEDM 0x00010800
[33806.722416] mmc0: SDHCFG 0x0000040a
[33806.722420] mmc0: SDHBCT 0x00000000
[33806.722423] mmc0: SDHBLC 0x00000000
[33806.722426] mmc0: ===========================================
[33806.744033] Unable to handle kernel NULL pointer dereference at virtual address 00000020
[33806.755125] pgd = f73844ad
[33806.759242] [00000020] *pgd=00000000
[33806.764235] Internal error: Oops: 817 [#1] ARM
[33806.770101] Modules linked in: snd_bcm2835(C) snd_pcm raspberrypi_hwmon snd_timer hwmon bcm2835_codec(C) bcm2835_v4l2(C) snd v4l2_mem2mem v4l2_common bcm2835_mmal_vchiq(C) videobuf2_vmalloc videobuf2_dma_contig videobuf2_memops videobuf2_v4l2 videobuf2_common videodev media vc_sm_cma(C) sha256_generic cfg80211 rfkill nft_chain_nat_ipv4 ipt_MASQUERADE nf_nat_ipv4 nf_nat nft_counter xt_conntrack nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nft_compat nf_tables nfnetlink i2c_dev ip_tables x_tables usb_f_rndis ipv6 usb_f_ecm u_ether usb_f_acm libcomposite u_serial 8021q garp stp llc dwc2 udc_core i2c_bcm2835 fixed uio_pdrv_genirq uio
[33806.839867] CPU: 0 PID: 704 Comm: kworker/0:3 Tainted: G C 4.19.57+ #1244
[33806.852151] Hardware name: BCM2835
[33806.857701] Workqueue: events_freezable mmc_rescan
[33806.864690] PC is at bcm2835_sdhost_finish_command+0x1d0/0x5fc
[33806.872707] LR is at trace_hardirqs_off+0x50/0x124
[33806.879717] pc : [<c054aa4c>] lr : [<c00d40dc>] psr: 40000093
[33806.888264] sp : d8e69c30 ip : c09e341c fp : d8e69c7c
[33806.895710] r10: 60000013 r9 : 00000000 r8 : c09e3028
[33806.903102] r7 : c09f38c0 r6 : d8e69ca0 r5 : d9c3c300 r4 : 00000040
[33806.911854] r3 : ffffff92 r2 : 00004037 r1 : 00000020 r0 : 00000000
[33806.920626] Flags: nZcv IRQs off FIQs on Mode SVC_32 ISA ARM Segment user
[33806.930153] Control: 00c5387d Table: 194e0008 DAC: 00000055
[33806.938165] Process kworker/0:3 (pid: 704, stack limit = 0x66c3ceeb)
[33806.946775] Stack: (0xd8e69c30 to 0xd8e6a000)
[33806.953309] 9c20: c09e3028 00000000 d8e69c7c d8e69c48
[33806.965737] 9c40: c054a128 c0076d24 d8e69c7c e5d71f59 c0549344 d9c3c000 d8e69d38 c09e3028
[33806.978044] 9c60: d9c3c300 00010800 c09e3028 00000000 d8e69cd4 d8e69c80 c054c0bc c054a888
[33806.990410] 9c80: d8e69ca4 d8e69c90 c054e918 c03dbf28 c054e894 da9d9624 d8e69cb4 d8e69ca8
[33807.002915] 9ca0: 60000013 e5d71f59 d8e69cc4 d9c3c000 d8e69d38 d8e69d38 00000000 00000000
[33807.015648] 9cc0: c09e3028 00000000 d8e69cf4 d8e69cd8 c0529b44 c054bc14 00000022 d9c3c000
[33807.028480] 9ce0: d8e69d38 00000000 d8eroot@p1:~/utils/raspinfo# 69d14 d8e69cf8 c052a8cc c0529ad8 c0529d44 d8e69d38
[33807.041510] 9d00: c09e3028 d9c3c000 d8e69d34 d8e69d18 c052a964 c052a844 00000000 d8e69d98
[33807.054776] 9d20: c09e3028 d9c3c000 d8e69d94 d8e69d38 c052aa54 c052a908 00000000 d8e69d98
[33807.068132] 9d40: 00000000 00000000 00000001 d8e69d4c d8e69d4c 00000000 d8e69d58 d8e69d58
[33807.081596] 9d60: c0529d44 00000000 00000000 00000000 00000000 e5d71f59 d9c3c000 c09e3028
[33807.095144] 9d80: d8e69e60 00000003 d8e69de4 d8e69d98 c0534a78 c052a9e8 00000037 00000000
[33807.108763] 9da0: 00000000 00000000 00000000 00000000 000000f5 00000000 ffffff92 00000000
[33807.122423] 9dc0: 00000000 00000000 d8e69d38 e5d71f59 00000064 d9c3c000 d8e69e5c d8e69de8
[33807.136089] 9de0: c0534b58 c05349c8 00000000 d8e69e68 00000000 00000000 00000000 00000000
[33807.149750] 9e00: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[33807.163387] 9e20: 00000000 00000000 00000000 e5d71f59 c0536f44 00000064 d9c3c000 00000000
[33807.176991] 9e40: c09e3028 d8e69ec0 00000000 d9c3c22c d8e69ebc d8e69e60 c0534d34 c0534ad8
[33807.190663] 9e60: 00000029 00000000 00000000 00000000 00000000 00000000 000000e1 00000000
[33807.204331] 9e80: 00000000 00000000 00000000 00000000 00000000 e5d71f59 00000000 d9c3c000
[33807.217996] 9ea0: 00030d40 c09e3028 c071945c c0719460 d8e69ee4 d8e69ec0 c0534888 c0534c88
[33807.231635] 9ec0: 00030d40 e5d71f59 c071945c d9c3c228 00030d40 d9c3c000 d8e69f0c d8e69ee8
[33807.245248] 9ee0: c052cd60 c0534850 c052c918 d9c3c228 d94cb900 c09eb7d8 00000000 dbab2500
[33807.258884] 9f00: d8e69f44 d8e69f10 c003d228 c052c924 00000008 d8ed7f58 d8e69f44 c09eb7d8
[33807.272542] 9f20: d94cb914 c09eb7ec c09f38c0 00000008 d8ed7f58 d94cb900 d8e69f7c d8e69f48
[33807.286222] 9f40: c003d4cc c003d104 d8e69f7c d8e69f58 c0042844 d8ed7f40 d934c040 00000000
[33807.299884] 9f60: d94cb900 c003d498 d8ed7f58 d952de88 d8e69fac d8e69f80 c0042fd0 c003d4a4
[33807.313506] 9f80: ffffffff d934c040 c0042eb4 00000000 00000000 00000000 00000000 00000000
[33807.327111] 9fa0: 00000000 d8e69fb0 c00090ac c0042ec0 00000000 00000000 00000000 00000000
[33807.340769] 9fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[33807.354426] 9fe0: 00000000 00000000 00000000 00000000 00000013 00000000 00000000 00000000
[33807.368127] [<c054aa4c>] (bcm2835_sdhost_finish_command) from [<c054c0bc>] (bcm2835_sdhost_request+0x4b4/0x684)
[33807.383747] [<c054c0bc>] (bcm2835_sdhost_request) from [<c0529b44>] (__mmc_start_request+0x78/0x164)
[33807.398387] [<c0529b44>] (__mmc_start_request) from [<c052a8cc>] (mmc_start_request+0x94/0xc4)
[33807.412471] [<c052a8cc>] (mmc_start_request) from [<c052a964>] (mmc_wait_for_req+0x68/0xe0)
[33807.426306] [<c052a964>] (mmc_wait_for_req) from [<c052aa54>] (mmc_wait_for_cmd+0x78/0xb4)
[33807.440109] [<c052aa54>] (mmc_wait_for_cmd) from [<c0534a78>] (mmc_app_cmd+0xbc/0x110)
[33807.453561] [<c0534a78>] (mmc_app_cmd) from [<c0534b58>] (mmc_wait_for_app_cmd+0x8c/0xfc)
[33807.467277] [<c0534b58>] (mmc_wait_for_app_cmd) from [<c0534d34>] (mmc_send_app_op_cond+0xb8/0x148)
[33807.481828] [<c0534d34>] (mmc_send_app_op_cond) from [<c0534888>] (mmc_attach_sd+0x44/0x178)
[33807.495736] [<c0534888>] (mmc_attach_sd) from [<c052cd60>] (mmc_rescan+0x448/0x498)
[33807.508881] [<c052cd60>] (mmc_rescan) from [<c003d228>] (process_one_work+0x130/0x3a0)
[33807.522339] [<c003d228>] (process_one_work) from [<c003d4cc>] (worker_thread+0x34/0x530)
[33807.535971] [<c003d4cc>] (worker_thread) from [<c0042fd0>] (kthread+0x11c/0x158)
[33807.548891] [<c0042fd0>] (kthread) from [<c00090ac>] (ret_from_fork+0x14/0x28)
[33807.558892] Exception stack(0xd8e69fb0 to 0xd8e69ff8)
[33807.566709] 9fa0: 00000000 00000000 00000000 00000000
[33807.580217] 9fc0: 00000000 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[33807.593664] 9fe0: 00000000 00000000 00000000 00000000 00000013 00000000
[33807.602999] Code: e5d530a4 e3130010 1a0000e9 e3e0306d (e5803020)
[33807.611770] ---[ end trace 27dee134a46220fb ]---
And the solution in short is to add the following to /boot/config.txt (may be in another location on live system) to configure the Pi4 on boot to avoid this log spam.
# Disable polling for SD-card
dtparam=sd_poll_once=on
I’m not sure of the consequences of doing this automatically within our installer thought. But we could.
This is non Pi4 specific. I’ve had this also on recent regular x86_64 builds. The browser url gets ‘stuck’. Visiting any other page frees it up I believe.
Curios. I’ve not actually tried this. The Pi4 I have here for building Arm64 installer profiles (Pi4 and ARM64EFI) and Arm64 rpms, has only a single USB-to-SATA adapter in uasp mode with SSD attached.
Yes, super annoying and makes it hard to diagnose anything else. Apply the above fix and then things will calm down considerable so one can see the logs then. These messages got to log and standard out. Let us know if this works for you also and if your end up find out the consequences let us know here. Pretty sure we can just edit this in with the installer if it’s safe to do so.
Yes, I was quite chuffed to finally see that for myself here, could hardly believe it when I first saw it .
I was surprised as the responsiveness myself. And works much better from an SSD with a descent uasp compatible (and working as some have flaky drivers) adapter.
OK, strange but if this was directly after first install boot, although Rockstor does work directly after install, I have my doubts as to it’s full function. So this may have been directly after initial install. Otherwise no idea currently.
That would be great. As to pointers, given you Pi4 obviously has had it’s EEPROM updated but in the Pi4 world this has to, ideally, be kept in sync with the rest of the boot system with lives in the firmware files. Try overwriting the start4* and fixup4* files on the installed Rockstor disk with those found in a fully updated (on your Pi4 so it also updates your EEPROM boot bit) Raspberry Pi OS. The default ones in openSUSE Leap 15.2 are I believe matched with an older pre USB boot Pi4 EEPROM. I think I had assumed not updating these files would render USB boot completely disfunctional and so I may have just done this quick as I needed to get our Arm64 build system up quickly. And have unfortunately had little time there after to test our resulting installers pre/post firmware file updates etc.
Thanks for getting the ball rolling on the Pi4 testing. Much appreciated. Bit in the middle of things currently hence the vague dir location re firmware files but given your Pi4 familiarity you will likely find them just fine. Really depends on if you are booting into the image in question or mounting say the sdcard on another linux system to make the changes there.
Incidentally in our build setup for the arm side of things I’ve used KVM on the Pi4 and it’s working a treat, bar some version drift between my various machines. I was chuffed to find this worked without issue. Although I’ve heard otherwise on a podcast and it was just not my experience. This was where the host OS was JeOS Leap 15.2 image, same as what Rockstor 4 is based on.
Hope that helps and thanks again for sharing your findings re the Pi4 installer. Much appreciated.