Re: KASAN debug kernel fails to boot at early stage when CONFIG_SMP=y is set (kernel 6.5-rc5, PowerMac G4 3,6)

[Erhard Furtner <erhard_f@mailbox.org>]

[-- Attachment #1: Type: text/plain, Size: 2700 bytes --]

On Mon, 14 Aug 2023 09:40:44 +0000
Christophe Leroy <christophe.leroy@csgroup.eu> wrote:

> Interesting. That means we get stuck somewhere around  MMU_init()
> 
> We know that MMU_init_hw() is called and runs at least until:
> 
> 	pr_info("Total memory = %lldMB; using %ldkB for hash table\n",
> 		(unsigned long long)(total_memory >> 20), Hash_size >> 10);
> 
> But we never reach the print in setup_kuap() which is itself called by 
> set_kup():
> 	pr_info("Activating Kernel Userspace Access Protection\n");
> 
> 
> Could you try to narrow more the issue by spreading pr_info() at places 
> in the code below and/or the called functions ? Either we never come 
> back from MMU_init_hw(), or one of mapin_ram() btext_unmap() 
> kasan_mmu_init() fails.
> 
> So the piece of code we are interested in is located in 
> arch/powerpc/mm/init_32.c and is:
> 
> 	/* Initialize the MMU hardware */
> 	if (ppc_md.progress)
> 		ppc_md.progress("MMU:hw init", 0x300);
> ==>	MMU_init_hw();  
> 
> 	/* Map in all of RAM starting at KERNELBASE */
> 	if (ppc_md.progress)
> 		ppc_md.progress("MMU:mapin", 0x301);
> 	mapin_ram();
> 
> 	/* Initialize early top-down ioremap allocator */
> 	ioremap_bot = IOREMAP_TOP;
> 
> 	if (ppc_md.progress)
> 		ppc_md.progress("MMU:exit", 0x211);
> 
> 	/* From now on, btext is no longer BAT mapped if it was at all */
> #ifdef CONFIG_BOOTX_TEXT
> 	btext_unmap();
> #endif
> 
> 	kasan_mmu_init();
> 
> ==>	setup_kup();  

I added a pr_info(); right after MMU_init_hw(); and another one right after setup_kup();.

Output of PPC_EARLY_DEBUG changes so that I get an additional black blank line after
[    0.000000] printk: bootconsole [udbg0] enabled
[    0.000000] Total memory = 2048MB; using 4096kB for hash table

and the freeze afterwards. So it looks like we return from MMU_init_hw() but not from setup_kup().

The dmesg of a warm boot (after first booting with kernel 6.4.10) supports that as it also shows the 1st blank line and the 2nd one just after activating KUEP/KUAP:

[    0.000000] printk: bootconsole [udbg0] enabled
[    0.000000] Total memory = 2048MB; using 4096kB for hash table
[    0.000000] 
[    0.000000] Activating Kernel Userspace Access Protection
[    0.000000] Activating Kernel Userspace Execution Prevention
[    0.000000] 
[    0.000000] Linux version 6.5.0-rc6-PMacG4-dirty (root@T1000) (gcc (Gentoo 12.3.1_p20230526 p2) 12.3.1 20230526, GNU ld (Gentoo 2.40 p7) 2.40.0) #1 SMP Mon Aug 14 18:05:17 CEST 2023

As the 2nd blank line from pr_info() is just after KUAP, KUEP initialization I thought these might be a problem. But if I deactivate KUAP/KUAP in the kernel .config I still get the freeze sot it must be something else.

Regards,
Erhard

[-- Attachment #2: dmesg_65-rc6_g4- --]
[-- Type: application/octet-stream, Size: 50400 bytes --]

[    0.000000] printk: bootconsole [udbg0] enabled
[    0.000000] Total memory = 2048MB; using 4096kB for hash table
[    0.000000] 
[    0.000000] Activating Kernel Userspace Access Protection
[    0.000000] Activating Kernel Userspace Execution Prevention
[    0.000000] 
[    0.000000] Linux version 6.5.0-rc6-PMacG4-dirty (root@T1000) (gcc (Gentoo 12.3.1_p20230526 p2) 12.3.1 20230526, GNU ld (Gentoo 2.40 p7) 2.40.0) #1 SMP Mon Aug 14 18:05:17 CEST 2023
[    0.000000] KASAN init done
[    0.000000] ioremap() called early from pmac_feature_init+0x17c/0xe9c. Use early_ioremap() instead
[    0.000000] Found UniNorth memory controller & host bridge @ 0xf8000000 revision: 0x24
[    0.000000] Mapped at 0xf53bf000
[    0.000000] ioremap() called early from probe_one_macio+0x1f8/0x400. Use early_ioremap() instead
[    0.000000] Found a Keylargo mac-io controller, rev: 3, mapped at 0x(ptrval)
[    0.000000] PowerMac motherboard: PowerMac G4 Windtunnel
[    0.000000] ioremap() called early from btext_map+0x64/0xdc. Use early_ioremap() instead
[    0.000000] Hardware name: PowerMac3,6 7455 0x80010303 PowerMac
[    0.000000] CPU maps initialized for 1 thread per core
[    0.000000]  (thread shift is 0)
[    0.000000] -----------------------------------------------------
[    0.000000] phys_mem_size     = 0x80000000
[    0.000000] dcache_bsize      = 0x20
[    0.000000] icache_bsize      = 0x20
[    0.000000] cpu_features      = 0x000000002514600a
[    0.000000]   possible        = 0x00000000277de00a
[    0.000000]   always          = 0x0000000001000000
[    0.000000] cpu_user_features = 0x9c000001 0x00000000
[    0.000000] mmu_features      = 0x00010001
[    0.000000] Hash_size         = 0x400000
[    0.000000] Hash_mask         = 0xffff
[    0.000000] -----------------------------------------------------
[    0.000000] ioremap() called early from pmac_setup_arch+0x1ac/0x448. Use early_ioremap() instead
[    0.000000] ioremap() called early from find_via_pmu+0x2a4/0x430. Use early_ioremap() instead
[    0.000000] ioremap() called early from find_via_pmu+0x2e0/0x430. Use early_ioremap() instead
[    0.000000] via-pmu: Server Mode is disabled
[    0.000000] PMU driver v2 initialized for Core99, firmware: 0c
[    0.000000] ioremap() called early from pmac_nvram_init+0x208/0x7c4. Use early_ioremap() instead
[    0.000000] nvram: Checking bank 0...
[    0.000000] nvram: gen0=3182, gen1=3183
[    0.000000] nvram: Active bank is: 1
[    0.000000] nvram: OF partition at 0x410
[    0.000000] nvram: XP partition at 0x1020
[    0.000000] nvram: NR partition at 0x1120
[    0.000000] Top of RAM: 0x80000000, Total RAM: 0x80000000
[    0.000000] Memory hole size: 0MB
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000000000-0x000000002fffffff]
[    0.000000]   Normal   empty
[    0.000000]   HighMem  [mem 0x0000000030000000-0x000000007fffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x000000007fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000007fffffff]
[    0.000000] percpu: Embedded 14 pages/cpu s24672 r8192 d24480 u57344
[    0.000000] pcpu-alloc: s24672 r8192 d24480 u57344 alloc=14*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 
[    0.000000] Kernel command line: ro root=/dev/sda5 zswap.max_pool_percent=16 slub_debug=FZP page_poison=1 netconsole=6666@192.168.178.8/eth0,6666@192.168.178.3/70:85:C2:30:EC:01 init=/usr/lib/systemd/systemd 
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 522560
[    0.000000] mem auto-init: stack:all(pattern), heap alloc:off, heap free:off
[    0.000000] stackdepot: allocating hash table via alloc_large_system_hash
[    0.000000] stackdepot hash table entries: 1048576 (order: 10, 4194304 bytes, linear)
[    0.000000] Kernel virtual memory layout:
[    0.000000]   * 0xf6000000..0xfec00000  : kasan shadow mem
[    0.000000]   * 0xf5bbf000..0xf5fff000  : fixmap
[    0.000000]   * 0xf5400000..0xf5800000  : highmem PTEs
[    0.000000]   * 0xf5115000..0xf5400000  : early ioremap
[    0.000000]   * 0xf1000000..0xf5110000  : vmalloc & ioremap
[    0.000000]   * 0xb0000000..0xc0000000  : modules
[    0.000000] Memory: 1946552K/2097152K available (16072K kernel code, 1964K rwdata, 4408K rodata, 1344K init, 402K bss, 150600K reserved, 0K cma-reserved, 1212416K highmem)
[    0.000000] **********************************************************
[    0.000000] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    0.000000] **                                                      **
[    0.000000] ** This system shows unhashed kernel memory addresses   **
[    0.000000] ** via the console, logs, and other interfaces. This    **
[    0.000000] ** might reduce the security of your system.            **
[    0.000000] **                                                      **
[    0.000000] ** If you see this message and you are not debugging    **
[    0.000000] ** the kernel, report this immediately to your system   **
[    0.000000] ** administrator!                                       **
[    0.000000] **                                                      **
[    0.000000] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    0.000000] **********************************************************
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] 	Tracing variant of Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 30 jiffies.
[    0.000000] NR_IRQS: 512, nr_irqs: 512, preallocated irqs: 16
[    0.000000] mpic: Resetting
[    0.000000] mpic: Setting up MPIC " MPIC 1   " version 1.2 at 80040000, max 2 CPUs
[    0.000000] mpic: ISU size: 64, shift: 6, mask: 3f
[    0.000000] mpic: Initializing for 64 sources
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] time_init: decrementer frequency = 41.658676 MHz
[    0.000000] time_init: processor frequency   = 1416.666661 MHz
[    0.000009] clocksource: timebase: mask: 0xffffffffffffffff max_cycles: 0x99b9699db, max_idle_ns: 440795204297 ns
[    0.000564] clocksource: timebase mult[18012db2] shift[24] registered
[    0.001064] clockevent: decrementer mult[aaa249b] shift[32] cpu[0]
[    0.003964] Console: colour dummy device 80x25
[    0.004498] printk: console [tty0] enabled
[    0.004958] printk: bootconsole [udbg0] disabled
[    0.006141] pid_max: default: 32768 minimum: 301
[    0.012419] LSM: initializing lsm=capability,yama
[    0.012513] Yama: becoming mindful.
[    0.014490] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.014713] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[    0.030652] PowerMac SMP probe found 2 cpus
[    0.031487] KeyWest i2c @0xf8001003 irq 42 /uni-n@f8000000/i2c@f8001000
[    0.031660]  channel 0 bus <multibus>
[    0.031776]  channel 1 bus <multibus>
[    0.032149] KeyWest i2c @0x80018000 irq 26 /pci@f2000000/mac-io@17/i2c@18000
[    0.032306]  channel 0 bus <multibus>
[    0.032445] PMU i2c /pci@f2000000/mac-io@17/via-pmu@16000/pmu-i2c
[    0.032593]  channel 1 bus <multibus>
[    0.032706]  channel 2 bus <multibus>
[    0.032778] pmf: no parser for command 17 !
[    0.032940] Processor timebase sync using GPIO 0x73
[    0.032976] mpic: requesting IPIs...
[    0.033342] CPU0: L2CR is 80000000
[    0.033374] CPU0: L3CR is 9c030000
[    0.039680] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1.
[    0.040993] MPC7450 family performance monitor hardware support registered
[    0.042001] rcu: Hierarchical SRCU implementation.
[    0.042052] rcu: 	Max phase no-delay instances is 1000.
[    0.045076] smp: Bringing up secondary CPUs ...
[84919679.163162] CPU1: L2CR was 0
[84919679.163249] CPU1: L2CR set to 80000000
[84919679.163261] CPU1: L3CR was 0
[84919679.163411] CPU1: L3CR set to 9c030000
[    0.051912] smp: Brought up 1 node, 2 CPUs
[    0.057883] devtmpfs: initialized
[    0.061705] Duplicate name in PowerPC,G4@0, renamed to "l2-cache#1"
[    0.062273] Duplicate name in l2-cache#1, renamed to "l2-cache#1"
[    0.064687] Duplicate name in PowerPC,G4@1, renamed to "l2-cache#1"
[    0.065267] Duplicate name in l2-cache#1, renamed to "l2-cache#1"
[    0.092116] Duplicate name in gpio@50, renamed to "gpio5@6f#1"
[    0.092534] Duplicate name in gpio@50, renamed to "gpio6@70#1"
[    0.093457] Duplicate name in gpio@50, renamed to "gpio11@75#1"
[    0.093993] Duplicate name in gpio@50, renamed to "extint-gpio15@67#1"
[    0.132210] Found UniNorth PCI host bridge at 0x00000000f0000000. Firmware bus number: 0->0
[    0.132349] PCI host bridge /pci@f0000000  ranges:
[    0.132449]  MEM 0x00000000f1000000..0x00000000f1ffffff -> 0x00000000f1000000 
[    0.132527]   IO 0x00000000f0000000..0x00000000f07fffff -> 0x0000000000000000
[    0.152864]  MEM 0x0000000090000000..0x00000000afffffff -> 0x0000000090000000 
[    0.153267] Found UniNorth PCI host bridge at 0x00000000f2000000. Firmware bus number: 0->0
[    0.153330] PCI host bridge /pci@f2000000 (primary) ranges:
[    0.153425]  MEM 0x00000000f3000000..0x00000000f3ffffff -> 0x00000000f3000000 
[    0.153502]   IO 0x00000000f2000000..0x00000000f27fffff -> 0x0000000000000000
[    0.174011]  MEM 0x0000000080000000..0x000000008fffffff -> 0x0000000080000000 
[    0.174995] Found UniNorth PCI host bridge at 0x00000000f4000000. Firmware bus number: 0->0
[    0.175114] PCI host bridge /pci@f4000000  ranges:
[    0.175215]  MEM 0x00000000f5000000..0x00000000f5ffffff -> 0x00000000f5000000 
[    0.175279]   IO 0x00000000f4000000..0x00000000f47fffff -> 0x0000000000000000
[    0.196114] Found NEC PD720100A USB2 chip with disabled EHCI, fixing up...
[    0.198329] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns
[    0.198773] futex hash table entries: 512 (order: 2, 16384 bytes, linear)
[    0.201307] prandom: seed boundary self test passed
[    0.209167] prandom: 100 self tests passed
[    0.216997] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.253617] PCI: Probing PCI hardware
[    0.256391] PCI host bridge to bus 0000:00
[    0.256476] pci_bus 0000:00: root bus resource [io  0xff780000-0xfff7ffff] (bus address [0x0000-0x7fffff])
[    0.256561] pci_bus 0000:00: root bus resource [mem 0xf1000000-0xf1ffffff]
[    0.256626] pci_bus 0000:00: root bus resource [mem 0x90000000-0xafffffff]
[    0.256801] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.256856] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to ff
[    0.258545] pci 0000:00:0b.0: [106b:0034] type 00 class 0x060000
[    0.260896] pci 0000:00:10.0: [1002:4150] type 00 class 0x030000
[    0.260988] pci 0000:00:10.0: reg 0x10: [mem 0xa0000000-0xafffffff pref]
[    0.261053] pci 0000:00:10.0: reg 0x14: [io  0xff780400-0xff7804ff]
[    0.261114] pci 0000:00:10.0: reg 0x18: [mem 0x90000000-0x9000ffff]
[    0.261199] pci 0000:00:10.0: reg 0x30: [mem 0x90020000-0x9003ffff pref]
[    0.261326] pci 0000:00:10.0: supports D1 D2
[    0.265205] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 00
[    0.267984] OF: /pci@f2000000/mac-io@17/gpio@50/gpio5@6f: could not find phandle 1751474532
[    0.268166] OF: /pci@f2000000/mac-io@17/gpio@50/extint-gpio15@67: could not find phandle 1751474532
[    0.268363] OF: /pci@f2000000/mac-io@17/gpio@50/gpio6@70: could not find phandle 1634562093
[    0.268529] OF: /pci@f2000000/mac-io@17/gpio@50/extint-gpio16@68: could not find phandle 1936745825
[    0.268728] OF: /pci@f2000000/mac-io@17/gpio@50/extint-gpio14@66: could not find phandle 1818848869
[    0.268920] OF: /pci@f2000000/mac-io@17/gpio@50/gpio12@76: could not find phandle 1835103092
[    0.269076] OF: /pci@f2000000/mac-io@17/gpio@50/gpio11@75: could not find phandle 1635083369
[    0.269223] OF: /pci@f2000000/mac-io@17/gpio@50/gpio5@6f: could not find phandle 1751474532
[    0.269371] OF: /pci@f2000000/mac-io@17/gpio@50/gpio6@70: could not find phandle 1634562093
[    0.269552] OF: /pci@f2000000/mac-io@17/gpio@50/extint-gpio4@5c: could not find phandle 1818848869
[    0.269750] OF: /pci@f2000000/mac-io@17/gpio@50/gpio11@75: could not find phandle 1635083369
[    0.269901] OF: /pci@f2000000/mac-io@17/gpio@50/extint-gpio15@67: could not find phandle 1751474532
[    0.273304] pci_bus 0001:00: Fixed dependency cycle(s) with /pci@f2000000/mac-io@17/interrupt-controller@40000
[    0.273586] PCI host bridge to bus 0001:00
[    0.273641] pci_bus 0001:00: root bus resource [io  0x0000-0x7fffff]
[    0.273705] pci_bus 0001:00: root bus resource [mem 0xf3000000-0xf3ffffff]
[    0.273769] pci_bus 0001:00: root bus resource [mem 0x80000000-0x8fffffff]
[    0.273836] pci_bus 0001:00: root bus resource [bus 00-ff]
[    0.273886] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to ff
[    0.275529] pci 0001:00:0b.0: [106b:0035] type 00 class 0x060000
[    0.278538] pci 0001:00:12.0: [1033:0035] type 00 class 0x0c0310
[    0.278626] pci 0001:00:12.0: reg 0x10: [mem 0x8008c000-0x8008cfff]
[    0.278790] pci 0001:00:12.0: supports D1 D2
[    0.278833] pci 0001:00:12.0: PME# supported from D0 D1 D2 D3hot
[    0.281074] pci 0001:00:12.1: [1033:0035] type 00 class 0x0c0310
[    0.281159] pci 0001:00:12.1: reg 0x10: [mem 0x8008b000-0x8008bfff]
[    0.281320] pci 0001:00:12.1: supports D1 D2
[    0.281362] pci 0001:00:12.1: PME# supported from D0 D1 D2 D3hot
[    0.283600] pci 0001:00:12.2: [1033:00e0] type 00 class 0x0c0320
[    0.283682] pci 0001:00:12.2: reg 0x10: [mem 0x80081000-0x800810ff]
[    0.283843] pci 0001:00:12.2: supports D1 D2
[    0.283885] pci 0001:00:12.2: PME# supported from D0 D1 D2 D3hot
[    0.285422] pci 0001:00:13.0: [1095:3112] type 00 class 0x018000
[    0.285499] pci 0001:00:13.0: reg 0x10: [io  0x0460-0x0467]
[    0.285557] pci 0001:00:13.0: reg 0x14: [io  0x0450-0x0453]
[    0.285612] pci 0001:00:13.0: reg 0x18: [io  0x0440-0x0447]
[    0.285666] pci 0001:00:13.0: reg 0x1c: [io  0x0430-0x0433]
[    0.285721] pci 0001:00:13.0: reg 0x20: [io  0x0420-0x042f]
[    0.285776] pci 0001:00:13.0: reg 0x24: [mem 0x80082000-0x800821ff]
[    0.285834] pci 0001:00:13.0: reg 0x30: [mem 0x80100000-0x8017ffff pref]
[    0.285951] pci 0001:00:13.0: supports D1 D2
[    0.288268] pci 0001:00:15.0: [9710:9865] type 00 class 0x070002
[    0.288355] pci 0001:00:15.0: reg 0x10: [io  0x0410-0x0417]
[    0.288414] pci 0001:00:15.0: reg 0x14: [mem 0x8008a000-0x8008afff]
[    0.288486] pci 0001:00:15.0: reg 0x20: [mem 0x80089000-0x80089fff]
[    0.288621] pci 0001:00:15.0: supports D1 D2
[    0.288662] pci 0001:00:15.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.290261] pci 0001:00:15.1: [9710:9865] type 00 class 0x070002
[    0.290341] pci 0001:00:15.1: reg 0x10: [io  0x0400-0x0407]
[    0.290399] pci 0001:00:15.1: reg 0x14: [mem 0x80088000-0x80088fff]
[    0.290471] pci 0001:00:15.1: reg 0x20: [mem 0x80087000-0x80087fff]
[    0.290604] pci 0001:00:15.1: supports D1 D2
[    0.290646] pci 0001:00:15.1: PME# supported from D0 D1 D2 D3hot D3cold
[    0.293510] pci 0001:00:15.2: [ffff:9865] type 00 class 0x070103
[    0.293595] pci 0001:00:15.2: reg 0x10: [io  0x0000-0x0007]
[    0.293652] pci 0001:00:15.2: reg 0x14: [io  0x0000-0x0007]
[    0.293708] pci 0001:00:15.2: reg 0x18: [mem 0x00000000-0x00000fff]
[    0.293772] pci 0001:00:15.2: reg 0x20: [mem 0x00000000-0x00000fff]
[    0.293905] pci 0001:00:15.2: supports D1 D2
[    0.293947] pci 0001:00:15.2: PME# supported from D0 D1 D2 D3hot D3cold
[    0.295438] pci 0001:00:16.0: [14e4:4320] type 00 class 0x028000
[    0.295516] pci 0001:00:16.0: reg 0x10: [mem 0x8008e000-0x8008ffff]
[    0.295672] pci 0001:00:16.0: supports D1 D2
[    0.295713] pci 0001:00:16.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.297902] pci 0001:00:17.0: [106b:0022] type 00 class 0xff0000
[    0.297985] pci 0001:00:17.0: reg 0x10: [mem 0x80000000-0x8007ffff]
[    0.299858] pci 0001:00:18.0: [106b:0019] type 00 class 0x0c0310
[    0.299941] pci 0001:00:18.0: reg 0x10: [mem 0x80086000-0x80086fff]
[    0.302054] pci 0001:00:19.0: [106b:0019] type 00 class 0x0c0310
[    0.302137] pci 0001:00:19.0: reg 0x10: [mem 0x80085000-0x80085fff]
[    0.304534] pci 0001:00:1b.0: [1033:0035] type 00 class 0x0c0310
[    0.304622] pci 0001:00:1b.0: reg 0x10: [mem 0x80084000-0x80084fff]
[    0.304785] pci 0001:00:1b.0: supports D1 D2
[    0.304828] pci 0001:00:1b.0: PME# supported from D0 D1 D2 D3hot D3cold
[    0.307118] pci 0001:00:1b.1: [1033:0035] type 00 class 0x0c0310
[    0.307202] pci 0001:00:1b.1: reg 0x10: [mem 0x80083000-0x80083fff]
[    0.307363] pci 0001:00:1b.1: supports D1 D2
[    0.307405] pci 0001:00:1b.1: PME# supported from D0 D1 D2 D3hot D3cold
[    0.309050] pci 0001:00:1b.2: [1033:00e0] type 00 class 0x0c0320
[    0.309128] pci 0001:00:1b.2: reg 0x10: [mem 0x80080000-0x800800ff]
[    0.309286] pci 0001:00:1b.2: supports D1 D2
[    0.309328] pci 0001:00:1b.2: PME# supported from D0 D1 D2 D3hot D3cold
[    0.311805] pci_bus 0001:00: busn_res: [bus 00-ff] end is updated to 00
[    0.317460] PCI host bridge to bus 0002:00
[    0.317542] pci_bus 0002:00: root bus resource [io  0x880000-0x107ffff] (bus address [0x0000-0x7fffff])
[    0.317620] pci_bus 0002:00: root bus resource [mem 0xf5000000-0xf5ffffff]
[    0.317688] pci_bus 0002:00: root bus resource [bus 00-ff]
[    0.317739] pci_bus 0002:00: busn_res: [bus 00-ff] end is updated to ff
[    0.319374] pci 0002:00:0b.0: [106b:0036] type 00 class 0x060000
[    0.321679] pci 0002:00:0d.0: [106b:0033] type 00 class 0xff0000
[    0.321762] pci 0002:00:0d.0: reg 0x10: [mem 0xf5004000-0xf5007fff]
[    0.324024] pci 0002:00:0e.0: [106b:0031] type 00 class 0x0c0010
[    0.324108] pci 0002:00:0e.0: reg 0x10: [mem 0xf5000000-0xf5000fff]
[    0.324262] pci 0002:00:0e.0: supports D1 D2
[    0.324304] pci 0002:00:0e.0: PME# supported from D0 D1 D2 D3hot
[    0.326443] pci 0002:00:0f.0: [106b:0032] type 00 class 0x020000
[    0.326525] pci 0002:00:0f.0: reg 0x10: [mem 0xf5200000-0xf53fffff]
[    0.326628] pci 0002:00:0f.0: reg 0x30: [mem 0xf5100000-0xf51fffff pref]
[    0.329978] pci_bus 0002:00: busn_res: [bus 00-ff] end is updated to 00
[    0.331526] PCI 0000:00 Cannot reserve Legacy IO [io  0xff780000-0xff780fff]
[    0.331610] PCI 0001:00 Cannot reserve Legacy IO [io  0x0000-0x0fff]
[    0.331691] pci_bus 0000:00: resource 4 [io  0xff780000-0xfff7ffff]
[    0.331744] pci_bus 0000:00: resource 5 [mem 0xf1000000-0xf1ffffff]
[    0.331793] pci_bus 0000:00: resource 6 [mem 0x90000000-0xafffffff]
[    0.331910] pci 0001:00:15.2: BAR 2: assigned [mem 0xf3000000-0xf3000fff]
[    0.331975] pci 0001:00:15.2: BAR 4: assigned [mem 0xf3001000-0xf3001fff]
[    0.332035] pci 0001:00:15.2: BAR 0: assigned [io  0x1000-0x1007]
[    0.332092] pci 0001:00:15.2: BAR 1: assigned [io  0x1008-0x100f]
[    0.332169] pci_bus 0001:00: resource 4 [io  0x0000-0x7fffff]
[    0.332218] pci_bus 0001:00: resource 5 [mem 0xf3000000-0xf3ffffff]
[    0.332268] pci_bus 0001:00: resource 6 [mem 0x80000000-0x8fffffff]
[    0.332323] pci_bus 0002:00: resource 4 [io  0x880000-0x107ffff]
[    0.332372] pci_bus 0002:00: resource 5 [mem 0xf5000000-0xf5ffffff]
[    0.409927] raid6: altivecx8 gen()   548 MB/s
[    0.466769] raid6: altivecx4 gen()   536 MB/s
[    0.523597] raid6: altivecx2 gen()   476 MB/s
[    0.580400] raid6: altivecx1 gen()   388 MB/s
[    0.637241] raid6: int32x8  gen()   139 MB/s
[    0.694157] raid6: int32x4  gen()   135 MB/s
[    0.751066] raid6: int32x2  gen()   118 MB/s
[    0.807727] raid6: int32x1  gen()    94 MB/s
[    0.807765] raid6: using algorithm altivecx8 gen() 548 MB/s
[    0.807803] raid6: using intx1 recovery algorithm
[    0.821302] SCSI subsystem initialized
[    0.824612] libata version 3.00 loaded.
[    0.826770] usbcore: registered new interface driver usbfs
[    0.827333] usbcore: registered new interface driver hub
[    0.828709] usbcore: registered new device driver usb
[    0.846285] pci 0000:00:10.0: vgaarb: setting as boot VGA device
[    0.846371] pci 0000:00:10.0: vgaarb: bridge control possible
[    0.846414] pci 0000:00:10.0: vgaarb: VGA device added: decodes=io+mem,owns=mem,locks=none
[    0.846529] vgaarb: loaded
[    0.848065] clocksource: Switched to clocksource timebase
[    0.982783] NET: Registered PF_INET protocol family
[    0.985942] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[    0.994624] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 10240 bytes, linear)
[    0.999364] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    1.001639] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[    1.011307] TCP bind hash table entries: 8192 (order: 6, 327680 bytes, linear)
[    1.013669] TCP: Hash tables configured (established 8192 bind 8192)
[    1.017018] UDP hash table entries: 512 (order: 2, 24576 bytes, linear)
[    1.017859] UDP-Lite hash table entries: 512 (order: 2, 24576 bytes, linear)
[    1.020020] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    1.021685] pci 0001:00:12.0: enabling device (0000 -> 0002)
[    1.021971] pci 0001:00:12.1: enabling device (0000 -> 0002)
[    1.022113] pci 0001:00:12.2: enabling device (0004 -> 0006)
[    1.022388] Apple USB OHCI 0001:00:18.0 disabled by firmware
[    1.022434] pci 0001:00:18.0: Can't enable PCI device, BIOS handoff failed.
[    1.022505] Apple USB OHCI 0001:00:19.0 disabled by firmware
[    1.022545] pci 0001:00:19.0: Can't enable PCI device, BIOS handoff failed.
[    1.022624] pci 0001:00:1b.0: enabling device (0000 -> 0002)
[    1.022752] pci 0001:00:1b.1: enabling device (0000 -> 0002)
[    1.022954] pci 0001:00:1b.2: enabling device (0004 -> 0006)
[    1.023151] pci 0002:00:0f.0: CLS mismatch (32 != 1020), using 32 bytes
[    1.024440] Thermal assist unit not available
[    1.039361] Initialise system trusted keyrings
[    1.041010] workingset: timestamp_bits=14 max_order=19 bucket_order=5
[    1.069295] fuse: init (API version 7.38)
[    1.072308] 9p: Installing v9fs 9p2000 file system support
[    1.074486] NET: Registered PF_ALG protocol family
[    1.074891] xor: measuring software checksum speed
[    1.152688]    8regs           :   126 MB/sec
[    1.231115]    8regs_prefetch  :   125 MB/sec
[    1.310215]    32regs          :   124 MB/sec
[    1.390281]    32regs_prefetch :   122 MB/sec
[    1.410126]    altivec         :   496 MB/sec
[    1.410165] xor: using function: altivec (496 MB/sec)
[    1.410285] Key type asymmetric registered
[    1.410328] Asymmetric key parser 'x509' registered
[    1.439114] bounce: pool size: 64 pages
[    1.441078] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    1.441148] io scheduler kyber registered
[    1.441798] io scheduler bfq registered
[    1.473450] MacIO PCI driver attached to Keylargo chipset
[    1.497453] 0.00013020:ch-a: ttyS0 at MMIO 0x80013020 (irq = 22, base_baud = 230400) is a Z85c30 ESCC - Serial port
[    1.507137] 0.00013000:ch-b: ttyS1 at MMIO 0x80013000 (irq = 23, base_baud = 230400) is a Z85c30 ESCC - Serial port
[    1.529258] sata_sil 0001:00:13.0: version 2.4
[    1.530216] sata_sil 0001:00:13.0: enabling device (0004 -> 0007)
[    1.542815] scsi host0: sata_sil
[    1.550723] scsi host1: sata_sil
[    1.553562] ata1: SATA max UDMA/100 mmio m512@0x80082000 tf 0x80082080 irq 53
[    1.553629] ata2: SATA max UDMA/100 mmio m512@0x80082000 tf 0x800820c0 irq 53
[    1.556348] pata-pci-macio 0002:00:0d.0: enabling device (0004 -> 0006)
[    1.571493] pata-pci-macio 0002:00:0d.0: Activating pata-macio chipset UniNorth ATA-6, Apple bus ID 3
[    1.581260] scsi host2: pata_macio
[    1.584446] ata3: PATA max UDMA/100 irq 39
[    1.868139] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[    1.871146] ata1.00: ATA-9: SanDisk SSD PLUS 240GB, UF4500RL, max UDMA/133
[    1.871210] ata1.00: 468877312 sectors, multi 1: LBA48 NCQ (depth 0/32)
[    1.872648] ata1.00: Features: Dev-Sleep
[    1.896336] ata1.00: configured for UDMA/100
[    1.897899] scsi 0:0:0:0: Direct-Access     ATA      SanDisk SSD PLUS 00RL PQ: 0 ANSI: 5
[    1.909703] sd 0:0:0:0: [sda] 468877312 512-byte logical blocks: (240 GB/224 GiB)
[    1.909989] sd 0:0:0:0: [sda] Write Protect is off
[    1.910065] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    1.910427] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.911116] sd 0:0:0:0: [sda] Preferred minimum I/O size 512 bytes
[    1.922193]  sda: [mac] sda1 sda2 sda3 sda4 sda5 sda6 sda7 sda8
[    1.937441] sd 0:0:0:0: [sda] Attached SCSI disk
[    2.334774] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[    2.337346] ata2.00: ATA-9: WDC WD5000LPLX-60ZNTT1, 02.01A02, max UDMA/133
[    2.337410] ata2.00: 976773168 sectors, multi 0: LBA48 NCQ (depth 0/32)
[    2.340108] ata2.00: configured for UDMA/100
[    2.341225] scsi 1:0:0:0: Direct-Access     ATA      WDC WD5000LPLX-6 1A02 PQ: 0 ANSI: 5
[    2.350688] sd 1:0:0:0: [sdb] 976773168 512-byte logical blocks: (500 GB/466 GiB)
[    2.350802] sd 1:0:0:0: [sdb] 4096-byte physical blocks
[    2.351052] sd 1:0:0:0: [sdb] Write Protect is off
[    2.351126] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[    2.351714] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.352235] sd 1:0:0:0: [sdb] Preferred minimum I/O size 4096 bytes
[    2.398105]  sdb: [mac] sdb1 sdb2 sdb3 sdb4 sdb5 sdb6 sdb7 sdb8
[    2.412884] sd 1:0:0:0: [sdb] Attached SCSI disk
[    2.614762] pata-macio 0.0001f000:ata-4: Activating pata-macio chipset KeyLargo ATA-4, Apple bus ID 2
[    2.625669] scsi host3: pata_macio
[    2.628459] ata4: PATA max UDMA/66 irq 19
[    2.787484] ata4.00: CFA: DeLOCK 54143 512MB, 100511E, max UDMA/66
[    2.787557] ata4.00: 1009008 sectors, multi 1: LBA 
[    2.792171] scsi 3:0:0:0: Direct-Access     ATA      DeLOCK 54143 512 11E  PQ: 0 ANSI: 5
[    2.800745] sd 3:0:0:0: [sdc] 1009008 512-byte logical blocks: (517 MB/493 MiB)
[    2.801218] sd 3:0:0:0: [sdc] Write Protect is off
[    2.801296] sd 3:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[    2.801738] sd 3:0:0:0: [sdc] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[    2.802260] sd 3:0:0:0: [sdc] Preferred minimum I/O size 512 bytes
[    2.812939]  sdc: [mac] sdc1 sdc2 sdc3 sdc4 sdc5 sdc6
[    2.827045] sd 3:0:0:0: [sdc] Attached SCSI disk
[    3.654761] pata-macio 0.00020000:ata-3: Activating pata-macio chipset KeyLargo ATA-3, Apple bus ID 0
[    3.664776] scsi host4: pata_macio
[    3.667501] ata5: PATA max MWDMA2 irq 20
[    3.669595] tun: Universal TUN/TAP device driver, 1.6
[    3.672887] sungem.c:v1.0 David S. Miller <davem@redhat.com>
[    3.685932] gem 0002:00:0f.0 eth0: Sun GEM (PCI) 10/100/1000BaseT Ethernet 00:0a:95:9c:76:3a
[    3.690477] ehci-pci 0001:00:12.2: EHCI Host Controller
[    3.690683] ehci-pci 0001:00:12.2: new USB bus registered, assigned bus number 1
[    3.692738] ehci-pci 0001:00:12.2: irq 52, io mem 0x80081000
[    3.697913] rtc-generic rtc-generic: registered as rtc0
[    3.700577] PowerMac i2c bus pmu 2 registered
[    3.702677] PowerMac i2c bus pmu 1 registered
[    3.704808] ehci-pci 0001:00:12.2: USB 2.0 started, EHCI 1.00
[    3.706744] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.05
[    3.706819] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.706872] usb usb1: Product: EHCI Host Controller
[    3.706913] usb usb1: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ehci_hcd
[    3.706958] usb usb1: SerialNumber: 0001:00:12.2
[    3.711079] PowerMac i2c bus mac-io 0 registered
[    3.711957] hub 1-0:1.0: USB hub found
[    3.712248] hub 1-0:1.0: 5 ports detected
[    3.712706] i2c i2c-2: No i2c address for /pci@f2000000/mac-io@17/i2c@18000/i2c-modem
[    3.714871] PowerMac i2c bus uni-n 1 registered
[    3.714948] i2c i2c-3: i2c-powermac: modalias failure on /uni-n@f8000000/i2c@f8001000/cereal@1c0
[    3.717061] PowerMac i2c bus uni-n 0 registered
[    3.721773] ehci-pci 0001:00:1b.2: EHCI Host Controller
[    3.721948] ehci-pci 0001:00:1b.2: new USB bus registered, assigned bus number 2
[    3.722899] ehci-pci 0001:00:1b.2: irq 63, io mem 0x80080000
[    3.725225] hid: raw HID events driver (C) Jiri Kosina
[    3.728618] usbcore: registered new interface driver usbhid
[    3.728676] usbhid: USB HID core driver
[    3.734794] ehci-pci 0001:00:1b.2: USB 2.0 started, EHCI 1.00
[    3.735100] NET: Registered PF_INET6 protocol family
[    3.737095] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.05
[    3.737182] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    3.737235] usb usb2: Product: EHCI Host Controller
[    3.737276] usb usb2: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ehci_hcd
[    3.737322] usb usb2: SerialNumber: 0001:00:1b.2
[    3.742981] hub 2-0:1.0: USB hub found
[    3.743269] hub 2-0:1.0: 5 ports detected
[    3.747360] Segment Routing with IPv6
[    3.748740] In-situ OAM (IOAM) with IPv6
[    3.749354] NET: Registered PF_PACKET protocol family
[    3.749445] NET: Registered PF_KEY protocol family
[    3.751461] 9pnet: Installing 9P2000 support
[    3.755003] drmem: No dynamic reconfiguration memory found
[    3.824092] ata5.00: ATAPI: _NEC DVD_RW ND-3520A, 1.04, max UDMA/33
[    3.832546] scsi 4:0:0:0: CD-ROM            _NEC     DVD_RW ND-3520A  1.04 PQ: 0 ANSI: 5
[    3.927092] Loading compiled-in X.509 certificates
[    3.966546] sr 4:0:0:0: [sr0] scsi3-mmc drive: 48x/48x writer cd/rw xa/form2 cdda tray
[    3.966649] cdrom: Uniform CD-ROM driver Revision: 3.20
[    3.968272] usb 1-3: new high-speed USB device number 2 using ehci-pci
[    3.986239] sr 4:0:0:0: Attached scsi CD-ROM sr0
[    4.023671] zswap: loaded using pool zstd/z3fold
[    4.118169] usb 1-3: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=32.98
[    4.118280] usb 1-3: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    4.118329] usb 1-3: Product: USB2.0 Hub
[    4.123089] hub 1-3:1.0: USB hub found
[    4.123640] hub 1-3:1.0: 4 ports detected
[    4.153333] debug_vm_pgtable: [debug_vm_pgtable         ]: Validating architecture page table helpers
[    4.268787] Btrfs loaded, zoned=no, fsverity=no
[    4.424884] usb 1-3.1: new low-speed USB device number 3 using ehci-pci
[    4.564928] usb 1-3.1: New USB device found, idVendor=04d9, idProduct=0006, bcdDevice= 1.40
[    4.565012] usb 1-3.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[    4.565065] usb 1-3.1: Product: RPI Wired Keyboard 5
[    4.565106] usb 1-3.1: Manufacturer:  
[    4.606038] input:   RPI Wired Keyboard 5 as /devices/pci0001:00/0001:00:12.2/usb1/1-3/1-3.1/1-3.1:1.0/0003:04D9:0006.0001/input/input0
[    4.681669] hid-generic 0003:04D9:0006.0001: input,hidraw0: USB HID v1.11 Keyboard [  RPI Wired Keyboard 5] on usb-0001:00:12.2-3.1/input0
[    4.714329] input:   RPI Wired Keyboard 5 as /devices/pci0001:00/0001:00:12.2/usb1/1-3/1-3.1/1-3.1:1.1/0003:04D9:0006.0002/input/input1
[    4.776156] hid-generic 0003:04D9:0006.0002: input,hidraw1: USB HID v1.11 Device [  RPI Wired Keyboard 5] on usb-0001:00:12.2-3.1/input1
[    4.864923] usb 1-3.4: new low-speed USB device number 4 using ehci-pci
[    4.973886] usb 1-3.4: New USB device found, idVendor=275d, idProduct=0ba6, bcdDevice= 1.00
[    4.973963] usb 1-3.4: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[    4.974017] usb 1-3.4: Product: USB OPTICAL MOUSE 
[    4.997224] input: USB OPTICAL MOUSE  as /devices/pci0001:00/0001:00:12.2/usb1/1-3/1-3.4/1-3.4:1.0/0003:275D:0BA6.0003/input/input2
[    5.007676] hid-generic 0003:275D:0BA6.0003: input,hidraw2: USB HID v1.11 Mouse [USB OPTICAL MOUSE ] on usb-0001:00:12.2-3.4/input0
[   10.210146] input: PMU as /devices/virtual/input/input3
[   10.212477] netpoll: netconsole: local port 6666
[   10.212532] netpoll: netconsole: local IPv4 address 192.168.178.8
[   10.212580] netpoll: netconsole: interface 'eth0'
[   10.212614] netpoll: netconsole: remote port 6666
[   10.212648] netpoll: netconsole: remote IPv4 address 192.168.178.3
[   10.212688] netpoll: netconsole: remote ethernet address 70:85:c2:30:ec:01
[   10.212741] netpoll: netconsole: device eth0 not up yet, forcing it
[   10.318492] sungem_phy: PHY ID: 2060e1, addr: 0
[   10.318802] gem 0002:00:0f.0 eth0: Found BCM5421 PHY
[   13.975079] gem 0002:00:0f.0 eth0: Link is up at 1000 Mbps, full-duplex
[   13.975267] gem 0002:00:0f.0 eth0: Pause is enabled (rxfifo: 10240 off: 7168 on: 5632)
[   13.990845] printk: console [netcon0] enabled
[   14.032432] netconsole: network logging started
[   14.234873] EXT4-fs (sda5): mounted filesystem 28419c7c-4bc4-4922-bdc8-6d8515c62385 ro with ordered data mode. Quota mode: disabled.
[   14.235425] VFS: Mounted root (ext4 filesystem) readonly on device 8:5.
[   14.240191] devtmpfs: mounted
[   14.244826] Freeing unused kernel image (initmem) memory: 1344K
[   14.271773] Checked W+X mappings: passed, no W+X pages found
[   14.272182] rodata_test: all tests were successful
[   14.272278] kallsyms_selftest: start
[   14.272349] Run /usr/lib/systemd/systemd as init process
[   14.272545]   with arguments:
[   14.272667]     /usr/lib/systemd/systemd
[   14.272747]   with environment:
[   14.272845]     HOME=/
[   14.272921]     TERM=linux
[   15.113868] systemd[1]: systemd 253 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)
[   15.114305] systemd[1]: Detected architecture ppc.
[   15.141876] systemd[1]: Hostname set to <T600>.
[   15.473677] memfd_create() without MFD_EXEC nor MFD_NOEXEC_SEAL, pid=1 'systemd'
[   18.153080] systemd[1]: Queued start job for default target graphical.target.
[   18.343874] systemd[1]: Created slice system-getty.slice.
[   18.360205] systemd[1]: Created slice system-modprobe.slice.
[   18.374517] systemd[1]: Created slice system-systemd\x2dfsck.slice.
[   18.388619] systemd[1]: Created slice system-vncserver.slice.
[   18.402332] systemd[1]: Created slice user.slice.
[   18.408259] systemd[1]: Started systemd-ask-password-console.path.
[   18.413518] systemd[1]: Started systemd-ask-password-wall.path.
[   18.425629] systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount.
[   18.427418] systemd[1]: Reached target paths.target.
[   18.428864] systemd[1]: Reached target remote-fs.target.
[   18.430801] systemd[1]: Reached target slices.target.
[   18.456561] systemd[1]: Listening on systemd-coredump.socket.
[   18.466070] systemd[1]: Listening on systemd-journald-dev-log.socket.
[   18.474286] systemd[1]: Listening on systemd-journald.socket.
[   18.485210] systemd[1]: Listening on systemd-udevd-control.socket.
[   18.493499] systemd[1]: Listening on systemd-udevd-kernel.socket.
[   18.502140] systemd[1]: dev-hugepages.mount was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/mm/hugepages).
[   18.536548] systemd[1]: Mounting dev-mqueue.mount...
[   18.609707] systemd[1]: Mounting sys-kernel-debug.mount...
[   18.621710] systemd[1]: sys-kernel-tracing.mount was skipped because of an unmet condition check (ConditionPathExists=/sys/kernel/tracing).
[   18.710365] systemd[1]: Starting kmod-static-nodes.service...
[   18.774251] systemd[1]: Starting modprobe@configfs.service...
[   18.854877] systemd[1]: Starting modprobe@dm_mod.service...
[   18.943840] systemd[1]: Starting modprobe@drm.service...
[   19.026548] device-mapper: uevent: version 1.0.3
[   19.044089] systemd[1]: Starting modprobe@fuse.service...
[   19.045410] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
[   19.107330] systemd[1]: Starting modprobe@loop.service...
[   19.201987] systemd[1]: Starting systemd-fsck-root.service...
[   19.354192] loop: module loaded
[   19.393967] systemd[1]: Starting systemd-journald.service...
[   19.507931] systemd[1]: Starting systemd-modules-load.service...
[   19.684660] systemd[1]: Starting systemd-udev-trigger.service...
[   19.961330] systemd-journald[106]: Collecting audit messages is disabled.
[   20.240894] systemd[1]: Mounted dev-mqueue.mount.
[   20.255800] systemd[1]: Mounted sys-kernel-debug.mount.
[   20.310786] systemd[1]: Finished kmod-static-nodes.service.
[   20.330666] systemd[1]: modprobe@configfs.service: Deactivated successfully.
[   20.336687] systemd[1]: Finished modprobe@configfs.service.
[   20.444335] systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
[   20.481044] systemd[1]: Finished modprobe@dm_mod.service.
[   20.497863] systemd[1]: modprobe@drm.service: Deactivated successfully.
[   20.504816] systemd[1]: Finished modprobe@drm.service.
[   20.540625] systemd[1]: modprobe@fuse.service: Deactivated successfully.
[   20.553226] systemd[1]: Finished modprobe@fuse.service.
[   20.621267] systemd[1]: modprobe@loop.service: Deactivated successfully.
[   20.626246] systemd[1]: Finished modprobe@loop.service.
[   20.635512] systemd[1]: Finished systemd-fsck-root.service.
[   20.643790] systemd[1]: Finished systemd-modules-load.service.
[   20.756259] systemd[1]: Mounting sys-fs-fuse-connections.mount...
[   20.926313] systemd[1]: Mounting sys-kernel-config.mount...
[   21.342437] systemd[1]: Starting systemd-remount-fs.service...
[   21.365299] systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met.
[   21.557867] systemd[1]: Starting systemd-sysctl.service...
[   21.849976] systemd[1]: Mounted sys-fs-fuse-connections.mount.
[   21.872235] systemd[1]: Mounted sys-kernel-config.mount.
[   22.340559] systemd[1]: Finished systemd-sysctl.service.
[   26.015770] systemd[1]: Finished systemd-remount-fs.service.
[   26.018680] systemd[1]: systemd-firstboot.service was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[   26.043296] systemd[1]: systemd-hwdb-update.service was skipped because of an unmet condition check (ConditionNeedsUpdate=/etc).
[   26.197874] systemd[1]: Starting systemd-random-seed.service...
[   26.207882] systemd[1]: systemd-sysusers.service was skipped because no trigger condition checks were met.
[   26.314358] systemd[1]: Starting systemd-tmpfiles-setup-dev.service...
[   27.561543] random: crng init done
[   27.599259] systemd[1]: Finished systemd-random-seed.service.
[   27.606049] systemd[1]: first-boot-complete.target was skipped because of an unmet condition check (ConditionFirstBoot=yes).
[   27.724001] systemd[1]: Started systemd-journald.service.
[   28.230421] systemd-journald[106]: Received client request to flush runtime journal.
[   28.446276] systemd-journald[106]: /var/log/journal/71303955349d475c9d69360df5e2c5b5/system.journal: Monotonic clock jumped backwards relative to last journal entry, rotating.
[   28.446590] systemd-journald[106]: Rotating system journal.
[   44.081765] BTRFS: device label g4_musl devid 1 transid 64495 /dev/sda4 scanned by (udev-worker) (135)
[   44.241776] BTRFS: device label tmp devid 1 transid 42 /dev/sda6 scanned by (udev-worker) (126)
[   47.760660] gem 0002:00:0f.0 enP2p0s15: renamed from eth0 (while UP)
[   48.898569] Adding 8388604k swap on /dev/sdb6.  Priority:-2 extents:1 across:8388604k FS
[   49.890775] kallsyms_selftest:  ---------------------------------------------------------
[   49.890986] kallsyms_selftest: | nr_symbols | compressed size | original size | ratio(%) |
[   49.891089] kallsyms_selftest: |---------------------------------------------------------|
[   49.891246] kallsyms_selftest: |      33860 |        364302   |       629830  |  57.84   |
[   49.891482] kallsyms_selftest:  ---------------------------------------------------------
[   50.726209] EXT4-fs (sdc5): mounting ext2 file system using the ext4 subsystem
[   50.756060] EXT4-fs (sdc5): mounted filesystem e4e8af9e-0f0d-44f9-b983-71bf61d782de r/w without journal. Quota mode: disabled.
[   50.756599] ext2 filesystem being mounted at /boot supports timestamps until 2038-01-19 (0x7fffffff)
[   52.800460] BTRFS info (device sda6): using xxhash64 (xxhash64-generic) checksum algorithm
[   52.800782] BTRFS info (device sda6): use lzo compression, level 0
[   52.800929] BTRFS info (device sda6): using free space tree
[   52.994498] BTRFS info (device sda6): enabling ssd optimizations
[   53.192481] ohci-pci 0001:00:12.0: OHCI PCI host controller
[   53.192783] ohci-pci 0001:00:12.0: new USB bus registered, assigned bus number 3
[   53.193551] ohci-pci 0001:00:12.0: irq 52, io mem 0x8008c000
[   53.882204] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[   53.882491] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   53.882640] usb usb3: Product: OHCI PCI host controller
[   53.882742] usb usb3: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ohci_hcd
[   53.882875] usb usb3: SerialNumber: 0001:00:12.0
[   53.904926] hub 3-0:1.0: USB hub found
[   53.951579] hub 3-0:1.0: 3 ports detected
[   54.006242] ohci-pci 0001:00:12.1: OHCI PCI host controller
[   54.006591] ohci-pci 0001:00:12.1: new USB bus registered, assigned bus number 4
[   54.007270] ohci-pci 0001:00:12.1: irq 52, io mem 0x8008b000
[   54.256063] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[   54.256347] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   54.256464] usb usb4: Product: OHCI PCI host controller
[   54.256594] usb usb4: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ohci_hcd
[   54.256725] usb usb4: SerialNumber: 0001:00:12.1
[   54.297676] hub 4-0:1.0: USB hub found
[   54.315067] hub 4-0:1.0: 2 ports detected
[   54.368864] Apple USB OHCI 0001:00:18.0 disabled by firmware
[   54.369218] Apple USB OHCI 0001:00:19.0 disabled by firmware
[   54.369818] ohci-pci 0001:00:1b.0: OHCI PCI host controller
[   54.370078] ohci-pci 0001:00:1b.0: new USB bus registered, assigned bus number 5
[   54.370857] ohci-pci 0001:00:1b.0: irq 63, io mem 0x80084000
[   54.493612] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[   54.493815] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   54.493930] usb usb5: Product: OHCI PCI host controller
[   54.494028] usb usb5: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ohci_hcd
[   54.494182] usb usb5: SerialNumber: 0001:00:1b.0
[   54.736147] hub 5-0:1.0: USB hub found
[   54.756739] hub 5-0:1.0: 3 ports detected
[   54.933457] ohci-pci 0001:00:1b.1: OHCI PCI host controller
[   54.933751] ohci-pci 0001:00:1b.1: new USB bus registered, assigned bus number 6
[   54.934441] ohci-pci 0001:00:1b.1: irq 63, io mem 0x80083000
[   55.072139] usb usb6: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.05
[   55.072401] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[   55.072547] usb usb6: Product: OHCI PCI host controller
[   55.072676] usb usb6: Manufacturer: Linux 6.5.0-rc6-PMacG4-dirty ohci_hcd
[   55.072781] usb usb6: SerialNumber: 0001:00:1b.1
[   55.173334] hub 6-0:1.0: USB hub found
[   55.195665] kallsyms_selftest: kallsyms_lookup_name() looked up 33860 symbols
[   55.195863] kallsyms_selftest: The time spent on each symbol is (ns): min=6697, max=1343610, avg=98598
[   55.197988] hub 6-0:1.0: 2 ports detected
[   55.288801] kallsyms_selftest: kallsyms_on_each_symbol() traverse all: 92821538 ns
[   55.289090] kallsyms_selftest: kallsyms_on_each_match_symbol() traverse all: 91745 ns
[   55.289198] kallsyms_selftest: finish
[   55.798773] b43-pci-bridge 0001:00:16.0: enabling device (0004 -> 0006)
[   55.799139] ssb: Found chip with id 0x4306, rev 0x02 and package 0x00
[   56.272906] b43-pci-bridge 0001:00:16.0: Sonics Silicon Backplane found on PCI device 0001:00:16.0
[   58.716327] firewire_ohci 0002:00:0e.0: enabling device (0000 -> 0002)
[   58.801716] firewire_ohci 0002:00:0e.0: added OHCI v1.10 device as card 0, 8 IR + 8 IT contexts, quirks 0x0
[   59.053876] [drm] radeon kernel modesetting enabled.
[   59.054546] radeon 0000:00:10.0: vgaarb: deactivate vga console
[   59.144372] radeon 0000:00:10.0: enabling device (0006 -> 0007)
[   59.229563] [drm] initializing kernel modesetting (RV350 0x1002:0x4150 0x1002:0x0002 0x00).
[   59.229779] [drm] Forcing AGP to PCI mode
[   59.235339] radeon 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x0000
[   59.373684] firewire_core 0002:00:0e.0: created device fw0: GUID 000a95fffe9c763a, S800
[   59.594867] ADM1030 fan controller [@2c]
[   59.619091] DS1775 digital thermometer [@49]
[   59.619273] Temp: 50.8 C
[   59.619293]   Hyst: 70.0 C
[   59.619382]   OS: 75.0 C
[   59.619524] 
[   60.208178] [drm] Generation 2 PCI interface, using max accessible memory
[   60.208479] radeon 0000:00:10.0: VRAM: 256M 0x00000000A0000000 - 0x00000000AFFFFFFF (256M used)
[   60.208617] radeon 0000:00:10.0: GTT: 512M 0x0000000080000000 - 0x000000009FFFFFFF
[   60.213985] [drm] Detected VRAM RAM=256M, BAR=256M
[   60.214198] [drm] RAM width 128bits DDR
[   60.256491] [drm] radeon: 256M of VRAM memory ready
[   60.281589] [drm] radeon: 512M of GTT memory ready.
[   60.282163] [drm] GART: num cpu pages 131072, num gpu pages 131072
[   61.008327] [drm] radeon: 1 quad pipes, 1 Z pipes initialized
[   61.008531] [drm] PCI GART of 512M enabled (table at 0x0000000009F00000).
[   61.008903] radeon 0000:00:10.0: WB enabled
[   61.009028] radeon 0000:00:10.0: fence driver on ring 0 use gpu addr 0x0000000080000000
[   61.098353] [drm] radeon: irq initialized.
[   61.098744] [drm] Loading R300 Microcode
[   61.614634] [drm] radeon: ring at 0x0000000080001000
[   61.634814] [drm] ring test succeeded in 0 usecs
[   61.694335] [drm] ib test succeeded in 0 usecs
[   62.109464] [drm] Radeon Display Connectors
[   62.109639] [drm] Connector 0:
[   62.109725] [drm]   DVI-I-1
[   62.109812] [drm]   HPD2
[   62.109894] [drm]   DDC: 0x64 0x64 0x64 0x64 0x64 0x64 0x64 0x64
[   62.109995] [drm]   Encoders:
[   62.110077] [drm]     CRT1: INTERNAL_DAC1
[   62.110165] [drm]     DFP2: INTERNAL_DVO1
[   62.110314] [drm] Connector 1:
[   62.110403] [drm]   DVI-I-2
[   62.110483] [drm]   HPD1
[   62.110561] [drm]   DDC: 0x60 0x60 0x60 0x60 0x60 0x60 0x60 0x60
[   62.110659] [drm]   Encoders:
[   62.110739] [drm]     CRT2: INTERNAL_DAC2
[   62.110826] [drm]     DFP1: INTERNAL_TMDS1
[   62.111114] [drm] Initialized radeon 2.50.0 20080528 for 0000:00:10.0 on minor 0
[   63.746847] [drm] fb mappable at 0xA0040000
[   63.747360] [drm] vram apper at 0xA0000000
[   63.747525] [drm] size 8294400
[   63.747618] [drm] fb depth is 24
[   63.747704] [drm]    pitch is 7680
[   64.040896] Console: switching to colour frame buffer device 240x67
[   64.929675] radeon 0000:00:10.0: [drm] fb0: radeondrmfb frame buffer device
[   67.685398] CPU-temp: 51.1 C
[   67.685448] , Case: 33.1 C
[   67.685953] ,  Fan: 0 (tuned -11)
[   75.202968] systemd-journald[106]: /var/log/journal/71303955349d475c9d69360df5e2c5b5/user-1000.journal: Monotonic clock jumped backwards relative to last journal entry, rotating.
[   75.243381] snd-aoa-fabric-layout: Using direct GPIOs
[   75.447423] snd-aoa-fabric-layout: can use this codec
[   75.555691] snd-aoa-codec-tas: tas found, addr 0x35 on /pci@f2000000/mac-io@17/i2c@18000/deq@6a
[   76.235964] cfg80211: Loading compiled-in X.509 certificates for regulatory database
[   77.038851] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
[   77.042388] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
[   77.043758] cfg80211: failed to load regulatory.db
[   78.472350] b43legacy-phy0: Broadcom 4306 WLAN found (core revision 4)
[   78.501500] b43legacy-phy0 debug: Found PHY: Analog 1, Type 2, Revision 1
[   78.502535] b43legacy-phy0 debug: Found Radio: Manuf 0x17F, Version 0x2050, Revision 2
[   78.532074] b43legacy-phy0 debug: Radio initialized
[   78.533939] b43legacy-phy0: Loading firmware b43legacy/ucode4.fw
[   78.538172] Broadcom 43xx-legacy driver loaded [ Features: PLID ]
[   78.633585] b43legacy-phy0: Loading firmware b43legacy/pcm4.fw
[   78.643246] b43legacy-phy0: Loading firmware b43legacy/b0g0initvals2.fw
[   78.654570] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
[  132.366810] EXT4-fs (sdc5): unmounting filesystem e4e8af9e-0f0d-44f9-b983-71bf61d782de.
[  134.302432] systemd-shutdown[1]: Syncing filesystems and block devices.
[  134.549227] systemd-shutdown[1]: Sending SIGTERM to remaining processes...
[  134.739759] systemd-journald[106]: Received SIGTERM from PID 1 (systemd-shutdow).
[  134.901564] systemd-shutdown[1]: Sending SIGKILL to remaining processes...
[  135.100091] systemd-shutdown[1]: Unmounting file systems.
[  135.180124] (sd-remount)[447]: Remounting '/' read-only with options ''.
[  135.244646] EXT4-fs (sda5): re-mounted 28419c7c-4bc4-4922-bdc8-6d8515c62385 ro. Quota mode: disabled.
[  135.519929] systemd-shutdown[1]: All filesystems unmounted.
[  135.552811] systemd-shutdown[1]: Deactivating swaps.
[  135.586407] systemd-shutdown[1]: All swaps deactivated.
[  135.618923] systemd-shutdown[1]: Detaching loop devices.
[  135.715850] systemd-shutdown[1]: All loop devices detached.
[  135.748659] systemd-shutdown[1]: Stopping MD devices.
[  135.782834] systemd-shutdown[1]: All MD devices stopped.
[  135.815197] systemd-shutdown[1]: Detaching DM devices.
[  135.849431] systemd-shutdown[1]: All DM devices detached.
[  135.882902] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.
[  135.983790] systemd-shutdown[1]: Syncing filesystems and block devices.
[  136.017835] systemd-shutdown[1]: Powering off.
[  136.052312] sd 3:0:0:0: [sdc] Stopping disk
[  136.086836] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[  136.121063] sd 1:0:0:0: [sdb] Stopping disk
[  136.481625] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  136.515566] sd 0:0:0:0: [sda] Stopping disk
[  136.561037] reboot: Power down