helloSystem / ISO

helloSystem Live and installation ISO
https://github.com/helloSystem/
BSD 3-Clause "New" or "Revised" License
806 stars 58 forks source link

13-CURRENT does not boot in Live mode on BIOS #11

Closed probonopd closed 3 years ago

probonopd commented 3 years ago

13-CURRENT based Live ISO does not boot. Getting

lock order reversal:
isofs -> bufwait established at:
(...)
md.c:895

Nevertheless it proceeds to loading the uzip, but then says

cannot mount tmpfs on /dev/reroot: operation not supported by device
emaste commented 3 years ago

Can you pastebin the whole boot log? I suspect the LOR does not actually impact the boot.

probonopd commented 3 years ago

Hi @emaste, thanks for commenting here. I need to find some way to get the boot log out of the machine...

probonopd commented 3 years ago

qemu can be used (albeit very slow) to get the boot log output out of the machine.

Using https://github.com/helloSystem/ISO/releases/tag/continuous-13.0-CURRENT:

sudo pkg install -y qemu-devel
LANG=C sudo /usr/local/bin/qemu-system-x86_64 -m 5G Downloads/hello-13.0-CURRENT-3cdcec0-amd64.iso
OK boot -v
Loading kernel...
/boot/kernel/kernel text=0x170198 text=0xd87e74 text=0x6874b0 data=0x140 data=0x1bab28+0x4444d8 syms=[0x8+0x17b470+0x8+0x19a96e]
Loading configured modules...
/boot/kernel/opensolaris.ko size 0xb7b8 at 0x2116000
/boot/kernel/geom_uzip.ko size 0xa700 at 0x2122000
loading required module 'xz'
/boot/kernel/xz.ko size 0x5e80 at 0x212d000
/boot/kernel/zfs.ko size 0x65e320 at 0x2133000
/data/ramdisk.ufs size=0xf88000
/boot/kernel/tmpfs.ko size 0x1c100 at 0x371a000
can't find '/etc/hostid'
GDB: no debug ports present
KDB: debugger backends: ddb
KDB: current backend: ddb
---<<BOOT>>---
APIC: Using the MADT enumerator.
Copyright (c) 1992-2020 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 13.0-CURRENT #0 2ed50808d2b-c254384(main): Thu Nov 12 07:29:09 UTC 2020
    root@releng1.nyi.freebsd.org:/usr/obj/usr/src/amd64.amd64/sys/GENERIC amd64
FreeBSD clang version 11.0.0 (git@github.com:llvm/llvm-project.git llvmorg-11.0.0-0-g176249bd673)
WARNING: WITNESS option enabled, expect reduced performance.
PPIM 0: PA=0xb8000, VA=0xffffffff83910000, size=0x8000, mode=0
pmap: large map 8 PML4 slots (4096 GB)
VT(vga): text 80x25
Preloaded elf kernel "/boot/kernel/kernel" at 0xffffffff83737000.
Preloaded elf obj module "/boot/kernel/opensolaris.ko" at 0xffffffff83740090.
Preloaded elf obj module "/boot/kernel/geom_uzip.ko" at 0xffffffff83740700.
Preloaded elf obj module "/boot/kernel/xz.ko" at 0xffffffff83740df0.
Preloaded elf obj module "/boot/kernel/zfs.ko" at 0xffffffff83741458.
Preloaded md_image "/data/ramdisk.ufs" at 0xffffffff83741c40.
Preloaded elf obj module "/boot/kernel/tmpfs.ko" at 0xffffffff83741c98.
Solaris: WARNING: ignoring tunable zfs_arc_max (using 0 instead)
module_register: cannot register tmpfs from kernel; already loaded from tmpfs.ko
Module tmpfs failed to register: 17
Calibrating TSC clock ... TSC clock: 2994731784 Hz
CPU: QEMU Virtual CPU version 2.5+ (2994.73-MHz K8-class CPU)
  Origin="AuthenticAMD"  Id=0x663  Family=0x6  Model=0x6  Stepping=3
  Features=0x783fbfd<FPU,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE,SSE2>
  Features2=0x80002001<SSE3,CX16,HV>
  AMD Features=0x20100800<SYSCALL,NX,LM>
  AMD Features2=0x5<LAHF,SVM>
  SVM: Features=0x0
Revision=1, ASIDs=16
L1 2MB data TLB: 255 entries, 1-way associative
L1 2MB instruction TLB: 255 entries, 1-way associative
L1 4KB data TLB: 255 entries, 1-way associative
L1 4KB instruction TLB: 255 entries, 1-way associative
L1 data cache: 64 kbytes, 64 bytes/line, 1 lines/tag, 2-way associative
L1 instruction cache: 64 kbytes, 64 bytes/line, 1 lines/tag, 2-way associative
L2 2MB unified TLB: 0 entries, disabled/not present
L2 4KB data TLB: 512 entries, 4-way associative
L2 4KB instruction TLB: 512 entries, 4-way associative
L2 unified cache: 512 kbytes, 64 bytes/line, 1 lines/tag, 16-way associative
Hypervisor: Origin = "TCGTCGTCGTCG"
real memory  = 5368709120 (5120 MB)
Physical memory chunk(s):
0x0000000000001000 - 0x000000000009efff, 647168 bytes (158 pages)
0x0000000000104000 - 0x00000000001fffff, 1032192 bytes (252 pages)
0x0000000003901000 - 0x00000000b5f87fff, 2993188864 bytes (730759 pages)
0x00000000bfc00000 - 0x00000000bfd43fff, 1327104 bytes (324 pages)
0x0000000100000000 - 0x000000017ffe7fff, 2147385344 bytes (524264 pages)
avail memory = 5112553472 (4875 MB)
MADT: Found CPU APIC ID 0 ACPI ID 0: enabled
SMP: Added CPU 0 (AP)
Event timer "LAPIC" quality 100
LAPIC: ipi_wait() us multiplier 1 (r 452734821 tsc 2994731784)
ACPI APIC Table: <BOCHS  BXPCAPIC>
APIC: CPU 0 has ACPI ID 0
x86bios:  IVT 0x000000-0x0004ff at 0xfffff80000000000
x86bios: SSEG 0x001000-0x001fff at 0xfffffe000ba59000
x86bios: EBDA 0x09f000-0x09ffff at 0xfffff8000009f000
x86bios:  ROM 0x0a0000-0x0fefff at 0xfffff800000a0000
Pentium Pro MTRR support enabled
random: no preloaded entropy cache
arc4random: WARNING: initial seeding bypassed the cryptographic random device because it was not yet seeded and the knob 'bypass_before_seeding' was enabled.
VIMAGE (virtualized network stack) enabled
hostuuid: using 00000000-0000-0000-0000-000000000000
ULE: setup cpu 0
ACPI: RSDP 0x00000000000F58B0 000014 (v00 BOCHS )
ACPI: RSDT 0x00000000BFFE14D2 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
ACPI: FACP 0x00000000BFFE1386 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
ACPI: DSDT 0x00000000BFFE0040 001346 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
ACPI: FACS 0x00000000BFFE0000 000040
ACPI: APIC 0x00000000BFFE13FA 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
ACPI: HPET 0x00000000BFFE1472 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
ACPI: WAET 0x00000000BFFE14AA 000028 (v01 BOCHS  BXPCWAET 00000001 BXPC 00000001)
MADT: Found IO APIC ID 0, Interrupt 0 at 0xfec00000
ioapic0: ver 0x20 maxredir 0x17
ioapic0: Routing external 8259A's -> intpin 0
MADT: Interrupt override: source 0, irq 2
ioapic0: Routing IRQ 0 -> intpin 2
MADT: Interrupt override: source 5, irq 5
ioapic0: intpin 5 trigger: level
MADT: Interrupt override: source 9, irq 9
ioapic0: intpin 9 trigger: level
MADT: Interrupt override: source 10, irq 10
ioapic0: intpin 10 trigger: level
MADT: Interrupt override: source 11, irq 11
ioapic0: intpin 11 trigger: level
lapic: Routing NMI -> LINT1
lapic: LINT1 trigger: edge
lapic: LINT1 polarity: high
ioapic0 <Version 2.0> irqs 0-23
lapic: Divisor 2, Frequency 500390470 Hz
cpu0 BSP:
     ID: 0x00000000   VER: 0x00050014 LDR: 0x00000000 DFR: 0xffffffff
  lint0: 0x00010700 lint1: 0x00000400 TPR: 0x00000000 SVR: 0x000001ff
  timer: 0x000100ef therm: 0x00010000 err: 0x000000f0 pmc: 0x00010400
TSC timecounter discards lower 1 bit(s)
Timecounter "TSC-low" frequency 1497365892 Hz quality 800
snd_unit_init() u=0x00ff8000 [512] d=0x00007c00 [32] c=0x000003ff [1024]
feeder_register: snd_unit=-1 snd_maxautovchans=16 latency=2 feeder_rate_min=1 feeder_rate_max=2016000 feeder_rate_round=25
random: entropy device external interface
wlan: <802.11 Link Layer>
EFI systbl not available
tcp_log: tcp_log device
crypto: <crypto core>
kbd: new array size 4
WARNING: Device "kbd" is Giant locked and may be deleted before FreeBSD 13.0.
kbd1 at kbdmux0
mem: <memory>
io: <I/O>
000.000040 [4346] netmap_init               netmap: loaded module
null: <full device, null device, zero device>
[ath_hal] loaded
nexus0
vtvga0: <VT VGA driver>
cryptosoft0: <software crypto>
crypto: assign cryptosoft0 driver id 0, flags 0x6000000
acpi0: <BOCHS BXPCRSDT>
ACPI: 1 ACPI AML tables successfully acquired and loaded
ioapic0: routing intpin 9 (ISA IRQ 9) to lapic 0 vector 48
acpi0: Power Button (fixed)
acpi0: wakeup code va 0xfffffe000bbb9000 pa 0x9e000
cpu0: <ACPI CPU> on acpi0
cpu0: switching to generic Cx mode
atrtc0: <AT realtime clock> port 0x70-0x77 irq 8 on acpi0
atrtc0: registered as a time-of-day clock, resolution 1.000000s
ioapic0: routing intpin 8 (ISA IRQ 8) to lapic 0 vector 49
Event timer "RTC" frequency 32768 Hz quality 0
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
hpet0: vendor 0x8086, rev 0x1, 100000000Hz 64bit, 3 timers, legacy route
hpet0:  t0: irqs 0x00000004 (0), 64bit, periodic
hpet0:  t1: irqs 0x00000004 (0), 64bit, periodic
hpet0:  t2: irqs 0x00000004 (0), 64bit, periodic
Timecounter "HPET" frequency 100000000 Hz quality 950
ACPI timer: 1/362 1/2 1/12 1/11 1/3 1/2 1/25 1/2 1/2 1/1 -> 10
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x608-0x60b on acpi0
pci_link0:        Index  IRQ  Rtd  Ref  IRQs
  Initial Probe       0   10   N     0  5 10 11
  Validation          0   10   N     0  5 10 11
  After Disable       0  255   N     0  5 10 11
pci_link1:        Index  IRQ  Rtd  Ref  IRQs
  Initial Probe       0   10   N     0  5 10 11
  Validation          0   10   N     0  5 10 11
  After Disable       0  255   N     0  5 10 11
pci_link2:        Index  IRQ  Rtd  Ref  IRQs
  Initial Probe       0   11   N     0  5 10 11
  Validation          0   11   N     0  5 10 11
  After Disable       0  255   N     0  5 10 11
pci_link3:        Index  IRQ  Rtd  Ref  IRQs
  Initial Probe       0   11   N     0  5 10 11
  Validation          0   11   N     0  5 10 11
  After Disable       0  255   N     0  5 10 11
pci_link4:        Index  IRQ  Rtd  Ref  IRQs
  Initial Probe       0    9   N     0  9
  Validation          0    9   N     0  9
  After Disable       0  255   N     0  9
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pcib0: decoding 5 range 0-0xff
pcib0: decoding 4 range 0-0xcf7
pcib0: decoding 4 range 0xd00-0xffff
pcib0: decoding 3 range 0xa0000-0xbffff
pcib0: decoding 3 range 0xc0000000-0xfebfffff
pcib0: decoding 3 range 0x180000000-0x1ffffffff
ACPI: Found matching pin for 0.1.INTA at func 3: 9
ACPI: Found matching pin for 0.3.INTA at func 0: 11
pci0: <ACPI PCI bus> on pcib0
pci0: domain=0, physical bus=0
found-> vendor=0x8086, dev=0x1237, revid=0x02
    domain=0, bus=0, slot=0, func=0
    class=06-00-00, hdrtype=0x00, mfdev=0
    cmdreg=0x0103, statreg=0x0000, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
found-> vendor=0x8086, dev=0x7000, revid=0x00
    domain=0, bus=0, slot=1, func=0
    class=06-01-00, hdrtype=0x00, mfdev=1
    cmdreg=0x0103, statreg=0x0200, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
found-> vendor=0x8086, dev=0x7010, revid=0x00
    domain=0, bus=0, slot=1, func=1
    class=01-01-80, hdrtype=0x00, mfdev=0
    cmdreg=0x0103, statreg=0x0280, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
pcib0: allocated type 4 (0x1f0-0x1f7) for rid 10 of pci0:0:1:1
pcib0: allocated type 4 (0x3f6-0x3f6) for rid 14 of pci0:0:1:1
pcib0: allocated type 4 (0x170-0x177) for rid 18 of pci0:0:1:1
pcib0: allocated type 4 (0x376-0x376) for rid 1c of pci0:0:1:1
    map[20]: type I/O Port, range 32, base 0xc040, size  4, enabled
pcib0: allocated type 4 (0xc040-0xc04f) for rid 20 of pci0:0:1:1
found-> vendor=0x8086, dev=0x7113, revid=0x03
    domain=0, bus=0, slot=1, func=3
    class=06-80-00, hdrtype=0x00, mfdev=0
    cmdreg=0x0103, statreg=0x0280, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
    intpin=a, irq=9
pcib0: matched entry for 0.1.INTA (src \_SB_.LNKS:0)
pcib0: slot 1 INTA routed to irq 9 via \_SB_.LNKS
found-> vendor=0x1234, dev=0x1111, revid=0x02
    domain=0, bus=0, slot=2, func=0
    class=03-00-00, hdrtype=0x00, mfdev=0
    cmdreg=0x0103, statreg=0x0000, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
    map[10]: type Prefetchable Memory, range 32, base 0xfd000000, size 24, enabled
pcib0: allocated type 3 (0xfd000000-0xfdffffff) for rid 10 of pci0:0:2:0
    map[18]: type Memory, range 32, base 0xfebf0000, size 12, enabled
pcib0: allocated type 3 (0xfebf0000-0xfebf0fff) for rid 18 of pci0:0:2:0
found-> vendor=0x8086, dev=0x100e, revid=0x03
    domain=0, bus=0, slot=3, func=0
    class=02-00-00, hdrtype=0x00, mfdev=0
    cmdreg=0x0103, statreg=0x0000, cachelnsz=0 (dwords)
    lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns)
    intpin=a, irq=11
    map[10]: type Memory, range 32, base 0xfebc0000, size 17, enabled
pcib0: allocated type 3 (0xfebc0000-0xfebdffff) for rid 10 of pci0:0:3:0
    map[14]: type I/O Port, range 32, base 0xc000, size  6, enabled
pcib0: allocated type 4 (0xc000-0xc03f) for rid 14 of pci0:0:3:0
pcib0: matched entry for 0.3.INTA (src \_SB_.LNKC:0)
pcib0: slot 3 INTA routed to irq 11 via \_SB_.LNKC
isab0: <PCI-ISA bridge> at device 1.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel PIIX3 WDMA2 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xc040-0xc04f at device 1.1 on pci0
ata0: <ATA channel> at channel 0 on atapci0
ioapic0: routing intpin 14 (ISA IRQ 14) to lapic 0 vector 50
ata1: <ATA channel> at channel 1 on atapci0
ioapic0: routing intpin 15 (ISA IRQ 15) to lapic 0 vector 51
pci0: <bridge> at device 1.3 (no driver attached)
vgapci0: <VGA-compatible display> mem 0xfd000000-0xfdffffff,0xfebf0000-0xfebf0fff at device 2.0 on pci0
vgapci0: Boot video device
em0: <Intel(R) PRO/1000 Network Connection> port 0xc000-0xc03f mem 0xfebc0000-0xfebdffff irq 11 at device 3.0 on pci0
em0: attach_pre capping queues at 1
em0: Using 1024 TX descriptors and 1024 RX descriptors
em0: allocated for 1 tx_queues
em0: allocated for 1 rx_queues
ioapic0: routing intpin 11 (ISA IRQ 11) to lapic 0 vector 52
em0: bpf attached
em0: Ethernet address: 52:54:00:12:34:56
em0: netmap queues/slots: TX 1/1024, RX 1/1024
acpi_syscontainer0: <System Container> on acpi0
acpi_syscontainer1: <System Container> port 0xaf00-0xaf0b on acpi0
acpi_syscontainer2: <System Container> port 0xafe0-0xafe3 on acpi0
acpi_syscontainer3: <System Container> port 0xae00-0xae13 on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
atkbd: the current kbd controller command byte 0061
atkbd: keyboard ID 0x41ab (2)
kbdc: RESET_KBD return code:00fa
kbdc: RESET_KBD status:00aa
kbd0 at atkbd0
kbd0: atkbd0, AT 101/102 (2), config:0x0, flags:0x1d0000
ioapic0: routing intpin 1 (ISA IRQ 1) to lapic 0 vector 53
atkbd0: [GIANT-LOCKED]
psm0: unable to allocate IRQ
psmcpnp0: <PS/2 mouse port> irq 12 on acpi0
psm0: current command byte:0061
kbdc: TEST_AUX_PORT status:0000
kbdc: RESET_AUX return code:00fa
kbdc: RESET_AUX status:00aa
kbdc: RESET_AUX ID:0000
kbdc: RESET_AUX return code:00fa
kbdc: RESET_AUX status:00aa
kbdc: RESET_AUX ID:0000
psm: status 00 02 64
psm: status 00 00 64
psm: status 00 03 64
psm: status 00 03 64
psm: data 08 00 00
psm: status 00 02 64
psm0: <PS/2 Mouse> irq 12 on atkbdc0
ioapic0: routing intpin 12 (ISA IRQ 12) to lapic 0 vector 54
psm0: [GIANT-LOCKED]
WARNING: Device "psm" is Giant locked and may be deleted before FreeBSD 13.0.
psm0: model IntelliMouse Explorer, device ID 4-00, 5 buttons
psm0: config:00000000, flags:00000008, packet size:4
psm0: syncmask:08, syncbits:00
fdc0: <floppy drive controller (FDE)> port 0x3f2-0x3f5,0x3f7 irq 6 drq 2 on acpi0
fdc0: does not respond
device_attach: fdc0 attach returned 6
ppc0: using extended I/O port range
ppc0: SPP
ppc0: <Parallel port> port 0x378-0x37f irq 7 on acpi0
ppc0: Generic chipset (NIBBLE-only) in COMPATIBLE mode
ioapic0: routing intpin 7 (ISA IRQ 7) to lapic 0 vector 55
ppbus0: <Parallel port bus> on ppc0
lpt0: <Printer> on ppbus0
lpt0: Interrupt-driven port
ppi0: <Parallel I/O> on ppbus0
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
uart0: console (9600,n,8,1)
ioapic0: routing intpin 4 (ISA IRQ 4) to lapic 0 vector 56
uart0: fast interrupt
uart0: PPS capture mode: DCD
ACPI: Enabled 2 GPEs in block 00 to 0F
ahc_isa_identify 0: ioport 0xc00 alloc failed
ahc_isa_identify 1: ioport 0x1c00 alloc failed
ahc_isa_identify 2: ioport 0x2c00 alloc failed
ahc_isa_identify 3: ioport 0x3c00 alloc failed
ahc_isa_identify 4: ioport 0x4c00 alloc failed
ahc_isa_identify 5: ioport 0x5c00 alloc failed
ahc_isa_identify 6: ioport 0x6c00 alloc failed
ahc_isa_identify 7: ioport 0x7c00 alloc failed
ahc_isa_identify 8: ioport 0x8c00 alloc failed
ahc_isa_identify 9: ioport 0x9c00 alloc failed
ahc_isa_identify 10: ioport 0xac00 alloc failed
ahc_isa_identify 11: ioport 0xbc00 alloc failed
ahc_isa_identify 12: ioport 0xcc00 alloc failed
ahc_isa_identify 13: ioport 0xdc00 alloc failed
ahc_isa_identify 14: ioport 0xec00 alloc failed
pcib0: allocated type 3 (0xb0000-0xb07ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb0800-0xb0fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb1000-0xb17ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb1800-0xb1fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb2000-0xb27ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb2800-0xb2fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb3000-0xb37ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb3800-0xb3fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb4000-0xb47ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb4800-0xb4fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb5000-0xb57ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb5800-0xb5fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb6000-0xb67ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb6800-0xb6fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb7000-0xb77ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb7800-0xb7fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb8000-0xb87ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb8800-0xb8fff) for rid 0 of orm0
pcib0: allocated type 3 (0xb9000-0xb97ff) for rid 0 of orm0
pcib0: allocated type 3 (0xb9800-0xb9fff) for rid 0 of orm0
pcib0: allocated type 3 (0xba000-0xba7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xba800-0xbafff) for rid 0 of orm0
pcib0: allocated type 3 (0xbb000-0xbb7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xbb800-0xbbfff) for rid 0 of orm0
pcib0: allocated type 3 (0xbc000-0xbc7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xbc800-0xbcfff) for rid 0 of orm0
pcib0: allocated type 3 (0xbd000-0xbd7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xbd800-0xbdfff) for rid 0 of orm0
pcib0: allocated type 3 (0xbe000-0xbe7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xbe800-0xbefff) for rid 0 of orm0
pcib0: allocated type 3 (0xbf000-0xbf7ff) for rid 0 of orm0
pcib0: allocated type 3 (0xbf800-0xbffff) for rid 0 of orm0
isa_probe_children: disabling PnP devices
atkbdc: atkbdc0 already exists; skipping it
atrtc: atrtc0 already exists; skipping it
ppc: ppc0 already exists; skipping it
sc: sc0 already exists; skipping it
uart: uart0 already exists; skipping it
isa_probe_children: probing non-PnP devices
orm0: <ISA Option ROM> at iomem 0xea000-0xeffff pnpid ORM0000 on isa0
sc0 failed to probe on isa0
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff pnpid PNP0900 on isa0
pcib0: allocated type 4 (0x3c0-0x3df) for rid 0 of vga0
VESA: INT 0x10 vector 0xc000:0x566c
VESA: information block
0000   56 45 53 41 00 03 11 59 00 c0 01 00 00 00 22 00
0010   00 04 00 01 00 00 25 59 00 c0 38 59 00 c0 4c 59
0020   00 c0 00 01 01 01 02 01 03 01 04 01 05 01 06 01
0030   07 01 0d 01 0e 01 0f 01 10 01 11 01 12 01 13 01
0040   14 01 15 01 16 01 17 01 18 01 19 01 1a 01 1b 01
0050   1c 01 1d 01 1e 01 1f 01 40 01 41 01 42 01 43 01
0060   44 01 45 01 46 01 47 01 48 01 49 01 4a 01 4b 01
0070   4c 01 75 01 76 01 77 01 78 01 79 01 7a 01 7b 01
0080   7c 01 7d 01 7e 01 7f 01 80 01 81 01 82 01 83 01
0090   84 01 85 01 86 01 87 01 88 01 89 01 8a 01 8b 01
00a0   8c 01 8d 01 8e 01 8f 01 90 01 91 01 92 01 93 01
00b0   94 01 95 01 96 01 97 01 98 01 00 00 01 00 02 00
00c0   03 00 04 00 05 00 06 00 07 00 0d 00 0e 00 0f 00
00d0   10 00 11 00 12 00 13 00 6a 00 ff ff 00 00 00 00
00e0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
00f0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0100   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0110   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0120   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0130   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0140   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0150   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0160   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0170   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0180   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0190   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01a0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01b0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01c0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01d0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01e0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01f0   00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
VESA: 92 mode(s) found
attimer0: <AT timer> at port 0x40 on isa0
pcib0: allocated type 4 (0x40-0x43) for rid 0 of attimer0
Timecounter "i8254" frequency 1193182 Hz quality 0
ioapic0: routing intpin 2 (ISA IRQ 0) to lapic 0 vector 57
Event timer "i8254" frequency 1193182 Hz quality 100
attimer0: non-PNP ISA device will be removed from GENERIC in FreeBSD 12.
fdc0: No FDOUT register!
fdc0 failed to probe at port 0x3f0 irq 6 drq 2 on isa0
pcib0: allocated type 4 (0x2f8-0x2f8) for rid 0 of uart1
uart1 failed to probe at port 0x2f8 irq 3 on isa0
isa_probe_children: probing PnP devices
Device configuration finished.
procfs registered
module_register_init: MOD_LOAD (tmpfs, 0xffffffff80cb4ef0, 0xffffffff83726b10) error 17
Timecounters tick every 10.000 msec
md0: Preloaded image </data/ramdisk.ufs> 16285696 bytes at 0xffffffff82791320
Solaris: WARNING: ignoring tunable zfs_arc_max (using 4236746752 instead)
ZFS filesystem version: 5
ZFS storage pool version: features support (5000)
lo0: bpf attached
vlan: initialized, using hash tables with chaining
IPsec: Initialized Security Association Processing.
tcp_init: net.inet.tcp.tcbhashsize auto tuned to 65536
usb_needs_explore_all: no devclass
ata0: reset tp1 mask=03 ostat0=50 ostat1=00
sysctl_unregister_oid: failed(22) to unregister sysctl(tmpfs)
WARNING: WITNESS option enabled, expect reduced performance.
ata0: stat0=0x50 err=0x01 lsb=0x00 msb=0x00
ata0: stat1=0x00 err=0x00 lsb=0xff msb=0xff
ata0: reset tp2 stat0=50 stat1=00 devices=0x1
ata1: reset tp1 mask=03 ostat0=50 ostat1=00
ata1: stat0=0x00 err=0x01 lsb=0x14 msb=0xeb
ata1: stat1=0x00 err=0x00 lsb=0xff msb=0xff
ata1: reset tp2 stat0=00 stat1=00 devices=0x10000
Trying to mount root from ufs:/dev/md0 []...
Root mount waiting for: CAM
ada0 at ata0 bus 0 scbus0 target 0 lun 0
ada0: <QEMU HARDDISK 2.5+> ATA-7 device
ada0: Serial Number QM00001
ada0: 16.700MB/s transfers (WDMA2, PIO 8192bytes)
ada0: 1906MB (3903732 512 byte sectors)
pass0 at ata0 bus 0 scbus0 target 0 lun 0
pass0: <QEMU HARDDISK 2.5+> ATA-7 device
pass0: Serial Number QM00001
pass0: 16.700MB/s transfers (WDMA2, PIO 8192bytes)
pass1 at ata1 bus 0 scbus1 target 0 lun 0
pass1: GEOM: new disk ada0
GEOM: ada0: the secondary GPT table is corrupt or invalid.
GEOM: ada0: using the primary only -- recovery suggested.
GEOM: iso9660/FURYBSD: the secondary GPT table is corrupt or invalid.
GEOM: iso9660/FURYBSD: using the primary only -- recovery suggested.
<QEMU QEMU DVD-ROM 2.5+> Removable CD-ROM SCSI device
pass1: Serial Number QM00003
pass1: 16.700MB/s transfers (WDMA2, ATAPI 12bytes, PIO 65534bytes)
cd0 at ata1 bus 0 scbus1 target 0 lun 0
cd0: <QEMU QEMU DVD-ROM 2.5+> Removable CD-ROM SCSI device
cd0: Serial Number QM00003
cd0: 16.700MB/s transfers (WDMA2, ATAPI 12bytes, PIO 65534bytes)
cd0: Attempt to query device size failed: NOT READY, Medium not present
GEOM: new disk cd0
atrtc0: providing initial system time
start_init: trying /rescue/init
==> Remount rootfs as read-write
==> Make mountpoints
Waiting for FURYBSD media to initialize
found /dev/iso9660/FURYBSD
==> Mount cdrom
cd9660: RockRidge Extension
mdconfig: WARNING: opening backing store: /cdrom/data/system.uzip readonly
random: unblocking device.
lock order reversal:
 1st 0xfffffe0041e0c3c0 bufwait (bufwait, lockmgr) @ /usr/src/sys/vm/vm_pager.c:391
 2nd 0xfffff80004f1b258 isofs (isofs, lockmgr) @ /usr/src/sys/dev/md/md.c:985
lock order isofs -> bufwait established at:
#0 0xffffffff80c50f6d at witness_checkorder+0x46d
#1 0xffffffff80bb301c at lockmgr_xlock_hard+0x6c
#2 0xffffffff80bb3d33 at __lockmgr_args+0x613
#3 0xffffffff80c9ec14 at getnewbuf+0x334
#4 0xffffffff80c9c0ae at getblkx+0x34e
#5 0xffffffff80c9bb54 at breadn_flags+0x44
#6 0xffffffff80b638dc at cd9660_blkatoff+0x5c
#7 0xffffffff80b65d36 at cd9660_vget_internal+0x266
#8 0xffffffff80cba7e0 at vfs_domount+0xa30
#9 0xffffffff80cb93e2 at vfs_donmount+0x872
#10 0xffffffff80cb8b39 at sys_nmount+0x69
#11 0xffffffff8102ec7b at amd64_syscall+0x12b
#12 0xffffffff81001d7e at fast_syscall_common+0xf8
lock order bufwait -> isofs attempted at:
#0 0xffffffff80c518cc at witness_checkorder+0xdcc
#1 0xffffffff80bb2938 at lockmgr_lock_flags+0x188
#2 0xffffffff80cdb214 at _vn_lock+0x54
#3 0xffffffff806f2d76 at mdstart_vnode+0x496
#4 0xffffffff806f099e at md_kthread+0x1fe
#5 0xffffffff80b9db70 at fork_exit+0x80
#6 0xffffffff810024ae at fork_trampoline+0xe
Required memory 3163787264 for memdisk
Detected memory 5310488576 for memdisk
==> Mount swap-based memdisk
==> Replicate system image to swap-based memdisk
  1719664640 bytes (1720 MB, 1640 MiB) transferred 3040.194s, 566 kB/s
0+330684 records in
1151+1422 records out
1723446416 bytes transferred in 3043.073398 secs (566351 bytes/sec)
lock order reversal:
 1st 0xfffff80004f02440 zfs (zfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:1016
 2nd 0xfffff80004f02258 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:1027
lock order zfs -> devfs attempted at:
#0 0xffffffff80c518cc at witness_checkorder+0xdcc
#1 0xffffffff80bb4385 at lockmgr_xlock+0x55
#2 0xffffffff80cdb214 at _vn_lock+0x54
#3 0xffffffff80cbac18 at vfs_domount+0xe68
#4 0xffffffff80cb93e2 at vfs_donmount+0x872
#5 0xffffffff80cb8b39 at sys_nmount+0x69
#6 0xffffffff8102ec7b at amd64_syscall+0x12b
#7 0xffffffff81001d7e at fast_syscall_common+0xf8
init_shell="/rescue/sh"
==> Unset rescue init kernel environment variables
==> Unmount filesystems for cloning
lock order reversal:
 1st 0xfffff80004f1bbe0 ufs (ufs, lockmgr) @ /usr/src/sys/kern/vfs_mount.c:1724
 2nd 0xfffff80004f1b810 devfs (devfs, lockmgr) @ /usr/src/sys/kern/vfs_subr.c:3132
lock order devfs -> ufs established at:
#0 0xffffffff80c50f6d at witness_checkorder+0x46d
#1 0xffffffff80bb2938 at lockmgr_lock_flags+0x188
#2 0xffffffff80ea18a1 at ffs_lock+0x71
#3 0xffffffff80cdb214 at _vn_lock+0x54
#4 0xffffffff80cbac18 at vfs_domount+0xe68
#5 0xffffffff80cb93e2 at vfs_donmount+0x872
#6 0xffffffff80cbd707 at kernel_mount+0x57
#7 0xffffffff80cc0031 at parse_mount+0x4a1
#8 0xffffffff80cbe539 at vfs_mountroot+0x589
#9 0xffffffff80b73e8f at start_init+0x1f
#10 0xffffffff80b9db70 at fork_exit+0x80
#11 0xffffffff810024ae at fork_trampoline+0xe
lock order ufs -> devfs attempted at:
#0 0xffffffff80c518cc at witness_checkorder+0xdcc
#1 0xffffffff80bb2938 at lockmgr_lock_flags+0x188
#2 0xffffffff80cdb214 at _vn_lock+0x54
#3 0xffffffff80cc47e1 at vput_final+0x111
#4 0xffffffff80b66e31 at cd9660_unmount+0xb1
#5 0xffffffff80cbbcdc at dounmount+0x42c
#6 0xffffffff80cbb83c at kern_unmount+0x2ec
#7 0xffffffff8102ec7b at amd64_syscall+0x12b
#8 0xffffffff81001d7e at fast_syscall_common+0xf8
== Set /dev/md2 device for reroot
vfs.root.mountfrom="zfs:livecd"
==> Rerooting into memdisk
2020-11-25T17:47:22.558391+00:00 - init 1 - - cannot mount tmpfs on /dev/reroot: Operation not supported by device
2020-11-25T17:47:22.585087+00:00 - init 1 - - reroot failed; going to single user mode
Enter full pathname of shell or RETURN for /rescue/sh: 
emaste commented 3 years ago

Thanks, I'll see what I can find.

probonopd commented 3 years ago

Thanks @emaste. Could it be that we need cryptodev_load="YES"?

emaste commented 3 years ago

kib points out "[ENODEV] is returned by vfs_mount when there is no registered fs and it cannot load the module"

Could be OpenZFS (i.e. the switch from the original ZFS port to OpenZFS) needs cryptodev loaded explicitly? You can also try kldloading it from the single user shell and then running reboot -r there.

probonopd commented 3 years ago

@pkgdemon recommended to make this change:

https://github.com/helloSystem/ISO/commit/a66a4a7aca2600ce85eaa8d2a9eafa0719902fcb

Let's see how it goes.

(According to @pkgdemon, zfs and its dependencies are about the only things we have to really load early.)

probonopd commented 3 years ago

This is on VirtualBox:

UEFI booting is completely broken on the 13-CURRENT ISO:

image

BIOS booting goes further, but still can't boot the Live ISO:

VirtualBox_FreeBSD_03_12_2020_22_07_30

probonopd commented 3 years ago

@pkgdemon hinted me at

https://github.com/adriaandegroot/furybsd-livecd/commit/17c007e43606eb7296651edf323d10a8615ad7c6

Will have a deep look. Especially at the tmpfs stuff.

probonopd commented 3 years ago

hello-13.0-CURRENT-f4159dc-amd64.iso DOES boot now. Thanks for your help!

probonopd commented 3 years ago

EFI defective, MBR also does not boot on Acer Revo RL85

probonopd commented 3 years ago

TODO: 13 allows us to use zstd, and since it seems to be better, why not use it while we are at it.

Clarification by darkain on irc:

openzfs_load is if you're using zfs from pkg instead of base, for those that want to use openzfs 2.0 (like zstd) on 12.2...

For something so essential as the boot fileystem i would never want anything that is not in base.

probonopd commented 3 years ago

https://reviews-dev.freebsd.org/rS366738 increased the size of the EFI ESP partition to 2048 without further reasoning. Maybe it will fix the EFI issue? It does.

BIOS boot still broken though.

grahamperrin commented 3 years ago

Today's hello-13.0-CURRENT-3d72a66-amd64.iso written to a USB flash drive (stress-tested 32 GB Kingston DataTraveler 3.0 PMAP s/n C860008AE288BF4189030BBD)

Ergo Vista 631

Circa 2008. Success, with the drive in one of the two rear ports:

  1. text for boot stages one and two
  2. the FreeBSD logo during the third and (multi-user) last stages –𢀓 presumably loader(1) builtin commands boot_mute
  3. the Ergo splash screen for a split-second
  4. helloSystem desktop environment.

Off-topic from boot: the touch pad is not driven, this might fall under https://github.com/helloSystem/ISO/issues/49#issuecomment-751280022

Note to self: in other situations (with e.g. NomadBSD) the late reappearance of the splash screen is sometimes much longer than a split-second.

probonopd commented 3 years ago

Your computer's splash screen appears after the FreeBSD splash screen?

probonopd commented 3 years ago

Probably this ticket can be closed as the 13-CURRENT experimental builds seem to boot on BIOS devices.

grahamperrin commented 3 years ago

Your computer's splash screen appears after the FreeBSD splash screen?

Yeah. Weird, and if I recall correctly I haven't seen this with anything other than NomadBSD and helloSystem.

probonopd commented 3 years ago

Possible explanation that helloSystem is using initgfx from NomadBSD (albeit a newer version than they do themselves).

probonopd commented 3 years ago

Confirmed working, the 13-CURRENT experimental builds are now booting on BIOS devices.

probonopd commented 2 years ago

Since I ran into the exact same issue a year later again while reworking the Live ISO architecture:

In FreeBSD 13, when one preloads the tmpfs module using the bootloader, then tmpfs is completely broken. Apparently the kernel contains a working tmpfs implementation, but when the non-working tmpfs module is preloaded using the bootloader, it wins over the working one in the kernel, resulting in broken tmpfs.

module_register: cannot register tmpfs from kernel; already loaded from tmpfs.ko
Module tmpfs failed to register: 17

module_register_init: MOD_LOAD (tmpfs, 0xffffffff80cb4ef0, 0xffffffff83726b10) error 17

(...)

cannot mount tmpfs on ...: Operation not supported by device

So the question is: If FreeBSD 13 has a working tmpfs in the kernel, why is there also a tmpfs module at all?