Your message dated Tue, 06 Dec 2022 15:12:50 +0100 with message-id <1843069.a7Racg3F4R@prancing-pony> and subject line Re: Bug#1021315: Linux kernel very slow to boot has caused the Debian Bug report #1021315, regarding Linux kernel very slow to boot to be marked as done. This means that you claim that the problem has been dealt with. If this is not the case it is now your responsibility to reopen the Bug report if necessary, and/or fix the problem forthwith. (NB: If you are a system administrator and have no idea what this message is talking about, this may indicate a serious mail system misconfiguration somewhere. Please contact owner@bugs.debian.org immediately.) -- 1021315: https://bugs.debian.org/cgi-bin/bugreport.cgi?bug=1021315 Debian Bug Tracking System Contact owner@bugs.debian.org with problems
--- Begin Message ---
- To: submit@bugs.debian.org
- Subject: Linux kernel very slow to boot
- From: eHenry Berg <ehenry.berg@gmail.com>
- Date: Wed, 5 Oct 2022 17:14:55 +0000
- Message-id: <CABv-jmW7HdxPFq9_1kaS8uNJOpLCKKfrEWkozDhB3g29Fvj7hQ@mail.gmail.com>
Package: linux-image-5.19.0-2-arm64 Version: 5.19.0-2 Computer: Raspberry Pi 3b Environment:Debian Unstable arm64 uname -a: Linux atlas 5.19.0-2-arm64 #1 SMP Debian 5.19.11-1 (2022-09-24) aarch64 GNU/Linux 2022-07-26 If I have noted right, the slowness began when I upgraded linux version from 5.18.0-2 to 5.18.0-3. 2022-10-04 I updated firmware from 2019-08-18 to 2022-10-04 (from master). Still very slow to boot. # cat /boot/firmware/cmdline.txt dwc_otg.lpm_enable=0 console=tty0 root=/dev/mmcblk0p3 rootfstype=f2fs elevator=deadline fsck.repair=yes rootwait cma=416M # cat /boot/firmware/config.txt arm_64bit=1 #device_tree=bcm2837-rpi-3-b-plus.dtb.5.19 device_tree=bcm2837-rpi-3-b.dtb.5.19 kernel=vmlinuz-5.19.0-2-arm64 initramfs initrd.img-5.19.0-2-arm64 followkernel # cat /etc/initramfs-tools/modules crc32 crc32c f2fs # cat /etc/modules vc4 # cat /etc/dphys-swapfile CONF_SWAPSIZE=1024 # cat /etc/fstab #<file system> <dir> <type> <options> <dump> <pass> proc /proc proc defaults 0 0 /dev/mmcblk0p1 /boot/firmware vfat noauto,noatime 0 2 /dev/mmcblk0p2 /boot ext2 defaults,noatime 0 0 /dev/mmcblk0p3 / f2fs defaults,noatime 0 0 # cat /etc/apt/sources.list deb http://ftp.fi.debian.org/debian sid main contrib non-free # systemd-analyze time Startup finished in 5min 50.088s (kernel) + 21.179s (userspace) = 6min 11.268s graphical.target reached after 21.110s in userspace. # dmesg -T > dmesg_5.19.0-2.txt I attach the whole file dmesg_5.19.0-2.txt. dmesg_5.19.0-2.txt: [Wed Oct 5 15:49:10 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:10 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input14 [Wed Oct 5 15:54:48 2022] F2FS-fs (mmcblk0p3): recover fsync data on readonly fs [Wed Oct 5 15:54:48 2022] F2FS-fs (mmcblk0p3): Mounted with checkpoint version = 1ba098 Why is it delayed from clock 15:49:10 to 15:54:48 in dmesg? The kernel boot time has been fast for years. The kernel startup time has been around 10 seconds and now it is almost 6 minutes. Best Regards, Evald[Wed Oct 5 15:48:59 2022] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [Wed Oct 5 15:48:59 2022] Linux version 5.19.0-2-arm64 (debian-kernel@lists.debian.org) (gcc-11 (Debian 11.3.0-6) 11.3.0, GNU ld (GNU Binutils for Debian) 2.39) #1 SMP Debian 5.19.11-1 (2022-09-24) [Wed Oct 5 15:48:59 2022] random: crng init done [Wed Oct 5 15:48:59 2022] Machine model: Raspberry Pi 3 Model B Rev 1.2 [Wed Oct 5 15:48:59 2022] efi: UEFI not found. [Wed Oct 5 15:48:59 2022] Reserved memory: bypass linux,cma node, using cmdline CMA params instead [Wed Oct 5 15:48:59 2022] OF: reserved mem: node linux,cma compatible matching fail [Wed Oct 5 15:48:59 2022] NUMA: No NUMA configuration found [Wed Oct 5 15:48:59 2022] NUMA: Faking a node at [mem 0x0000000000000000-0x000000003b3fffff] [Wed Oct 5 15:48:59 2022] NUMA: NODE_DATA [mem 0x3b20d940-0x3b20ffff] [Wed Oct 5 15:48:59 2022] Zone ranges: [Wed Oct 5 15:48:59 2022] DMA [mem 0x0000000000000000-0x000000003b3fffff] [Wed Oct 5 15:48:59 2022] DMA32 empty [Wed Oct 5 15:48:59 2022] Normal empty [Wed Oct 5 15:48:59 2022] Movable zone start for each node [Wed Oct 5 15:48:59 2022] Early memory node ranges [Wed Oct 5 15:48:59 2022] node 0: [mem 0x0000000000000000-0x000000003b3fffff] [Wed Oct 5 15:48:59 2022] Initmem setup node 0 [mem 0x0000000000000000-0x000000003b3fffff] [Wed Oct 5 15:48:59 2022] On node 0, zone DMA: 19456 pages in unavailable ranges [Wed Oct 5 15:48:59 2022] cma: Reserved 416 MiB at 0x0000000012600000 [Wed Oct 5 15:48:59 2022] percpu: Embedded 30 pages/cpu s83176 r8192 d31512 u122880 [Wed Oct 5 15:48:59 2022] pcpu-alloc: s83176 r8192 d31512 u122880 alloc=30*4096 [Wed Oct 5 15:48:59 2022] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [Wed Oct 5 15:48:59 2022] Detected VIPT I-cache on CPU0 [Wed Oct 5 15:48:59 2022] CPU features: kernel page table isolation forced ON by KASLR [Wed Oct 5 15:48:59 2022] CPU features: detected: Kernel page table isolation (KPTI) [Wed Oct 5 15:48:59 2022] CPU features: detected: ARM erratum 843419 [Wed Oct 5 15:48:59 2022] CPU features: detected: ARM erratum 845719 [Wed Oct 5 15:48:59 2022] Fallback order for Node 0: 0 [Wed Oct 5 15:48:59 2022] Built 1 zonelists, mobility grouping on. Total pages: 238896 [Wed Oct 5 15:48:59 2022] Policy zone: DMA [Wed Oct 5 15:48:59 2022] Kernel command line: video=HDMI-A-1:1920x1080M@60 dma.dmachans=0x7ff5 bcm2709.boardrev=0xa02082 bcm2709.serial=0x3f3d54e2 bcm2709.uart_clock=48000000 smsc95xx.macaddr=B8:27:EB:3D:54:E2 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 dwc_otg.lpm_enable=0 console=tty0 root=/dev/mmcblk0p3 rootfstype=f2fs elevator=deadline fsck.repair=yes rootwait cma=416M [Wed Oct 5 15:48:59 2022] Kernel parameter elevator= does not have any effect anymore. Please use sysfs to set IO scheduler for individual devices. [Wed Oct 5 15:48:59 2022] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [Wed Oct 5 15:48:59 2022] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) [Wed Oct 5 15:48:59 2022] mem auto-init: stack:off, heap alloc:on, heap free:off [Wed Oct 5 15:48:59 2022] Memory: 100432K/970752K available (12480K kernel code, 2682K rwdata, 8840K rodata, 5952K init, 590K bss, 94076K reserved, 425984K cma-reserved) [Wed Oct 5 15:48:59 2022] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [Wed Oct 5 15:48:59 2022] ftrace: allocating 41880 entries in 164 pages [Wed Oct 5 15:48:59 2022] ftrace: allocated 164 pages with 3 groups [Wed Oct 5 15:48:59 2022] trace event string verifier disabled [Wed Oct 5 15:48:59 2022] rcu: Hierarchical RCU implementation. [Wed Oct 5 15:48:59 2022] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. [Wed Oct 5 15:48:59 2022] Rude variant of Tasks RCU enabled. [Wed Oct 5 15:48:59 2022] Tracing variant of Tasks RCU enabled. [Wed Oct 5 15:48:59 2022] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [Wed Oct 5 15:48:59 2022] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [Wed Oct 5 15:48:59 2022] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [Wed Oct 5 15:48:59 2022] Root IRQ handler: bcm2836_arm_irqchip_handle_irq [Wed Oct 5 15:48:59 2022] rcu: srcu_init: Setting srcu_struct sizes based on contention. [Wed Oct 5 15:48:59 2022] arch_timer: cp15 timer(s) running at 19.20MHz (phys). [Wed Oct 5 15:48:59 2022] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns [Wed Oct 5 15:48:59 2022] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns [Wed Oct 5 15:48:59 2022] Console: colour dummy device 80x25 [Wed Oct 5 15:48:59 2022] printk: console [tty0] enabled [Wed Oct 5 15:48:59 2022] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=76800) [Wed Oct 5 15:48:59 2022] pid_max: default: 32768 minimum: 301 [Wed Oct 5 15:48:59 2022] LSM: Security Framework initializing [Wed Oct 5 15:48:59 2022] landlock: Up and running. [Wed Oct 5 15:48:59 2022] Yama: disabled by default; enable with sysctl kernel.yama.* [Wed Oct 5 15:48:59 2022] AppArmor: AppArmor initialized [Wed Oct 5 15:48:59 2022] TOMOYO Linux initialized [Wed Oct 5 15:48:59 2022] LSM support for eBPF active [Wed Oct 5 15:48:59 2022] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [Wed Oct 5 15:48:59 2022] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [Wed Oct 5 15:48:59 2022] cblist_init_generic: Setting adjustable number of callback queues. [Wed Oct 5 15:48:59 2022] cblist_init_generic: Setting shift to 2 and lim to 1. [Wed Oct 5 15:48:59 2022] cblist_init_generic: Setting shift to 2 and lim to 1. [Wed Oct 5 15:48:59 2022] rcu: Hierarchical SRCU implementation. [Wed Oct 5 15:48:59 2022] rcu: Max phase no-delay instances is 1000. [Wed Oct 5 15:48:59 2022] EFI services will not be available. [Wed Oct 5 15:48:59 2022] smp: Bringing up secondary CPUs ... [Wed Oct 5 15:48:59 2022] Detected VIPT I-cache on CPU1 [Wed Oct 5 15:48:59 2022] CPU1: Booted secondary processor 0x0000000001 [0x410fd034] [Wed Oct 5 15:48:59 2022] Detected VIPT I-cache on CPU2 [Wed Oct 5 15:48:59 2022] CPU2: Booted secondary processor 0x0000000002 [0x410fd034] [Wed Oct 5 15:48:59 2022] Detected VIPT I-cache on CPU3 [Wed Oct 5 15:48:59 2022] CPU3: Booted secondary processor 0x0000000003 [0x410fd034] [Wed Oct 5 15:48:59 2022] smp: Brought up 1 node, 4 CPUs [Wed Oct 5 15:48:59 2022] SMP: Total of 4 processors activated. [Wed Oct 5 15:48:59 2022] CPU features: detected: 32-bit EL0 Support [Wed Oct 5 15:48:59 2022] CPU features: detected: 32-bit EL1 Support [Wed Oct 5 15:48:59 2022] CPU features: detected: CRC32 instructions [Wed Oct 5 15:48:59 2022] CPU: All CPU(s) started at EL2 [Wed Oct 5 15:48:59 2022] alternatives: patching kernel code [Wed Oct 5 15:48:59 2022] node 0 deferred pages initialised in 16ms [Wed Oct 5 15:48:59 2022] devtmpfs: initialized [Wed Oct 5 15:48:59 2022] Registered cp15_barrier emulation handler [Wed Oct 5 15:48:59 2022] Registered setend emulation handler [Wed Oct 5 15:48:59 2022] KASLR enabled [Wed Oct 5 15:48:59 2022] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [Wed Oct 5 15:48:59 2022] futex hash table entries: 1024 (order: 4, 65536 bytes, linear) [Wed Oct 5 15:48:59 2022] pinctrl core: initialized pinctrl subsystem [Wed Oct 5 15:48:59 2022] DMI not present or invalid. [Wed Oct 5 15:48:59 2022] NET: Registered PF_NETLINK/PF_ROUTE protocol family [Wed Oct 5 15:48:59 2022] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations [Wed Oct 5 15:48:59 2022] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [Wed Oct 5 15:48:59 2022] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [Wed Oct 5 15:48:59 2022] audit: initializing netlink subsys (disabled) [Wed Oct 5 15:48:59 2022] audit: type=2000 audit(0.080:1): state=initialized audit_enabled=0 res=1 [Wed Oct 5 15:48:59 2022] thermal_sys: Registered thermal governor 'fair_share' [Wed Oct 5 15:48:59 2022] thermal_sys: Registered thermal governor 'bang_bang' [Wed Oct 5 15:48:59 2022] thermal_sys: Registered thermal governor 'step_wise' [Wed Oct 5 15:48:59 2022] thermal_sys: Registered thermal governor 'user_space' [Wed Oct 5 15:48:59 2022] thermal_sys: Registered thermal governor 'power_allocator' [Wed Oct 5 15:48:59 2022] cpuidle: using governor ladder [Wed Oct 5 15:48:59 2022] cpuidle: using governor menu [Wed Oct 5 15:48:59 2022] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [Wed Oct 5 15:48:59 2022] ASID allocator initialised with 32768 entries [Wed Oct 5 15:48:59 2022] HugeTLB: can optimize 4095 vmemmap pages for hugepages-1048576kB [Wed Oct 5 15:48:59 2022] HugeTLB: can optimize 127 vmemmap pages for hugepages-32768kB [Wed Oct 5 15:48:59 2022] HugeTLB: can optimize 7 vmemmap pages for hugepages-2048kB [Wed Oct 5 15:48:59 2022] HugeTLB: can optimize 0 vmemmap pages for hugepages-64kB [Wed Oct 5 15:48:59 2022] Serial: AMBA PL011 UART driver [Wed Oct 5 15:48:59 2022] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [Wed Oct 5 15:48:59 2022] HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages [Wed Oct 5 15:48:59 2022] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [Wed Oct 5 15:48:59 2022] HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages [Wed Oct 5 15:48:59 2022] ACPI: Interpreter disabled. [Wed Oct 5 15:48:59 2022] iommu: Default domain type: Translated [Wed Oct 5 15:48:59 2022] iommu: DMA domain TLB invalidation policy: strict mode [Wed Oct 5 15:48:59 2022] EDAC MC: Ver: 3.0.0 [Wed Oct 5 15:48:59 2022] NetLabel: Initializing [Wed Oct 5 15:48:59 2022] NetLabel: domain hash size = 128 [Wed Oct 5 15:48:59 2022] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [Wed Oct 5 15:48:59 2022] NetLabel: unlabeled traffic allowed by default [Wed Oct 5 15:48:59 2022] vgaarb: loaded [Wed Oct 5 15:48:59 2022] clocksource: Switched to clocksource arch_sys_counter [Wed Oct 5 15:48:59 2022] VFS: Disk quotas dquot_6.6.0 [Wed Oct 5 15:48:59 2022] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [Wed Oct 5 15:48:59 2022] AppArmor: AppArmor Filesystem Enabled [Wed Oct 5 15:48:59 2022] pnp: PnP ACPI: disabled [Wed Oct 5 15:48:59 2022] NET: Registered PF_INET protocol family [Wed Oct 5 15:48:59 2022] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [Wed Oct 5 15:48:59 2022] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) [Wed Oct 5 15:48:59 2022] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [Wed Oct 5 15:48:59 2022] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) [Wed Oct 5 15:48:59 2022] TCP bind hash table entries: 8192 (order: 5, 131072 bytes, linear) [Wed Oct 5 15:48:59 2022] TCP: Hash tables configured (established 8192 bind 8192) [Wed Oct 5 15:48:59 2022] MPTCP token hash table entries: 1024 (order: 2, 24576 bytes, linear) [Wed Oct 5 15:48:59 2022] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [Wed Oct 5 15:48:59 2022] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [Wed Oct 5 15:48:59 2022] NET: Registered PF_UNIX/PF_LOCAL protocol family [Wed Oct 5 15:48:59 2022] NET: Registered PF_XDP protocol family [Wed Oct 5 15:48:59 2022] PCI: CLS 0 bytes, default 64 [Wed Oct 5 15:48:59 2022] Trying to unpack rootfs image as initramfs... [Wed Oct 5 15:48:59 2022] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 counters available [Wed Oct 5 15:48:59 2022] kvm [1]: IPA Size Limit: 40 bits [Wed Oct 5 15:48:59 2022] kvm [1]: Hyp mode initialized successfully [Wed Oct 5 15:48:59 2022] Initialise system trusted keyrings [Wed Oct 5 15:48:59 2022] Key type blacklist registered [Wed Oct 5 15:48:59 2022] workingset: timestamp_bits=42 max_order=18 bucket_order=0 [Wed Oct 5 15:48:59 2022] zbud: loaded [Wed Oct 5 15:48:59 2022] integrity: Platform Keyring initialized [Wed Oct 5 15:48:59 2022] Key type asymmetric registered [Wed Oct 5 15:48:59 2022] Asymmetric key parser 'x509' registered [Wed Oct 5 15:49:03 2022] Freeing initrd memory: 42872K [Wed Oct 5 15:49:03 2022] alg: self-tests for CTR-KDF (hmac(sha256)) passed [Wed Oct 5 15:49:03 2022] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) [Wed Oct 5 15:49:03 2022] io scheduler mq-deadline registered [Wed Oct 5 15:49:03 2022] gpio gpiochip0: (pinctrl-bcm2835): not an immutable chip, please consider fixing it! [Wed Oct 5 15:49:03 2022] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [Wed Oct 5 15:49:03 2022] simple-framebuffer 3e402000.framebuffer: framebuffer at 0x3e402000, 0x7f8000 bytes [Wed Oct 5 15:49:03 2022] simple-framebuffer 3e402000.framebuffer: format=a8r8g8b8, mode=1920x1080x32, linelength=7680 [Wed Oct 5 15:49:03 2022] Console: switching to colour frame buffer device 240x67 [Wed Oct 5 15:49:03 2022] simple-framebuffer 3e402000.framebuffer: fb0: simplefb registered! [Wed Oct 5 15:49:03 2022] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [Wed Oct 5 15:49:03 2022] 3f215040.serial: ttyS1 at MMIO 0x3f215040 (irq = 71, base_baud = 31250000) is a 16550 [Wed Oct 5 15:49:03 2022] Serial: AMBA driver [Wed Oct 5 15:49:03 2022] msm_serial: driver initialized [Wed Oct 5 15:49:03 2022] bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver [Wed Oct 5 15:49:03 2022] mousedev: PS/2 mouse device common for all mice [Wed Oct 5 15:49:03 2022] ledtrig-cpu: registered to indicate activity on CPUs [Wed Oct 5 15:49:03 2022] bcm2835-mbox 3f00b880.mailbox: mailbox enabled [Wed Oct 5 15:49:03 2022] NET: Registered PF_INET6 protocol family [Wed Oct 5 15:49:03 2022] Segment Routing with IPv6 [Wed Oct 5 15:49:03 2022] In-situ OAM (IOAM) with IPv6 [Wed Oct 5 15:49:03 2022] mip6: Mobile IPv6 [Wed Oct 5 15:49:03 2022] NET: Registered PF_PACKET protocol family [Wed Oct 5 15:49:03 2022] mpls_gso: MPLS GSO support [Wed Oct 5 15:49:03 2022] registered taskstats version 1 [Wed Oct 5 15:49:03 2022] Loading compiled-in X.509 certificates [Wed Oct 5 15:49:04 2022] Loaded X.509 cert 'Debian Secure Boot CA: 6ccece7e4c6c0d1f6149f3dd27dfcc5cbb419ea1' [Wed Oct 5 15:49:04 2022] Loaded X.509 cert 'Debian Secure Boot Signer 2022 - linux: 14011249c2675ea8e5148542202005810584b25f' [Wed Oct 5 15:49:04 2022] zswap: loaded using pool lzo/zbud [Wed Oct 5 15:49:04 2022] Key type ._fscrypt registered [Wed Oct 5 15:49:04 2022] Key type .fscrypt registered [Wed Oct 5 15:49:04 2022] Key type fscrypt-provisioning registered [Wed Oct 5 15:49:04 2022] Key type encrypted registered [Wed Oct 5 15:49:04 2022] AppArmor: AppArmor sha1 policy hashing enabled [Wed Oct 5 15:49:04 2022] ima: No TPM chip found, activating TPM-bypass! [Wed Oct 5 15:49:04 2022] ima: Allocated hash algorithm: sha256 [Wed Oct 5 15:49:04 2022] ima: No architecture policies found [Wed Oct 5 15:49:04 2022] evm: Initialising EVM extended attributes: [Wed Oct 5 15:49:04 2022] evm: security.selinux [Wed Oct 5 15:49:04 2022] evm: security.SMACK64 (disabled) [Wed Oct 5 15:49:04 2022] evm: security.SMACK64EXEC (disabled) [Wed Oct 5 15:49:04 2022] evm: security.SMACK64TRANSMUTE (disabled) [Wed Oct 5 15:49:04 2022] evm: security.SMACK64MMAP (disabled) [Wed Oct 5 15:49:04 2022] evm: security.apparmor [Wed Oct 5 15:49:04 2022] evm: security.ima [Wed Oct 5 15:49:04 2022] evm: security.capability [Wed Oct 5 15:49:04 2022] evm: HMAC attrs: 0x1 [Wed Oct 5 15:49:05 2022] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 99, base_baud = 0) is a PL011 rev2 [Wed Oct 5 15:49:05 2022] serial serial0: tty port ttyAMA0 registered [Wed Oct 5 15:49:05 2022] raspberrypi-firmware soc:firmware: Attached to firmware from 2022-09-30T14:27:03 [Wed Oct 5 15:49:05 2022] Freeing unused kernel memory: 5952K [Wed Oct 5 15:49:05 2022] Checked W+X mappings: passed, no W+X pages found [Wed Oct 5 15:49:05 2022] Run /init as init process [Wed Oct 5 15:49:05 2022] with arguments: [Wed Oct 5 15:49:05 2022] /init [Wed Oct 5 15:49:05 2022] with environment: [Wed Oct 5 15:49:05 2022] HOME=/ [Wed Oct 5 15:49:05 2022] TERM=linux [Wed Oct 5 15:49:06 2022] usb_phy_generic phy: supply vcc not found, using dummy regulator [Wed Oct 5 15:49:06 2022] usb_phy_generic phy: dummy supplies not allowed for exclusive requests [Wed Oct 5 15:49:06 2022] i2c-bcm2835 3f805000.i2c: Could not read clock-frequency property [Wed Oct 5 15:49:06 2022] sdhci: Secure Digital Host Controller Interface driver [Wed Oct 5 15:49:06 2022] sdhci: Copyright(c) Pierre Ossman [Wed Oct 5 15:49:06 2022] sdhost-bcm2835 3f202000.mmc: loaded - DMA enabled (>1) [Wed Oct 5 15:49:06 2022] sdhci-pltfm: SDHCI platform and OF driver helper [Wed Oct 5 15:49:06 2022] sdhci-iproc 3f300000.mmc: allocated mmc-pwrseq [Wed Oct 5 15:49:06 2022] usbcore: registered new interface driver usbfs [Wed Oct 5 15:49:06 2022] usbcore: registered new interface driver hub [Wed Oct 5 15:49:06 2022] usbcore: registered new device driver usb [Wed Oct 5 15:49:06 2022] mmc1: SDHCI controller on 3f300000.mmc [3f300000.mmc] using PIO [Wed Oct 5 15:49:06 2022] mmc0: host does not support reading read-only switch, assuming write-enable [Wed Oct 5 15:49:06 2022] mmc0: new high speed SDXC card at address 0001 [Wed Oct 5 15:49:06 2022] mmcblk0: mmc0:0001 00000 59.6 GiB [Wed Oct 5 15:49:06 2022] mmcblk0: p1 p2 p3 [Wed Oct 5 15:49:06 2022] mmc1: new high speed SDIO card at address 0001 [Wed Oct 5 15:49:07 2022] dwc2 3f980000.usb: supply vusb_d not found, using dummy regulator [Wed Oct 5 15:49:07 2022] dwc2 3f980000.usb: supply vusb_a not found, using dummy regulator [Wed Oct 5 15:49:07 2022] checking generic (3e402000 7f8000) vs hw (0 ffffffffffffffff) [Wed Oct 5 15:49:07 2022] fb0: switching to vc4 from simple [Wed Oct 5 15:49:07 2022] Console: switching to colour dummy device 80x25 [Wed Oct 5 15:49:07 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_hvs_ops [vc4]) [Wed Oct 5 15:49:07 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:07 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:07 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input0 [Wed Oct 5 15:49:07 2022] dwc2 3f980000.usb: DWC OTG Controller [Wed Oct 5 15:49:07 2022] dwc2 3f980000.usb: new USB bus registered, assigned bus number 1 [Wed Oct 5 15:49:07 2022] dwc2 3f980000.usb: irq 51, io mem 0x3f980000 [Wed Oct 5 15:49:07 2022] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.19 [Wed Oct 5 15:49:07 2022] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [Wed Oct 5 15:49:07 2022] usb usb1: Product: DWC OTG Controller [Wed Oct 5 15:49:07 2022] usb usb1: Manufacturer: Linux 5.19.0-2-arm64 dwc2_hsotg [Wed Oct 5 15:49:07 2022] usb usb1: SerialNumber: 3f980000.usb [Wed Oct 5 15:49:07 2022] hub 1-0:1.0: USB hub found [Wed Oct 5 15:49:07 2022] hub 1-0:1.0: 1 port detected [Wed Oct 5 15:49:07 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:07 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:07 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:07 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input1 [Wed Oct 5 15:49:07 2022] usb 1-1: new high-speed USB device number 2 using dwc2 [Wed Oct 5 15:49:07 2022] usb 1-1: New USB device found, idVendor=0424, idProduct=9514, bcdDevice= 2.00 [Wed Oct 5 15:49:07 2022] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [Wed Oct 5 15:49:07 2022] hub 1-1:1.0: USB hub found [Wed Oct 5 15:49:07 2022] hub 1-1:1.0: 5 ports detected [Wed Oct 5 15:49:07 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:07 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:07 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:07 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input2 [Wed Oct 5 15:49:08 2022] usb 1-1.1: new high-speed USB device number 3 using dwc2 [Wed Oct 5 15:49:08 2022] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00, bcdDevice= 2.00 [Wed Oct 5 15:49:08 2022] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input3 [Wed Oct 5 15:49:08 2022] usb 1-1.2: new low-speed USB device number 4 using dwc2 [Wed Oct 5 15:49:08 2022] smsc95xx: unknown parameter 'macaddr' ignored [Wed Oct 5 15:49:08 2022] smsc95xx v2.0.0 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input4 [Wed Oct 5 15:49:08 2022] usb 1-1.2: New USB device found, idVendor=413c, idProduct=2107, bcdDevice= 1.15 [Wed Oct 5 15:49:08 2022] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [Wed Oct 5 15:49:08 2022] usb 1-1.2: Product: Dell USB Entry Keyboard [Wed Oct 5 15:49:08 2022] usb 1-1.2: Manufacturer: Dell [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input5 [Wed Oct 5 15:49:08 2022] SMSC LAN8700 usb-001:003:01: attached PHY driver (mii_bus:phy_addr=usb-001:003:01, irq=112) [Wed Oct 5 15:49:08 2022] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:3d:54:e2 [Wed Oct 5 15:49:08 2022] usbcore: registered new interface driver smsc95xx [Wed Oct 5 15:49:08 2022] hid: raw HID events driver (C) Jiri Kosina [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] smsc95xx 1-1.1:1.0 enxb827eb3d54e2: renamed from eth0 [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input6 [Wed Oct 5 15:49:08 2022] usbcore: registered new interface driver usbhid [Wed Oct 5 15:49:08 2022] usbhid: USB HID core driver [Wed Oct 5 15:49:08 2022] input: Dell Dell USB Entry Keyboard as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.0/0003:413C:2107.0001/input/input7 [Wed Oct 5 15:49:08 2022] usb 1-1.3: new low-speed USB device number 5 using dwc2 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input8 [Wed Oct 5 15:49:08 2022] hid-generic 0003:413C:2107.0001: input,hidraw0: USB HID v1.10 Keyboard [Dell Dell USB Entry Keyboard] on usb-3f980000.usb-1.2/input0 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input9 [Wed Oct 5 15:49:08 2022] usb 1-1.3: New USB device found, idVendor=413c, idProduct=3012, bcdDevice=43.01 [Wed Oct 5 15:49:08 2022] usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [Wed Oct 5 15:49:08 2022] usb 1-1.3: Product: Dell USB Optical Mouse [Wed Oct 5 15:49:08 2022] usb 1-1.3: Manufacturer: Dell [Wed Oct 5 15:49:08 2022] input: Dell Dell USB Optical Mouse as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.0/0003:413C:3012.0002/input/input10 [Wed Oct 5 15:49:08 2022] hid-generic 0003:413C:3012.0002: input,hidraw1: USB HID v1.11 Mouse [Dell Dell USB Optical Mouse] on usb-3f980000.usb-1.3/input0 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input11 [Wed Oct 5 15:49:08 2022] usb 1-1.5: new high-speed USB device number 6 using dwc2 [Wed Oct 5 15:49:08 2022] usb 1-1.5: New USB device found, idVendor=090c, idProduct=1000, bcdDevice=11.00 [Wed Oct 5 15:49:08 2022] usb 1-1.5: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [Wed Oct 5 15:49:08 2022] usb 1-1.5: Product: Flash Drive FIT [Wed Oct 5 15:49:08 2022] usb 1-1.5: Manufacturer: Samsung [Wed Oct 5 15:49:08 2022] usb 1-1.5: SerialNumber: 0318916090000332 [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input12 [Wed Oct 5 15:49:08 2022] SCSI subsystem initialized [Wed Oct 5 15:49:08 2022] usb-storage 1-1.5:1.0: USB Mass Storage device detected [Wed Oct 5 15:49:08 2022] usb-storage 1-1.5:1.0: Quirks match for vid 090c pid 1000: 400 [Wed Oct 5 15:49:08 2022] scsi host0: usb-storage 1-1.5:1.0 [Wed Oct 5 15:49:08 2022] usbcore: registered new interface driver usb-storage [Wed Oct 5 15:49:08 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:08 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:08 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:08 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input13 [Wed Oct 5 15:49:09 2022] usbcore: registered new interface driver uas [Wed Oct 5 15:49:10 2022] scsi 0:0:0:0: Direct-Access Samsung Flash Drive FIT 1100 PQ: 0 ANSI: 6 [Wed Oct 5 15:49:10 2022] sd 0:0:0:0: [sda] 250609664 512-byte logical blocks: (128 GB/120 GiB) [Wed Oct 5 15:49:10 2022] sd 0:0:0:0: [sda] Write Protect is off [Wed Oct 5 15:49:10 2022] sd 0:0:0:0: [sda] Mode Sense: 43 00 00 00 [Wed Oct 5 15:49:10 2022] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [Wed Oct 5 15:49:10 2022] sda: sda1 [Wed Oct 5 15:49:10 2022] sd 0:0:0:0: [sda] Attached SCSI removable disk [Wed Oct 5 15:49:10 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:49:10 2022] Registered IR keymap rc-cec [Wed Oct 5 15:49:10 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:49:10 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input14 [Wed Oct 5 15:54:48 2022] F2FS-fs (mmcblk0p3): recover fsync data on readonly fs [Wed Oct 5 15:54:48 2022] F2FS-fs (mmcblk0p3): Mounted with checkpoint version = 1ba098 [Wed Oct 5 15:54:48 2022] Not activating Mandatory Access Control as /sbin/tomoyo-init does not exist. [Wed Oct 5 15:54:49 2022] systemd[1]: System time before build time, advancing clock. [Wed Oct 5 15:54:49 2022] systemd[1]: Inserted module 'autofs4' [Wed Oct 5 15:54:49 2022] systemd[1]: systemd 251.5-1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) [Wed Oct 5 15:54:49 2022] systemd[1]: Detected architecture arm64. [Wed Oct 5 15:54:49 2022] systemd[1]: Hostname set to <atlas>. [Wed Oct 5 15:54:50 2022] systemd[1]: Queued start job for default target Graphical Interface. [Wed Oct 5 15:54:50 2022] systemd[1]: Created slice Slice /system/getty. [Wed Oct 5 15:54:50 2022] systemd[1]: Created slice Slice /system/modprobe. [Wed Oct 5 15:54:50 2022] systemd[1]: Created slice Slice /system/postgresql. [Wed Oct 5 15:54:50 2022] systemd[1]: Created slice User and Session Slice. [Wed Oct 5 15:54:50 2022] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [Wed Oct 5 15:54:50 2022] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target Local Integrity Protected Volumes. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target User and Group Name Lookups. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target Remote File Systems. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target Slice Units. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target Swaps. [Wed Oct 5 15:54:50 2022] systemd[1]: Reached target Local Verity Protected Volumes. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on Syslog Socket. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on initctl Compatibility Named Pipe. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on Journal Audit Socket. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on Journal Socket (/dev/log). [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on Journal Socket. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on udev Control Socket. [Wed Oct 5 15:54:50 2022] systemd[1]: Listening on udev Kernel Socket. [Wed Oct 5 15:54:50 2022] systemd[1]: Mounting Huge Pages File System... [Wed Oct 5 15:54:50 2022] systemd[1]: Mounting POSIX Message Queue File System... [Wed Oct 5 15:54:50 2022] systemd[1]: Mounting Kernel Debug File System... [Wed Oct 5 15:54:50 2022] systemd[1]: Mounting Kernel Trace File System... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Restore / save the current clock... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Wait for network to be configured by ifupdown... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Set the console keyboard layout... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Create List of Static Device Nodes... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Load Kernel Module configfs... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Load Kernel Module drm... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Load Kernel Module fuse... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Journal Service... [Wed Oct 5 15:54:50 2022] systemd[1]: Starting Load Kernel Modules... [Wed Oct 5 15:54:51 2022] systemd[1]: Starting Remount Root and Kernel File Systems... [Wed Oct 5 15:54:51 2022] systemd[1]: Repartition Root Disk was skipped because all trigger condition checks failed. [Wed Oct 5 15:54:51 2022] systemd[1]: Starting Coldplug All udev Devices... [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted Huge Pages File System. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted POSIX Message Queue File System. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted Kernel Debug File System. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted Kernel Trace File System. [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Restore / save the current clock. [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Wait for network to be configured by ifupdown. [Wed Oct 5 15:54:51 2022] fuse: init (API version 7.36) [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Create List of Static Device Nodes. [Wed Oct 5 15:54:51 2022] systemd[1]: modprobe@configfs.service: Deactivated successfully. [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Load Kernel Module configfs. [Wed Oct 5 15:54:51 2022] systemd[1]: modprobe@drm.service: Deactivated successfully. [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Load Kernel Module drm. [Wed Oct 5 15:54:51 2022] systemd[1]: modprobe@fuse.service: Deactivated successfully. [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Load Kernel Module fuse. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounting FUSE Control File System... [Wed Oct 5 15:54:51 2022] systemd[1]: Mounting Kernel Configuration File System... [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Remount Root and Kernel File Systems. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted FUSE Control File System. [Wed Oct 5 15:54:51 2022] systemd[1]: Mounted Kernel Configuration File System. [Wed Oct 5 15:54:51 2022] systemd[1]: First Boot Wizard was skipped because of a failed condition check (ConditionFirstBoot=yes). [Wed Oct 5 15:54:51 2022] systemd[1]: Platform Persistent Storage Archival was skipped because of a failed condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [Wed Oct 5 15:54:51 2022] systemd[1]: Starting Load/Save Random Seed... [Wed Oct 5 15:54:51 2022] systemd[1]: Starting Create System Users... [Wed Oct 5 15:54:51 2022] systemd[1]: Finished Load Kernel Modules. [Wed Oct 5 15:54:51 2022] systemd[1]: Starting Apply Kernel Variables... [Wed Oct 5 15:54:51 2022] systemd[1]: Started Journal Service. [Wed Oct 5 15:54:52 2022] systemd-journald[273]: Received client request to flush runtime journal. [Wed Oct 5 15:54:52 2022] systemd-journald[273]: File /var/log/journal/16defecfe0b742c39e7cf24cba7b63f0/system.journal corrupted or uncleanly shut down, renaming and replacing. [Wed Oct 5 15:54:55 2022] sd 0:0:0:0: Attached scsi generic sg0 type 0 [Wed Oct 5 15:54:55 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:55 2022] Registered IR keymap rc-cec [Wed Oct 5 15:54:55 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:54:55 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input15 [Wed Oct 5 15:54:55 2022] vchiq: module is from the staging directory, the quality is unknown, you have been warned. [Wed Oct 5 15:54:56 2022] bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer [Wed Oct 5 15:54:56 2022] bcm2835-rng 3f104000.rng: hwrng registered [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] EXT4-fs (mmcblk0p2): mounting ext2 file system using the ext4 subsystem [Wed Oct 5 15:54:56 2022] Registered IR keymap rc-cec [Wed Oct 5 15:54:56 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:54:56 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input16 [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] Registered IR keymap rc-cec [Wed Oct 5 15:54:56 2022] EXT4-fs (mmcblk0p2): mounted filesystem without journal. Quota mode: none. [Wed Oct 5 15:54:56 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:54:56 2022] ext2 filesystem being mounted at /boot supports timestamps until 2038 (0x7fffffff) [Wed Oct 5 15:54:56 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input17 [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f400000.hvs (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] Registered IR keymap rc-cec [Wed Oct 5 15:54:56 2022] rc rc0: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0 [Wed Oct 5 15:54:56 2022] input: vc4 as /devices/platform/soc/3f902000.hdmi/rc/rc0/input18 [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f902000.hdmi (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f806000.vec (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f004000.txp (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f206000.pixelvalve (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f207000.pixelvalve (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3f807000.pixelvalve (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: bound 3fc00000.v3d (ops vc4_drm_unregister [vc4]) [Wed Oct 5 15:54:56 2022] [drm] Initialized vc4 0.0.0 20140616 for soc:gpu on minor 0 [Wed Oct 5 15:54:56 2022] alg: No test for fips(ansi_cprng) (fips_ansi_cprng) [Wed Oct 5 15:54:56 2022] vc4_hdmi 3f902000.hdmi: Invalid register ID 83 [Wed Oct 5 15:54:56 2022] vc4_hdmi 3f902000.hdmi: Invalid register ID 83 [Wed Oct 5 15:54:56 2022] Console: switching to colour frame buffer device 240x67 [Wed Oct 5 15:54:56 2022] vc4-drm soc:gpu: [drm] fb0: vc4drmfb frame buffer device [Wed Oct 5 15:54:56 2022] cfg80211: Loading compiled-in X.509 certificates for regulatory database [Wed Oct 5 15:54:56 2022] cfg80211: Loaded X.509 cert 'benh@debian.org: 577e021cb980e0e820821ba7b54b4961b8b4fadf' [Wed Oct 5 15:54:56 2022] cfg80211: Loaded X.509 cert 'romain.perier@gmail.com: 3abbc6ec146e09d1b6016ab9d6cf71dd233f0328' [Wed Oct 5 15:54:56 2022] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [Wed Oct 5 15:54:56 2022] platform regulatory.0: firmware: direct-loading firmware regulatory.db [Wed Oct 5 15:54:56 2022] platform regulatory.0: firmware: direct-loading firmware regulatory.db.p7s [Wed Oct 5 15:54:56 2022] audit: type=1400 audit(1664984899.883:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lsb_release" pid=376 comm="apparmor_parser" [Wed Oct 5 15:54:56 2022] audit: type=1400 audit(1664984899.907:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe" pid=379 comm="apparmor_parser" [Wed Oct 5 15:54:56 2022] audit: type=1400 audit(1664984899.907:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe//kmod" pid=379 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.095:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="mariadbd_akonadi" pid=377 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [Wed Oct 5 15:54:57 2022] usbcore: registered new interface driver brcmfmac [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.119:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="mysqld_akonadi" pid=378 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.127:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/akonadiserver" pid=391 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: firmware: failed to load brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.bin (-2) [Wed Oct 5 15:54:57 2022] firmware_class: See https://wiki.debian.org/Firmware for information about missing firmware [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: firmware: failed to load brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.bin (-2) [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.bin failed with error -2 [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43430-sdio.bin [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.167:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="postgresql_akonadi" pid=389 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.txt [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.183:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/man" pid=414 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.183:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_filter" pid=414 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] audit: type=1400 audit(1664984900.183:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_groff" pid=414 comm="apparmor_parser" [Wed Oct 5 15:54:57 2022] snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. [Wed Oct 5 15:54:57 2022] bcm2835_audio bcm2835_audio: card created with 8 channels [Wed Oct 5 15:54:57 2022] mc: Linux media interface: v0.10 [Wed Oct 5 15:54:57 2022] brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 [Wed Oct 5 15:54:57 2022] brcmfmac mmc1:0001:1: firmware: direct-loading firmware brcm/brcmfmac43430-sdio.clm_blob [Wed Oct 5 15:54:57 2022] brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Mar 30 2021 01:12:21 version 7.45.98.118 (7d96287 CY) FWID 01-32059766 [Wed Oct 5 15:54:57 2022] videodev: Linux video capture interface: v2.00 [Wed Oct 5 15:54:57 2022] bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. [Wed Oct 5 15:54:57 2022] bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. [Wed Oct 5 15:54:58 2022] Bluetooth: Core ver 2.22 [Wed Oct 5 15:54:58 2022] NET: Registered PF_BLUETOOTH protocol family [Wed Oct 5 15:54:58 2022] Bluetooth: HCI device and connection manager initialized [Wed Oct 5 15:54:58 2022] Bluetooth: HCI socket layer initialized [Wed Oct 5 15:54:58 2022] Bluetooth: L2CAP socket layer initialized [Wed Oct 5 15:54:58 2022] Bluetooth: SCO socket layer initialized [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART driver ver 2.3 [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol H4 registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol LL registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol ATH3K registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol Three-wire (H5) registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol Intel registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol Broadcom registered [Wed Oct 5 15:54:58 2022] hci_uart_bcm serial0-0: supply vbat not found, using dummy regulator [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol QCA registered [Wed Oct 5 15:54:58 2022] hci_uart_bcm serial0-0: supply vddio not found, using dummy regulator [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol AG6XX registered [Wed Oct 5 15:54:58 2022] Bluetooth: HCI UART protocol Marvell registered [Wed Oct 5 15:54:59 2022] uart-pl011 3f201000.serial: no DMA platform data [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: chip id 94 [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: features 0x2e [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM43430A1 [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM43430A1 (001.002.009) build 0000 [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM43430A1.raspberrypi,3-model-b.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM43430A1.raspberrypi,3-model-b.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM43430A1.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM43430A1.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM.raspberrypi,3-model-b.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM.raspberrypi,3-model-b.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM.hcd (-2) [Wed Oct 5 15:54:59 2022] bluetooth hci0: firmware: failed to load brcm/BCM.hcd (-2) [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: firmware Patch file not found, tried: [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: 'brcm/BCM43430A1.raspberrypi,3-model-b.hcd' [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: 'brcm/BCM43430A1.hcd' [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: 'brcm/BCM.raspberrypi,3-model-b.hcd' [Wed Oct 5 15:54:59 2022] Bluetooth: hci0: BCM: 'brcm/BCM.hcd' [Wed Oct 5 15:55:00 2022] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [Wed Oct 5 15:55:00 2022] Bluetooth: BNEP filters: protocol multicast [Wed Oct 5 15:55:00 2022] Bluetooth: BNEP socket layer initialized [Wed Oct 5 15:55:00 2022] NET: Registered PF_ALG protocol family [Wed Oct 5 15:55:01 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:01 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:03 2022] NET: Registered PF_QIPCRTR protocol family [Wed Oct 5 15:55:03 2022] smsc95xx 1-1.1:1.0 enxb827eb3d54e2: hardware isn't capable of remote wakeup [Wed Oct 5 15:55:03 2022] smsc95xx 1-1.1:1.0 enxb827eb3d54e2: Link is Up - 100Mbps/Full - flow control off [Wed Oct 5 15:55:03 2022] IPv6: ADDRCONF(NETDEV_CHANGE): enxb827eb3d54e2: link becomes ready [Wed Oct 5 15:55:03 2022] smsc95xx 1-1.1:1.0 enxb827eb3d54e2: Link is Down [Wed Oct 5 15:55:04 2022] Adding 1048572k swap on /var/swap. Priority:-2 extents:90 across:7378944k SSFS [Wed Oct 5 15:55:04 2022] kauditd_printk_skb: 6 callbacks suppressed [Wed Oct 5 15:55:04 2022] audit: type=1400 audit(1664984907.859:18): apparmor="DENIED" operation="capable" profile="/usr/sbin/cupsd" pid=612 comm="cupsd" capability=12 capname="net_admin" [Wed Oct 5 15:55:05 2022] smsc95xx 1-1.1:1.0 enxb827eb3d54e2: Link is Up - 100Mbps/Full - flow control off [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:18 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:18 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:22 2022] Bluetooth: RFCOMM TTY layer initialized [Wed Oct 5 15:55:22 2022] Bluetooth: RFCOMM socket layer initialized [Wed Oct 5 15:55:22 2022] Bluetooth: RFCOMM ver 1.11 [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:55:39 2022] hdmi-audio-codec hdmi-audio-codec.16.auto: ASoC: error at snd_soc_dai_startup on i2s-hifi: -19 [Wed Oct 5 15:55:39 2022] MAI: __soc_pcm_open() failed (-19) [Wed Oct 5 15:56:20 2022] audit: type=1400 audit(1664985381.381:19): apparmor="DENIED" operation="open" profile="postgresql_akonadi" name="/etc/ssl/openssl.cnf" pid=1077 comm="postgres" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [Wed Oct 5 16:02:41 2022] F2FS-fs (sda1): Mounted with checkpoint version = 17adc
--- End Message ---
--- Begin Message ---
- To: 1021315-done@bugs.debian.org
- Subject: Re: Bug#1021315: Linux kernel very slow to boot
- From: Diederik de Haas <didi.debian@cknow.org>
- Date: Tue, 06 Dec 2022 15:12:50 +0100
- Message-id: <1843069.a7Racg3F4R@prancing-pony>
- In-reply-to: <[🔎] CABv-jmV_xRYHGS-6_NppY4oGXV7Q9_B4o2ezEpFZJYe1+9S=0Q@mail.gmail.com>
- References: <CABv-jmW7HdxPFq9_1kaS8uNJOpLCKKfrEWkozDhB3g29Fvj7hQ@mail.gmail.com> <[🔎] CABv-jmV_xRYHGS-6_NppY4oGXV7Q9_B4o2ezEpFZJYe1+9S=0Q@mail.gmail.com>
On Tuesday, 6 December 2022 13:22:23 CET eHenry Berg wrote: > The reason why it was very slow to boot up, was because of the file > system check. > > I erased "fsck.repair=yes" from the cmdline.txt above and now it boots up > fast. > > Please close this bug. Thanks for reporting back, closing.Attachment: signature.asc
Description: This is a digitally signed message part.
--- End Message ---