Opened 44 hours ago

Last modified 23 hours ago

#19360 closed bug

VM page fault related to AVLTreeBase RAMFS — at Initial Version

Reported by: dovsienko Owned by: nobody
Priority: normal Milestone: R1/beta6
Component: File Systems/RAMFS Version: R1/Development
Keywords: Cc:
Blocked By: Blocking:
Platform: All

Description

The problem reproduced two times shortly after booting hrev58538. The first KDL had AVLTreeBase::Remove() in the backtrace, the second had AVLTreeBase::Insert(), both have RAMFS. The factor that triggered the problem is a Perl script, which runs 4 busy workers, each of which uses a few temporary files (TMPDIR=/boot/system/var/shared_memory). System memory usage stays around 450MB, the VM (VirtualBox) has 2GB RAM and 4 CPU cores.

For the second case a complete output of the serial console follows.

options = 0
APM version 0.0 available, flags 0.
smp: using ACPI to detect MP configuration
smp: local apic address is 0xfee00000
smp: found local APIC with id 0
smp: found local APIC with id 1
smp: found local APIC with id 2
smp: found local APIC with id 3
smp: found io APIC with id 4 and address 0xfec00000
VESA version = 2.0, capabilities 1
OEM string: VirtualBox VESA BIOS
 0x100: 640 x 400 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x101: 640 x 480 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x102: 800 x 600 x 4 (a = 31, mem = 3, phy = e0000000, p = 4, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x103: 800 x 600 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x104: 1024 x 768 x 4 (a = 31, mem = 3, phy = e0000000, p = 4, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x105: 1024 x 768 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x106: 1280 x 1024 x 4 (a = 31, mem = 3, phy = e0000000, p = 4, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x107: 1280 x 1024 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x10d: 320 x 200 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x10e: 320 x 200 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x10f: 320 x 200 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x110: 640 x 480 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x111: 640 x 480 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x112: 640 x 480 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x113: 800 x 600 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x114: 800 x 600 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x115: 800 x 600 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x116: 1024 x 768 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x117: 1024 x 768 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x118: 1024 x 768 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x119: 1280 x 1024 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x11a: 1280 x 1024 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x11b: 1280 x 1024 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x140: 320 x 200 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x141: 640 x 400 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x142: 640 x 480 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x143: 800 x 600 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x144: 1024 x 768 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x145: 1280 x 1024 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x146: 320 x 200 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x147: 1600 x 1200 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
 0x148: 1152 x 864 x 8 (a = 155, mem = 4, phy = e0000000, p = 1, b = 1)
	mask: r: 0 0 g: 0 0 b: 0 0 dcmi: 0
 0x149: 1152 x 864 x 15 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 10 g: 5 5 b: 5 0 dcmi: 0
 0x14a: 1152 x 864 x 16 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 5 11 g: 6 5 b: 5 0 dcmi: 0
 0x14b: 1152 x 864 x 24 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 0
 0x14c: 1152 x 864 x 32 (a = 155, mem = 6, phy = e0000000, p = 1, b = 1)
	mask: r: 8 16 g: 8 8 b: 8 0 dcmi: 2
Using mode 0x144
VESA compatible graphics!
Welcome to the Haiku boot loader!
Haiku revision: hrev58538
number of drives: 1
add_partitions_for(0x001014b8, mountFS = no)
add_partitions_for(fd = 0, mountFS = no)
0x00101620 Partition::Partition
0x00101620 Partition::Scan()
check for partitioning_system: GUID Partition Map
check for partitioning_system: Intel Partition Map
  priority: 810
check for partitioning_system: Intel Extended Partition
0x00101798 Partition::Partition
0x00101620 Partition::AddChild 0x00101798
0x00101798 Partition::SetParent 0x00101620
new child partition!
0x00101620 Partition::Scan(): scan child 0x00101798 (start = 32768, size = 23621271552, parent = 0x00101620)!
0x00101798 Partition::Scan()
check for partitioning_system: GUID Partition Map
check for partitioning_system: Intel Partition Map
check for partitioning_system: Intel Extended Partition
0x00101620 Partition::~Partition
0x00101798 Partition::SetParent 0x00000000
boot partition offset: 32768
0x00101798 Partition::_Mount check for file_system: BFS Filesystem
PackageVolumeInfo::SetTo()
load kernel kernel_x86_64...
video mode: 800x600x32
ucode_load: system/non-packaged/data/firmware/intel-ucode/06-3a-09
ucode_load: couldn't find microcode
smp: found 4 cpus
smp: apic_phys = 0xfee00000
smp: ioapic_phys = 0xfec00000
smp: apic (mapped) = 0x81afb000
APIC ticks/sec = 988557077
GDT at 0x5ee80
phys memory ranges:
    base 0x0000000000100000, length 0x000000007fef0000
allocated phys memory ranges:
    base 0x0000000000100000, length 0x0000000000181000
    base 0x0000000000800000, length 0x0000000000a63000
    base 0x0000000003f00000, length 0x0000000000100000
allocated virt memory ranges:
    base 0xffffffff80000000, length 0x0000000001b09000
maximum boot loader heap usage: 783216, currently used: 554184
kernel args ranges:
    base 0xffffffff81107000, length 0x000000000006e000
    base 0xffffffff8134a000, length 0x000000000002e000
    base 0xffffffff813c5000, length 0x0000000000010000
    base 0xffffffff8142b000, length 0x0000000000010000
    base 0xffffffff8144a000, length 0x0000000000010000
    base 0xffffffff81524000, length 0x000000000002d000
    base 0xffffffff817b7000, length 0x0000000000010000
    base 0xffffffff81807000, length 0x0000000000010000
    base 0xffffffff8185d000, length 0x0000000000010000
    base 0xffffffff818a4000, length 0x0000000000010000
    base 0xffffffff818ef000, length 0x0000000000010000
    base 0xffffffff81934000, length 0x0000000000010000
    base 0xffffffff819dc000, length 0x0000000000010000
    base 0xffffffff81a21000, length 0x000000000001e000
    base 0xffffffff81a63000, length 0x0000000000010000
    base 0xffffffff81ad1000, length 0x0000000000010000
    base 0xffffffff81ae7000, length 0x0000000000010000
kernel entry at 0xffffffff800699b0
Welcome to kernel debugger output!
Haiku revision: hrev58538, debug level: 2
CPU: no microcode provided
CPU 0: type 0 family 6 extended_family 0 model 10 extended_model 3 stepping 9, string 'GenuineIntel'
CPU 0: vendor 'Intel' model name 'Intel(R) Core(TM) i7-3770 CPU @ 3.40GHz'
CPU 0: apic id 0, package 0, core 0, smt 0
CPU 0: cache sharing: L1 id 0, L2 id 0, L3 id 0
CPU 0: features: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clfsh mmx fxsr sse sse2 htt sse3 pclmulqdq ssse3 cx16 pcid sse4_1 sse4_2 popcnt aes xsave avx f16c rdrnd hypervisor syscall nx long arat l1d_flush constant_tsc 
CPU 0: patch_level 0x0
using PAT for memory type configuration
PAT MSR on CPU 0 before init: 0x7040600070406
PAT MSR on CPU 0 after init: 0x7040100070406
reserve_io_interrupt_vectors: reserved 16 vectors starting from 0
mark_page_range_in_use(0x0, 0x100): start page is before free list
mark_page_range_in_use(0x0, 0xa0): start page is before free list
mapping local apic at 0xffffffff81afb000
arch_altcodepatch_replace found 2 altcodepatches for tag 3
arch_altcodepatch_replace found 4 altcodepatches for tag 4
enable XSAVE 0x7 832
CPU 3: type 0 family 6 extended_family 0 model 10 extended_model 3 stepping 9, string 'GenuineIntel'
CPU 1: type 0 family 6 extended_family 0 model 10 extended_model 3 stepping 9, string 'GenuineIntel'
CPU 2: type 0 family 6 extended_family 0 model 10 extended_model 3 stepping 9, string 'GenuineIntel'
CPU 3: vendor 'Intel' model name 'Intel(R) Core(TM) i7-3770 CPU @ 3.40GHz'
CPU 2: vendor 'Intel' model name 'Intel(R) Core(TM) i7-3770 CPU @ 3.40GHz'
CPU 3: apic id 3, package 0, core 3, smt 0
CPU 3: cache sharing: L1 id 3, L2 id 3, L3 id 3
CPU 1: vendor 'Intel' model name 'Intel(R) Core(TM) i7-3770 CPU @ 3.40GHz'
CPU 1: apic id 1, package 0, core 1, smt 0
CPU 1: cache sharing: L1 id 1, L2 id 1, L3 id 1
CPU 1: features: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clfsh mmx fxsr sse sse2 htt sse3 pclmulqdq ssse3 cx16 pcid sse4_1 sse4_2 popcnt aes xsave osxsave avx f16c rdrnd hypervisor syscall nx long arat l1d_flush constant_tsc 
CPU 1: patch_level 0x0
CPU 3: features: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clfsh mmx fxsr sse sse2 htt sse3 pclmulqdq ssse3 cx16 pcid sse4_1 sse4_2 popcnt aes xsave osxsave avx f16c rdrnd hypervisor syscall nx long arat l1d_flush constant_tsc 
PAT MSR on CPU 1 before init: 0x7040600070406
CPU 3: patch_level 0x0
CPU 2: apic id 2, package 0, core 2, smt 0
PAT MSR on CPU 3 before init: 0x7040600070406
PAT MSR on CPU 1 after init: 0x7040100070406
PAT MSR on CPU 3 after init: 0x7040100070406
CPU 2: cache sharing: L1 id 2, L2 id 2, L3 id 2
CPU 2: features: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clfsh mmx fxsr sse sse2 htt sse3 pclmulqdq ssse3 cx16 pcid sse4_1 sse4_2 popcnt aes xsave osxsave avx f16c rdrnd hypervisor syscall nx long arat l1d_flush constant_tsc 
CPU 2: patch_level 0x0
PAT MSR on CPU 2 before init: 0x7040600070406
PAT MSR on CPU 2 after init: 0x7040100070406
setting up apic for CPU 0: apic id 0, version 327700
CPU 0: logical apic id: 0x1
x86_init_fpu: CPU has SSE... enabling FXSR and XMM.
reserve_io_interrupt_vectors: reserved 3 vectors starting from 221
reserve_io_interrupt_vectors: reserved 1 vectors starting from 219
arch_init_timer: using APIC timer.
allocate_commpage_entry(2, 16) -> 0x0000000000000200
scheduler_init: found 4 logical cpus and 3 cache levels
scheduler switches: single core: false, cpu load tracking: false, core load tracking: true
scheduler: switching to low latency mode
msi support enabled
setting up apic for CPU 3: apic id 3, version 327700
CPU 3: logical apic id: 0x8
setting up apic for CPU 1: apic id 1, version 327700
setting up apic for CPU 2: apic id 2, version 327700
x86_init_fpu: CPU has SSE... enabling FXSR and XMM.
CPU 1: logical apic id: 0x2
x86_init_fpu: CPU has SSE... enabling FXSR and XMM.
CPU 2: logical apic id: 0x4
x86_init_fpu: CPU has SSE... enabling FXSR and XMM.
slab memory manager: created area 0xffffffff80801000 (159)
allocate_commpage_entry(3, 69) -> 0x0000000000000210
PCI: pci_module_init
slab memory manager: created area 0xffffffff86001000 (161)
assuming memory type 50000000 for overlapping 0x0, 0x1000 area 165 from existing 0x0, 0xa0000 area 3
assuming memory type 50000000 for overlapping 0x9f000, 0x1000 area 166 from existing 0x0, 0xa0000 area 3
ACPI: RSDP 0x00000000000E0000 000024 (v02 VBOX  )
ACPI: XSDT 0x000000007FFF0030 00003C (v01 VBOX   VBOXXSDT 00000001 ASL  00000061)
ACPI: FACP 0x000000007FFF00F0 0000F4 (v04 VBOX   VBOXFACP 00000001 ASL  00000061)
ACPI: DSDT 0x000000007FFF0620 002353 (v02 VBOX   VBOXBIOS 00000002 INTL 20200925)
ACPI: FACS 0x000000007FFF0200 000040
ACPI: APIC 0x000000007FFF0240 00006C (v02 VBOX   VBOXAPIC 00000001 ASL  00000061)
ACPI: SSDT 0x000000007FFF02B0 00036C (v01 VBOX   VBOXCPUT 00000002 INTL 20200925)
ACPI: Forced DSDT copy: length 0x02353 copied locally, original unmapped
ACPI: 2 ACPI AML tables successfully acquired and loaded
ACPI: Enabled 2 GPEs in block 00 to 07
publish device: node 0xffffffff8215cbe0, path acpi/namespace, module bus_managers/acpi/namespace/device_v1
publish device: node 0xffffffff8215cbe0, path acpi/call, module bus_managers/acpi/call/device_v1
registering power button
registering sleep button
PCI: mechanism 1 controller found
PCI: find_pci_capability ERROR 0:12:0 capability 0x5 empty list
PCI: find_pci_capability ERROR 0:12:0 capability 0x11 empty list
PCI: find_pci_capability ERROR 0:12:0 capability 0x8 empty list
found io-apic with address 0xfec00000, global interrupt base 0, apic-id 4
mapping io-apic 0 at physical address 0xfec00000
io-apic 0 has range 0-23, 24 entries, version 0x00170020, apic-id 4
setting ACPI interrupt model to APIC
IRQ routing table with 7 entries
address 0x2ffff; pin 0; GSI 18; pci 0:2 pin 1 func mask 1; bios irq: 10; gsi 18; config 0x06
address 0x4ffff; pin 0; GSI 20; pci 0:4 pin 1 func mask 1; bios irq: 11; gsi 20; config 0x06
address 0x7ffff; pin 0; GSI 23; pci 0:7 pin 1 func mask 1; bios irq: 9; gsi 23; config 0x06
address 0x8ffff; pin 0; GSI 16; pci 0:8 pin 1 func mask 1; bios irq: 11; gsi 16; config 0x06
address 0xcffff; pin 0; GSI 20; pci 0:12 pin 1 func mask 1; bios irq: 11; gsi 20; config 0x06
address 0xdffff; pin 0; GSI 21; pci 0:13 pin 1 func mask 1; bios irq: 11; gsi 21; config 0x06
address 0x11ffff; pin 0; GSI 17; pci 0:17 pin 1 func mask 1; bios irq: 11; gsi 17; config 0x06
found interrupt override for bus 0, source irq 0, global irq 2, flags 0x00000000
found interrupt override for bus 0, source irq 9, global irq 9, flags 0x0000000f
free_io_interrupt_vectors: freeing 16 vectors starting from 0
reserve_io_interrupt_vectors: reserved 24 vectors starting from 0
using io-apics for interrupt routing
PCI: find_pci_capability ERROR 0:12:0 capability 0x5 empty list
PCI: find_pci_capability ERROR 0:12:0 capability 0x11 empty list
PCI: find_pci_capability ERROR 0:12:0 capability 0x8 empty list
PCI: [dom 0, bus  0] bus   0, device  0, function  0: vendor 8086, device 1237, revision 02
PCI:   class_base 06, class_function 00, class_api 00
PCI:   vendor 8086: Intel Corporation
PCI:   device 1237: 440FX - 82441FX PMC [Natoma]
PCI:   info: Bridge (Host bridge)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 00, interrupt_pin 00, min_grant 00, max_latency 00
PCI:   base reg 0: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (not supported)
PCI: [dom 0, bus  0] bus   0, device  1, function  0: vendor 8086, device 7000, revision 00
PCI:   class_base 06, class_function 01, class_api 00
PCI:   vendor 8086: Intel Corporation
PCI:   device 7000: 82371SB PIIX3 ISA [Natoma/Triton II]
PCI:   info: Bridge (ISA bridge)
PCI:   line_size 00, latency 00, header_type 80, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 00, interrupt_pin 00, min_grant 00, max_latency 00
PCI:   base reg 0: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (not supported)
PCI: [dom 0, bus  0] bus   0, device  2, function  0: vendor 15ad, device 0405, revision 00
PCI:   class_base 03, class_function 00, class_api 00
PCI:   vendor 15ad: VMware
PCI:   device 0405: SVGA II Adapter
PCI:   info: Display controller (VGA compatible controller, VGA controller)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0405, subsystem_vendor_id 15ad
PCI:   interrupt_line 12, interrupt_pin 01, min_grant 00, max_latency 00
PCI:   base reg 0: host 0000d000, pci 0000d000, size 00000010, flags 01
PCI:   base reg 1: host e0000000, pci e0000000, size 04000000, flags 08
PCI:   base reg 2: host f0000000, pci f0000000, size 00200000, flags 00
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (not supported)
PCI: [dom 0, bus  0] bus   0, device  4, function  0: vendor 80ee, device cafe, revision 00
PCI:   class_base 08, class_function 80, class_api 00
PCI:   vendor 80ee: InnoTek Systemberatung GmbH
PCI:   device cafe: VirtualBox Guest Service
PCI:   info: Generic system peripheral
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 14, interrupt_pin 01, min_grant 00, max_latency 00
PCI:   base reg 0: host 0000d020, pci 0000d020, size 00000020, flags 01
PCI:   base reg 1: host f0400000, pci f0400000, size 00400000, flags 00
PCI:   base reg 2: host f0800000, pci f0800000, size 00004000, flags 08
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (not supported)
PCI: [dom 0, bus  0] bus   0, device  7, function  0: vendor 8086, device 7113, revision 08
PCI:   class_base 06, class_function 80, class_api 00
PCI:   vendor 8086: Intel Corporation
PCI:   device 7113: 82371AB/EB/MB PIIX4 ACPI
PCI:   info: Bridge
PCI:   line_size 00, latency 00, header_type 80, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 09, interrupt_pin 01, min_grant 00, max_latency 00
PCI:   base reg 0: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (not supported)
PCI: [dom 0, bus  0] bus   0, device  8, function  0: vendor 8086, device 100f, revision 02
PCI:   class_base 02, class_function 00, class_api 00
PCI:   vendor 8086: Intel Corporation
PCI:   device 100f: 82545EM Gigabit Ethernet Controller (Copper) (PRO/1000 MT Single Port Adapter)
PCI:   info: Network controller (Ethernet controller)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0750, subsystem_vendor_id 15ad
PCI:   interrupt_line 10, interrupt_pin 01, min_grant ff, max_latency 00
PCI:   base reg 0: host f0820000, pci f0820000, size 00020000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 0000d040, pci 0000d040, size 00000008, flags 01
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: PM, PCI-X
PCI: [dom 0, bus  0] bus   0, device 12, function  0: vendor 8086, device 1e31, revision 00
PCI:   class_base 0c, class_function 03, class_api 30
PCI:   vendor 8086: Intel Corporation
PCI:   device 1e31: 7 Series/C210 Series Chipset Family USB xHCI Host Controller
PCI:   info: Serial bus controller (USB controller, XHCI)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 14, interrupt_pin 01, min_grant 00, max_latency 00
PCI:   base reg 0: host f0840000, pci f0840000, size 00010000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: (empty list)
PCI: find_pci_capability ERROR 0:12:0 capability 0x10 empty list
PCI: [dom 0, bus  0] bus   0, device 13, function  0: vendor 8086, device 2829, revision 02
PCI:   class_base 01, class_function 06, class_api 01
PCI:   vendor 8086: Intel Corporation
PCI:   device 2829: 82801HM/HEM (ICH8M/ICH8M-E) SATA Controller [AHCI mode]
PCI:   info: Mass storage controller (SATA controller, AHCI 1.0)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0000, subsystem_vendor_id 0000
PCI:   interrupt_line 15, interrupt_pin 01, min_grant 00, max_latency 00
PCI:   base reg 0: host 0000d048, pci 0000d048, size 00000008, flags 01
PCI:   base reg 1: host 0000d050, pci 0000d050, size 00000004, flags 01
PCI:   base reg 2: host 0000d058, pci 0000d058, size 00000008, flags 01
PCI:   base reg 3: host 0000d060, pci 0000d060, size 00000004, flags 01
PCI:   base reg 4: host 0000d070, pci 0000d070, size 00000010, flags 01
PCI:   base reg 5: host f0850000, pci f0850000, size 00002000, flags 00
PCI:   Capabilities: PM, SATA
PCI: [dom 0, bus  0] bus   0, device 17, function  0: vendor 8086, device 100f, revision 02
PCI:   class_base 02, class_function 00, class_api 00
PCI:   vendor 8086: Intel Corporation
PCI:   device 100f: 82545EM Gigabit Ethernet Controller (Copper) (PRO/1000 MT Single Port Adapter)
PCI:   info: Network controller (Ethernet controller)
PCI:   line_size 00, latency 00, header_type 00, BIST 00
PCI:   ROM base host 00000000, pci 00000000, size 00000000
PCI:   cardbus_CIS 00000000, subsystem_id 0750, subsystem_vendor_id 15ad
PCI:   interrupt_line 11, interrupt_pin 01, min_grant ff, max_latency 00
PCI:   base reg 0: host f0860000, pci f0860000, size 00020000, flags 00
PCI:   base reg 1: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 2: host 0000d080, pci 0000d080, size 00000008, flags 01
PCI:   base reg 3: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 4: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   base reg 5: host 00000000, pci 00000000, size 00000000, flags 00
PCI:   Capabilities: PM, PCI-X
usb xhci -1: interface version: 0x0100
usb xhci -1: structural parameters: 1:0x0e000820 2:0x00000059 3:0x00040001
usb xhci -1: capability parameters: 0x04000000
usb xhci -1: starting XHCI host controller
usb xhci -1: successfully started the controller
usb hub 2: port 0: new device connected
usb error control pipe 6: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x58a020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 7: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x58a020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: get_boot_partitions(): boot volume message:
port 0: new device connected
KMessage: buffer: 0xffffffff81ae9558 (size/capacity: 347/347), flags: 0xa
  field: "booted from image" (BOOL): false
  field: "partition offset"  (LLNG): 32768 (0x8000)
  field: "packaged"          (BOOL): true
  field: "boot method"       (LONG): 0 (0x0)
  field: "boot drive number" (LLNG): 128 (0x80)
  field: "disk identifier"   (RAWT): data at 0xffffffff81ae9664, 79 bytes
get_boot_partitions(): boot method type: 0
ahci: AHCI controller Intel ICH8M (AHCI mode) found!
ahci: ahci_register_device
ahci: ahci_init_driver
ahci: ahci_sim_init_bus
ahci: ahci_sim_init_bus: pciDevice 0xffffffff825bf350
ahci: AHCIController::Init 0:13:0 vendor 8086, device 2829
ahci: PCI SATA capability found at offset 0xa8
ahci: satacr0 = 0x00100012, satacr1 = 0x00000028
ahci: pcicmd old 0x0007
ahci: pcicmd new 0x0006
ahci: registers at 0xf0850000, size 0x2000
ahci: mapping physical address 0xf0850000 with 8192 bytes for AHCI HBA regs
ahci: physical = 0xf0850000, virtual = 0xffffffff812ce000, offset = 0, phyadr = 0xf0850000, mapadr = 0xffffffff812ce000, size = 8192, area = 0x000000d7
ahci: cap: Interface Speed Support: generation 2
ahci: cap: Number of Command Slots: 32 (raw 0x1f)
ahci: cap: Number of Ports: 2 (raw 0x1)
ahci: cap: Supports Port Multiplier: no
ahci: cap: Supports External SATA: no
ahci: cap: Enclosure Management Supported: no
ahci: cap: FIS-based Switching Control: no
ahci: cap: Supports Command List Override: no
ahci: cap: Supports Staggered Spin-up: yes
ahci: cap: Supports Mechanical Presence Switch: no
ahci: cap: Supports 64-bit Addressing: yes
ahci: cap: Supports Native Command Queuing: yes
ahci: cap: Supports SNotification Register: no
ahci: cap: Supports Command List Override: no
ahci: cap: Supports AHCI mode only: yes
ahci: ghc: AHCI Enable: yes
ahci: Ports Implemented Mask: 0x000003 Number of Available Ports: 2
ahci: AHCI Version 0001.01.00 Interrupt 21
ahci: allocating 4096 bytes for AHCI port 0
ahci: area = 216, size = 4096, virt = 0xffffffff812e5000, phy = 0x22a6000
ahci: allocating 4096 bytes for AHCI port 1
ahci: area = 217, size = 4096, virt = 0xffffffff812e6000, phy = 0x22a7000
ahci: Probe: port 0 link speed 3.0Gb/s
ahci: Probe: port 1 link speed 3.0Gb/s
ahci: cookie = 0xffffffff82437900
ahci: ahci_path_inquiry, cookie 0xffffffff82437900
ahci: ahci_path_inquiry, cookie 0xffffffff82437900
ahci: ahci_scan_bus, cookie 0xffffffff82437900
ahci: sg_memcpy phyAddr 0x579060, size 96
ahci: ahci_get_restrictions, cookie 0xffffffff82437900
publish device: node 0xffffffff825cdf18, path disk/scsi/0/0/0/raw, module drivers/disk/scsi/scsi_disk/device_v1
ahci: ahci_get_restrictions, cookie 0xffffffff82437900
publish device: node 0xffffffff825cda18, path disk/scsi/0/1/0/raw, module drivers/disk/scsi/scsi_cd/device_v1
ahci: sg_memcpy phyAddr 0x579190, size 32
periph_check_capacity: TRIM: Setting trim support to disabled
DMAResource@0xffffffff825cde78: low/high 0/100000000, max segment count 32, align 2, boundary 65536, max transfer 130560, max segment size 33554432
ahci: sg_memcpy phyAddr 0x579350, size 32
periph_check_capacity: TRIM: Setting trim support to disabled
ahci: ahci_ioctl, cookie 0xffffffff82437900
ahci: Probe: port 1 link speed 3.0Gb/s
ahci: sata_request::finish ATA command 0xa0 failed: status 0x41, error 0x20
ahci: sata_request::finish ATAPI packet 9e 10 00 00 00 00 00 00 00 00 00 00 00 20 00 00 (len 16)
periph_check_capacity: TRIM: Setting trim support to disabled
ahci: ahci_ioctl, cookie 0xffffffff82437900
identify(0, 0xffffffff825c89c8)
raw_command: 
ahci: AHCIPort::ScsiExecuteRequest port 0 unsupported request opcode 0x43
identify(0, 0xffffffff825c89b0)
raw_command: 
ahci: AHCIPort::ScsiExecuteRequest port 0 unsupported request opcode 0x43
device 0: /dev/disk/scsi/0/0/0/raw
  media status:      No error
  device flags:      2
  offset:            0
  size:              23622320128 (22528 MB)
  content size:      23622320128
  block size:        512
  physical block size: 512
  child count:       1
  index:             -1
  status:            0
  flags:             5
  volume:            -1
  disk system:       partitioning_systems/intel/map/v1
  name:              VBOX HARDDISK
  content name:      <NULL>
  type:              <NULL>
  content type:      Intel Partition Map
  params:            <NULL>
  content params:    <NULL>
  partition 2: /dev/disk/scsi/0/0/0/0
    offset:            32768
    size:              23621271552 (22527 MB)
    content size:      23621271552
    block size:        2048
    physical block size: 512
    child count:       0
    index:             0
    status:            0
    flags:             2
    volume:            -1
    disk system:       file_systems/bfs/v1
    name:              <NULL>
    content name:      haikudevroot
    type:              Be File System
    content type:      Be File System
    params:            type = 235 ; active = 1
    content params:    <NULL>
device 1: /dev/disk/scsi/0/1/0/raw
  media status:      No media present
  device flags:      5
Identified boot partition by partition offset.
ahci: sg_memcpy phyAddr 0x579460, size 32
periph_check_capacity: TRIM: Setting trim support to disabled
ahci: sg_memcpy phyAddr 0x5793e0, size 32
periph_check_capacity: TRIM: Setting trim support to disabled
bfs: mounted "haikudevroot" (root node at 524288, device = /dev/disk/scsi/0/0/0/0)
Mounted boot partition: /dev/disk/scsi/0/0/0/0
unknown: [8021405:    17] Adding packages from "/boot/system/packages"
slab memory manager: created area 0xffffffff87801000 (263)
slab memory manager: created area 0xffffffff88001000 (265)
slab memory manager: created area 0xffffffff88801000 (268)
slab memory manager: created area 0xffffffff89001000 (269)
slab memory manager: created area 0xffffffff89801000 (271)
unknown: [9480389:    17] StringPool usage:
unknown: [9481096:    17]   total unique strings:       64303,  1159904 bytes, overhead: 1028848 bytes + 1048576 bytes
unknown: [9482405:    17]   total strings with dups:   312849,  4052256 bytes
unknown: [9483265:    17]   unshared strings:            2544
unknown: [9483871:    17]   bytes saved:               814928
unknown: [9489595:    17] Adding packages from "/boot/home/config/packages"
unknown: [9491265:    17] Failed to open packages activation file: No such file or directory
unknown: [9492364:    17] Loading packages from activation file failed. Loading all packages in packages directory.
unknown: [9500281:    17] StringPool usage:
unknown: [9500857:    17]   total unique strings:       64303,  1159904 bytes, overhead: 1028848 bytes + 1048576 bytes
unknown: [9501973:    17]   total strings with dups:   312860,  4052321 bytes
unknown: [9502845:    17]   unshared strings:            2541
unknown: [9503749:    17]   bytes saved:               814993
module: Search for file_cache/launch_speedup/v1 failed.
smbios_scan
found System Information at 0xffffffff82145e38
found vendor 1 product 2
smbios_scan found vendor innotek GmbH product VirtualBox
publish device: node 0xffffffff87d3f000, path disk/virtual/ram/control, module drivers/disk/virtual/ram_disk/control/device_v1
loaded driver /boot/system/add-ons/kernel/drivers/dev/zero
usb_modeswitch: init_hardware()
usb_modeswitch: init_driver()
usb_modeswitch: trying module bus_managers/usb/v3.1
usb error control pipe 8: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 9: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb_modeswitch: publish_devices()
usb_modeswitch: uninit_driver()
loaded driver /boot/system/add-ons/kernel/drivers/dev/usb_modeswitch
loaded driver /boot/system/add-ons/kernel/drivers/dev/tty
loaded driver /boot/system/add-ons/kernel/drivers/dev/null
loaded driver /boot/system/add-ons/kernel/drivers/dev/dprintf
con_init: trying module console/frame_buffer/v1
loaded driver /boot/system/add-ons/kernel/drivers/dev/console
swap_init_post_modules: virtual_memory is disabled
mtrr: [cpu 2] MTRRs are enabled
mtrr: [cpu 2] default type is 0 uncacheable
mtrr: [cpu 2] fixed range MTRRs are enabled
mtrr: [cpu 2] 0: base: 0x0; length: 0x80000000; type: 6 write-back
ignoring MTRRs due to PAT support
allocate_commpage_entry(4, 16) -> 0x0000000000000258
no valid cpufreq module found
no valid cpuidle module found
ignoring MTRRs due to PAT support
kernel debugger extension "debugger/run_on_exit/v1": loaded
kernel debugger extension "debugger/usb_keyboard/v1": loaded
kernel debugger extension "debugger/invalidate_on_exit/v1": loaded
kernel debugger extension "debugger/hangman/v1": loaded
kernel debugger extension "debugger/disasm/v1": loaded
publish device: node 0xffffffff821570a0, path random, module bus_managers/random/device_v1
publish device: node 0xffffffff821570a0, path urandom, module bus_managers/random/device_v1
publish device: node 0xffffffff8207ce68, path power/button/power_fixed, module drivers/power/acpi_button/device_v1
publish device: node 0xffffffff8207cc88, path power/button/sleep_fixed, module drivers/power/acpi_button/device_v1
publish device: node 0xffffffff8207cb48, path power/acpi_battery/0, module drivers/power/acpi_battery/device_v1
usb hub 2: port 0: new device connected
slab memory manager: created area 0xffffffff8a001000 (3610)
package_daemon: [22974441:    42] root at "/boot" (device: 3, node: 524288) registered
package_daemon: [22976362:    42] volume at "/boot/system" registered
package_daemon: [22977533:    42] volume at "/boot/home/config" registered
Test: and [file_exists [/system/bin/FirstBootPrompt], or [not [file_exists [/boot/home/config/settings/Locale settings]], readonly ]] -> 0
register_domain(9, unix)
register_domain(5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff895d0580, 9, unix)
unregister_domain(0xffffffff895d0400, 1, internet)
unregister_domain(0xffffffff895d0780, 5, internet6)
register_domain(5, internet6)
unregister_domain(0xffffffff895d0400, 5, internet6)
register_domain(4, link)
register_domain(1, internet)
unregister_domain(0xffffffff895d0400, 4, link)
unregister_domain(0xffffffff895d0380, 1, internet)
package_daemon: [23927985:    62] The latest volume state is also the currently active one
package_daemon: [23929068:    62] Volume::InitialVerify((nil), (nil))
package_daemon: [23945959:    62] Volume::InitialVerify(): volume at "/boot/system" is consistent
package_daemon: [23948854:    62] Failed to open packages activation file /boot/home/config/packages/administrative/activated-packages: No such file or directory
package_daemon: [23952566:    62] Failed to get activated packages info from activated packages file. Assuming all package files in package directory are activated.
package_daemon: [23956285:    62] The latest volume state is also the currently active one
package_daemon: [23957952:    62] Volume::InitialVerify(0x10cb0f711f40, (nil))
package_daemon: [23965023:    62] Volume::InitialVerify(): volume at "/boot/home/config" is consistent
usb error control pipe 10: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 11: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
loaded driver /boot/system/add-ons/kernel/drivers/dev/net/usb_rndis
radeon_hd: init_hardware
usb_davicom:00.27.748:init_driver::ver.0.9.5
loaded driver /boot/system/add-ons/kernel/drivers/dev/net/usb_davicom
Radeon - init_hardware: Version: 5.1.6.0
Radeon - Radeon_CardDetect: no supported devices found
usb_asix:00.27.765:init_driver::ver.0.10.1
loaded driver /boot/system/add-ons/kernel/drivers/dev/net/usb_asix
nvidia: CALLED init_hardware
nvidia: init_hardware: no supported device found
loaded driver /boot/system/add-ons/kernel/drivers/dev/net/pegasus
intel_extreme: CALLED status_t init_hardware()
etherpci: init_driver init_driver: etherpci not found
devfs: "intel_810" api_version missing
i810: init_hardware() - no supported devices
ati: init_hardware() - no supported devices
vesa: init_hardware()
vesa: init_driver()
vesa: publish_devices()
vesa: find_device()
loaded driver /boot/system/add-ons/kernel/drivers/dev/graphics/vesa
framebuffer: init_hardware()
VMware: init_hardware
VMware: init_hardware: 0
VMware: init_driver
VMware: init_driver: 0
VMware: publish_devices
VMware: find_device (graphics/vmware)
loaded driver /boot/system/add-ons/kernel/drivers/dev/graphics/vmware
VMware: OpenHook (graphics/vmware, 2)
VMware: shared area created
VMware: index port: 53248, value port: 53249
VMware: SVGA_REG_ID OK
VMware: max resolution: 4096x4096
VMware: frame buffer: 0x00000000e0000000, size 67108864
VMware: fifo: 0x00000000f0000000, size 2097152
VMware: capabilities:
VMware: RECT_COPY
VMware: CURSOR
VMware: CURSOR_BYPASS
VMware: CURSOR_BYPASS_2
VMware: ALPHA_CURSOR
VMware: EXTENDED_FIFO
VMware: frame buffer mapped: 0x00000000e0000000->0xffffffff8c000000, area 6788, size 67108864, write combined: 1
VMware: fifo mapped: 0x00000000f0000000->0xffffffff81e00000, area 6789, size 2097152
VMware: OpenHook: 0
VMware: INIT_ACCELERANT (3)
VMware: INIT_ACCELERANT: 0
VMware: SET_DISPLAY_MODE
pci_reserve_device(0, 8, 0, ipro1000)
VMware: PROPOSE_DISPLAY_MODE
VMware: setting 800x600x32
VMware: fifo capabilities:
VMware: FENCE
VMware: PITCHLOCK
VMware: init fifo: 1164 -> 2097152
VMware: GET_FRAME_BUFFER_CONFIG
VMware: fb: 0xffffffff8c000000, fb_dma: 0xe0000000, row: 3200 bytes
pci_reserve_device(0, 17, 0, ipro1000)
if_initname(0xffffffff893b0000, em, 2)
[ipro1000] ipro1000: /dev/net/ipro1000/0
[ipro1000] (em) attach_pre capping queues at 1
[ipro1000] (em) bus_alloc_resource(3, [16], 0x0, 0xffffffffffffffff, 0x1,0x2)
[ipro1000] (em) bus_alloc_resource(4, [24], 0x0, 0xffffffffffffffff, 0x1,0x2)
register_domain(9, unix)
register_domain(5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff89d88400, 9, unix)
unregister_domain(0xffffffff89d88300, 1, internet)
unregister_domain(0xffffffff89d88380, 5, internet6)
register_domain(5, internet6)
unregister_domain(0xffffffff89d88300, 5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff89d88300, 1, internet)
register_domain(9, unix)
register_domain(5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff89d88400, 9, unix)
unregister_domain(0xffffffff89d88000, 1, internet)
unregister_domain(0xffffffff89d88480, 5, internet6)
register_domain(5, internet6)
unregister_domain(0xffffffff89d88000, 5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff89d88000, 1, internet)
[ipro1000] (em) Using 1024 TX descriptors and 1024 RX descriptors
slab memory manager: created area 0xffffffff8a801000 (7341)
[ipro1000] (em) allocated for 1 tx_queues
[ipro1000] (em) allocated for 1 rx_queues
[ipro1000] (em) bus_alloc_resource(1, [0], 0x0, 0xffffffffffffffff, 0x1,0x6)
if_attach 0xffffffff89db3af0
ipro1000: init_driver(0xffffffff81923210)
if_initname(0xffffffff89a99000, em, 4)
[ipro1000] ipro1000: /dev/net/ipro1000/1
[ipro1000] (em) attach_pre capping queues at 1
[ipro1000] (em) bus_alloc_resource(3, [16], 0x0, 0xffffffffffffffff, 0x1,0x2)
[ipro1000] (em) bus_alloc_resource(4, [24], 0x0, 0xffffffffffffffff, 0x1,0x2)
[ipro1000] (em) Using 1024 TX descriptors and 1024 RX descriptors
[ipro1000] (em) allocated for 1 tx_queues
[ipro1000] (em) allocated for 1 rx_queues
[ipro1000] (em) bus_alloc_resource(1, [0], 0x0, 0xffffffffffffffff, 0x1,0x6)
if_attach 0xffffffff89db38f0
ipro1000: init_driver(0xffffffff81923210)
loaded driver /boot/system/add-ons/kernel/drivers/dev/net/ipro1000
loaded driver /boot/system/add-ons/kernel/drivers/dev/input/wacom
loaded driver /boot/system/add-ons/kernel/drivers/dev/input/usb_hid
ps2_hid: init_hardware
ps2_hid: init_driver
ps2_hid: publish_devices
ps2_hid: uninit_driver
loaded driver /boot/system/add-ons/kernel/drivers/dev/input/ps2_hid
ALPS not supported: 10 00 64
ps2: probe_mouse Extended PS/2 mouse found
ps2: devfs_publish_device input/mouse/ps2/intelli_0, status = 0x00000000
ps2: devfs_publish_device input/keyboard/at/0, status = 0x00000000
usb hub 2: port 0: new device connected
register_domain(9, unix)
register_domain(5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff8a13cb00, 9, unix)
unregister_domain(0xffffffff8a13ca00, 1, internet)
unregister_domain(0xffffffff8a13ca80, 5, internet6)
register_domain(5, internet6)
unregister_domain(0xffffffff8a13ca00, 5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff8a13ca00, 1, internet)
register_domain(9, unix)
register_domain(5, internet6)
register_domain(1, internet)
unregister_domain(0xffffffff8a13ca80, 9, unix)
unregister_domain(0xffffffff895d0c80, 1, internet)
unregister_domain(0xffffffff8a13cb00, 5, internet6)
register_domain(5, internet6)
unregister_domain(0xffffffff895d0c80, 5, internet6)
register_domain(1, internet)
[net/ipro1000/0] compat_open(0x2)
ps2: keyboard found
AddOnManager::_RegisterAddOn(): InitCheck() in "/boot/system/add-ons/input_server/filters/vmware_mouse" returned General system error
thread 145 tried to delete kernel semaphore 0.
/dev/net/ipro1000/0: link down, media 0x20 quality 1000 speed 0
register_domain(5, internet6)
usb error control pipe 12: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 13: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
loaded driver /boot/system/add-ons/kernel/drivers/dev/bus/usb_raw
[net/ipro1000/1] compat_open(0x2)
sis7018:init_hardware:ver:2.0.2
loaded driver /boot/system/add-ons/kernel/drivers/dev/audio/hmulti/usb_audio
emuxki: init_hardware()
echo3g: init_hardware()
echo3g: no card found
auvia: init_hardware()
auich: init_hardware()
/dev/net/ipro1000/1: link down, media 0x20 quality 1000 speed 0
usb hub 2: port 0: new device connected
[ipro1000] (em) Link is up 1000 Mbps Full Duplex
/dev/net/ipro1000/1: link up, media 0x900030 quality 1000 speed 1000000000
register_domain(4, link)
slab memory manager: created area 0xffffffff8b001000 (8279)
usb error control pipe 14: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
register_domain(9, unix)
usb error control pipe 15: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 16: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 17: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 18: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 19: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 20: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 21: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 22: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 23: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 24: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 25: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 26: timeout waiting for queued request to complete
usb error xhci 0: TRB 0x598020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 27: timeout waiting for queued request to complete
usb error xhci 0: TRB 0xa37020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
usb error control pipe 28: timeout waiting for queued request to complete
usb error xhci 0: TRB 0xa37020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb error control pipe 29: timeout waiting for queued request to complete
usb error xhci 0: TRB 0xa39020 was not found in the endpoint!
usb error xhci 0: failed to get the device descriptor: Operation timed out
usb hub 2: port 0: new device connected
vm_page_fault: vm_soft_fault returned error 'Bad address' on fault at 0x0, ip 0xffffffff8012985d, write 1, kernel, exec 0, thread 0x185
PANIC: vm_page_fault: unhandled page fault in kernel space at 0x0, ip 0xffffffff8012985d

Welcome to Kernel Debugging Land...
Thread 389 "pthread func" running on CPU 2
stack trace for thread 389 "pthread func"
    kernel stack: 0xffffffff87007000 to 0xffffffff8700c000
      user stack: 0x00007fa7eeda9000 to 0x00007fa7eede9000
frame                       caller             <image>:function + offset
 0 ffffffff8700b0d0 (+  32) ffffffff80154b30   <kernel_x86_64> arch_debug_call_with_fault_handler + 0x1a
 1 ffffffff8700b120 (+  80) ffffffff800b8848   <kernel_x86_64> debug_call_with_fault_handler + 0x78
 2 ffffffff8700b180 (+  96) ffffffff800b9f34   <kernel_x86_64> kernel_debugger_loop(char const*, char const*, __va_list_tag*, int) + 0xf4
 3 ffffffff8700b1d0 (+  80) ffffffff800ba2ce   <kernel_x86_64> kernel_debugger_internal(char const*, char const*, __va_list_tag*, int) + 0x6e
 4 ffffffff8700b2c0 (+ 240) ffffffff800ba667   <kernel_x86_64> panic + 0xb7
 5 ffffffff8700b3b0 (+ 240) ffffffff8013b248   <kernel_x86_64> vm_page_fault + 0x298
 6 ffffffff8700b3f0 (+  64) ffffffff80160c6e   <kernel_x86_64> x86_page_fault_exception + 0x15e
 7 ffffffff8700b768 (+ 888) ffffffff8015640c   <kernel_x86_64> int_bottom + 0x80
kernel iframe at 0xffffffff8700b768 (end = 0xffffffff8700b830)
 rax 0x0                   rbx 0xffffffff8700b8a0    rcx 0xffffffff8a97e608
 rdx 0xffffffff8a97e818    rsi 0xffffffff8a97e610    rdi 0xffffffff82076700
 rbp 0xffffffff8700b850     r8 0xffffffff8a97ecd0     r9 0x7e
 r10 0x0                   r11 0x0                   r12 0xffffffff82076700
 r13 0xffffffff8a97e818    r14 0xffffffff8700b860    r15 0xffffffff8a97ecd0
 rip 0xffffffff8012985d    rsp 0xffffffff8700b838 rflags 0x10292
 vector: 0xe, error code: 0x2
 8 ffffffff8700b850 (+ 232) ffffffff8012985d   <kernel_x86_64> AVLTreeBase::_RotateLeft(AVLTreeNode**) + 0x0d
 9 ffffffff8700ba90 (+ 576) ffffffff80129a49   <kernel_x86_64> AVLTreeBase::_Insert(AVLTreeNode*) + 0xd9
10 ffffffff8700baa0 (+  16) ffffffff80129ab9   <kernel_x86_64> AVLTreeBase::Insert(AVLTreeNode*) + 0x09
11 ffffffff8700bb10 (+ 112) ffffffff8112d170   </boot/system/add-ons/kernel/file_systems/ramfs> SizeIndex::Changed[clone .localalias] (Node*, long) + 0x110
12 ffffffff8700bb40 (+  48) ffffffff81121f53   </boot/system/add-ons/kernel/file_systems/ramfs> File::SetSize[clone .localalias] (long) + 0x63
13 ffffffff8700bb90 (+  80) ffffffff81124d16   </boot/system/add-ons/kernel/file_systems/ramfs> ramfs_open(fs_volume*, fs_vnode*, int, void**) + 0x146
14 ffffffff8700bbd0 (+  64) ffffffff8010141f   <kernel_x86_64> open_vnode(vnode*, int, bool) + 0x3f
15 ffffffff8700bd70 (+ 416) ffffffff80107f68   <kernel_x86_64> create_vnode(vnode*, char const*, int, int, bool) + 0x4b8
16 ffffffff8700bec0 (+ 336) ffffffff8010ad42   <kernel_x86_64> file_create(int, char*, int, int, bool) + 0x62
17 ffffffff8700bf20 (+  96) ffffffff8011123b   <kernel_x86_64> _user_open + 0xcb
18 ffffffff8700bf30 (+  16) ffffffff8015670f   <kernel_x86_64> x86_64_syscall_entry + 0xfb
user iframe at 0xffffffff8700bf30 (end = 0xffffffff8700bff8)
 rax 0x71                  rbx 0x7fa7eede8a73        rcx 0x21bf2624c7c
 rdx 0x641                 rsi 0x11f15e1c38f0        rdi 0xffffff9c
 rbp 0x7fa7eede8820         r8 0x7fa7eede8a73         r9 0xffffffff
 r10 0x1a4                 r11 0x202                 r12 0x601
 r13 0x11f15e1c38f0        r14 0x1b6                 r15 0x11f15d8f0740
 rip 0x21bf2624c7c         rsp 0x7fa7eede87b8     rflags 0x202
 vector: 0x63, error code: 0x0
19 00007fa7eede8820 (+   0) 0000021bf2624c7c   </boot/system/lib/libroot.so> _kern_open + 0x0c
20 00007fa7eede8850 (+  48) 000000c9e58e450b   </boot/system/lib/perl5/5.40.0/x> Perl_debstack (nearest) + 0xdd9
21 00007fa7eede88c0 (+ 112) 000000c9e592f688   </boot/system/lib/perl5/5.40.0/x> PerlIOUnix_open + 0xfe
22 00007fa7eede8950 (+ 144) 000000c9e592e6e1   </boot/system/lib/perl5/5.40.0/x> PerlIOBuf_open + 0x150
23 00007fa7eede89f0 (+ 160) 000000c9e5930ea2   </boot/system/lib/perl5/5.40.0/x> PerlIO_openn + 0x1a8
24 00007fa7eede8ac0 (+ 208) 000000c9e58e50e6   </boot/system/lib/perl5/5.40.0/x> Perl_debstack (nearest) + 0x19b4
25 00007fa7eede8b40 (+ 128) 000000c9e5985a66   </boot/system/lib/perl5/5.40.0/x> Perl_sortsv (nearest) + 0x263a
26 00007fa7eede8b60 (+  32) 000000c9e59ecd26   </boot/system/lib/perl5/5.40.0/x> Perl_runops_standard + 0x16
27 00007fa7eede8cc0 (+ 352) 000000c9e58ce378   </boot/system/lib/perl5/5.40.0/x> Perl_call_sv + 0x432
28 00007fa7eede8d80 (+ 192) 000000e859615de2   </boot/system/lib/perl5/5.40.0/x> _init (nearest) + 0xe5a
29 00007fa7eede8df0 (+ 112) 000000e859617c6f   </boot/system/lib/perl5/5.40.0/x> _init (nearest) + 0x2ce7
30 00007fa7eede8e10 (+  32) 0000021bf26338d8   </boot/system/lib/libroot.so> pthread_exit (nearest) + 0x38
31 0000000000000000 (+   0) 00007fffea272258   10712:commpage@0x00007fffea272000 + 0x258
kdebug> 

Change History (1)

by dovsienko, 44 hours ago

the first KDL

Note: See TracTickets for help on using tickets.