[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.10.0-7.9-debug (green@centos7-base) (gcc version 4.8.5 20150623 (Red Hat 4.8.5-44) (GCC) ) #1 SMP Sat Mar 26 23:28:42 EDT 2022 [ 0.000000] Command line: rd.shell root=nbd:192.168.200.253:centos7:ext4:ro:-p,-b4096 ro crashkernel=128M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffcdfff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffce000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000013edfffff] usable [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-1.fc38 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0x13ee00 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0000C0000000 mask 3FFFC0000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] PAT configuration [0-7]: WB WC UC- UC WB WP UC- UC [ 0.000000] e820: last_pfn = 0xbffce max_arch_pfn = 0x400000000 [ 0.000000] found SMP MP-table at [mem 0x000f5b30-0x000f5b3f] mapped at [ffffffffff200b30] [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] Using GB pages for direct mapping [ 0.000000] BRK [0x023c1000, 0x023c1fff] PGTABLE [ 0.000000] BRK [0x023c2000, 0x023c2fff] PGTABLE [ 0.000000] BRK [0x023c3000, 0x023c3fff] PGTABLE [ 0.000000] BRK [0x023c4000, 0x023c4fff] PGTABLE [ 0.000000] BRK [0x023c5000, 0x023c5fff] PGTABLE [ 0.000000] BRK [0x023c6000, 0x023c6fff] PGTABLE [ 0.000000] RAMDISK: [mem 0xbc2e2000-0xbffbffff] [ 0.000000] Early table checksum verification disabled [ 0.000000] ACPI: RSDP 00000000000f5950 00014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 00000000bffe1bb7 00034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 00000000bffe1a53 00074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 00000000bffe0040 01A13 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 00000000bffe0000 00040 [ 0.000000] ACPI: APIC 00000000bffe1ac7 00090 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 00000000bffe1b57 00038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: WAET 00000000bffe1b8f 00028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000013edfffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x13e5e3000-0x13e609fff] [ 0.000000] Reserving 128MB of memory at 768MB for crashkernel (System RAM: 4077MB) [ 0.000000] kvm-clock: cpu 0, msr 1:3e592001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 364685366 cycles [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 0.000000] Normal [mem 0x100000000-0x13edfffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00001000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0xbffcdfff] [ 0.000000] node 0: [mem 0x100000000-0x13edfffff] [ 0.000000] Initmem setup node 0 [mem 0x00001000-0x13edfffff] [ 0.000000] On node 0 totalpages: 1043820 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 12224 pages used for memmap [ 0.000000] DMA32 zone: 782286 pages, LIFO batch:31 [ 0.000000] Normal zone: 4024 pages used for memmap [ 0.000000] Normal zone: 257536 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] PM: Registered nosave memory: [mem 0xbffce000-0xbfffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.000000] e820: [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] setup_percpu: NR_CPUS:5120 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] percpu: Embedded 38 pages/cpu s115176 r8192 d32280 u524288 [ 0.000000] pcpu-alloc: s115176 r8192 d32280 u524288 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 1 2 3 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 13e2135c0 [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes) [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 1027487 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: rd.shell root=nbd:192.168.200.253:centos7:ext4:ro:-p,-b4096 ro crashkernel=128M panic=1 nomodeset ipmtu=9000 ip=dhcp rd.neednet=1 init_on_free=off mitigations=off console=ttyS1,115200 audit=0 [ 0.000000] audit: disabled (until reboot) [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] x86/fpu: xstate_offset[2]: 0240, xstate_sizes[2]: 0100 [ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form [ 0.000000] Memory: 3820268k/5224448k available (8172k kernel code, 1049168k absent, 355012k reserved, 5773k data, 2532k init) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU restricting CPUs from NR_CPUS=5120 to nr_cpu_ids=4. [ 0.000000] Offload RCU callbacks from all CPUs [ 0.000000] Offload RCU callbacks from CPUs: 0-3. [ 0.000000] NR_IRQS:327936 nr_irqs:456 0 [ 0.000000] Console: colour *CGA 80x25 [ 0.000000] console [ttyS1] enabled [ 0.000000] allocated 25165824 bytes of page_cgroup [ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] ODEBUG: 73 of 73 active objects replaced [ 0.000000] hpet clockevent registered [ 0.000000] tsc: Detected 2399.998 MHz processor [ 0.527194] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.529922] pid_max: default: 32768 minimum: 301 [ 0.531916] Security Framework initialized [ 0.533400] SELinux: Initializing. [ 0.535413] SELinux: Starting in permissive mode [ 0.536799] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.541509] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.545155] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.548097] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.551261] Initializing cgroup subsys memory [ 0.553337] Initializing cgroup subsys devices [ 0.555683] Initializing cgroup subsys freezer [ 0.557741] Initializing cgroup subsys net_cls [ 0.559111] Initializing cgroup subsys blkio [ 0.561305] Initializing cgroup subsys perf_event [ 0.562724] Initializing cgroup subsys hugetlb [ 0.564028] Initializing cgroup subsys pids [ 0.565072] Initializing cgroup subsys net_prio [ 0.567747] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.571043] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.572826] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.574416] tlb_flushall_shift: 6 [ 0.575807] FEATURE SPEC_CTRL Present [ 0.577081] FEATURE IBPB_SUPPORT Present [ 0.578551] Spectre V2 : Enabling Indirect Branch Prediction Barrier [ 0.580518] Spectre V2 : Vulnerable [ 0.582216] Speculative Store Bypass: Vulnerable [ 0.585016] debug: unmapping init [mem 0xffffffff82019000-0xffffffff8201ffff] [ 0.594563] ACPI: Core revision 20130517 [ 0.597491] ACPI: All ACPI Tables successfully acquired [ 0.599464] ftrace: allocating 30294 entries in 119 pages [ 0.655312] Enabling x2apic [ 0.656186] Enabled x2apic [ 0.657126] Switched APIC routing to physical x2apic. [ 0.659496] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.660937] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (fam: 06, model: 3e, stepping: 04) [ 0.664513] TSC deadline timer enabled [ 0.664746] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.667116] ... version: 2 [ 0.668297] ... bit width: 48 [ 0.669376] ... generic registers: 4 [ 0.670434] ... value mask: 0000ffffffffffff [ 0.671953] ... max period: 00007fffffffffff [ 0.673278] ... fixed-purpose events: 3 [ 0.674647] ... event mask: 000000070000000f [ 0.676426] KVM setup paravirtual spinlock [ 0.682140] kvm-clock: cpu 1, msr 1:3e592041, secondary cpu clock [ 0.688363] KVM setup async PF for cpu 1 [ 0.691463] kvm-stealtime: cpu 1, msr 13e2935c0 [ 0.697795] kvm-clock: cpu 2, msr 1:3e592081, secondary cpu clock [ 0.701086] KVM setup async PF for cpu 2 [ 0.679916] smpboot: Booting Node 0, Processors #1 #2 #3 OK [ 0.702514] kvm-stealtime: cpu 2, msr 13e3135c0 [ 0.703486] kvm-clock: cpu 3, msr 1:3e5920c1, secondary cpu clock [ 0.706349] Brought up 4 CPUs [ 0.706407] KVM setup async PF for cpu 3 [ 0.706496] kvm-stealtime: cpu 3, msr 13e3935c0 [ 0.710311] smpboot: Max logical packages: 1 [ 0.711782] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.716449] devtmpfs: initialized [ 0.717884] x86/mm: Memory block size: 128MB [ 0.723170] EVM: security.selinux [ 0.724259] EVM: security.ima [ 0.725045] EVM: security.capability [ 0.729670] atomic64 test passed for x86-64 platform with CX8 and with SSE [ 0.732530] NET: Registered protocol family 16 [ 0.734317] cpuidle: using governor haltpoll [ 0.737172] ACPI: bus type PCI registered [ 0.738532] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.740831] PCI: Using configuration type 1 for base access [ 0.742527] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.754255] ACPI: Added _OSI(Module Device) [ 0.756691] ACPI: Added _OSI(Processor Device) [ 0.760012] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.761457] ACPI: Added _OSI(Processor Aggregator Device) [ 0.763127] ACPI: Added _OSI(Linux-Dell-Video) [ 0.765539] ACPI: EC: Look up EC in DSDT [ 0.768585] ACPI: Interpreter enabled [ 0.769990] ACPI: (supports S0 S3 S4 S5) [ 0.771420] ACPI: Using IOAPIC for interrupt routing [ 0.773414] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.777565] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.789344] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.792059] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] [ 0.794809] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.797232] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.802353] acpiphp: Slot [2] registered [ 0.803838] acpiphp: Slot [3] registered [ 0.805084] acpiphp: Slot [4] registered [ 0.806639] acpiphp: Slot [5] registered [ 0.808171] acpiphp: Slot [6] registered [ 0.809687] acpiphp: Slot [7] registered [ 0.811137] acpiphp: Slot [8] registered [ 0.812494] acpiphp: Slot [9] registered [ 0.813533] acpiphp: Slot [10] registered [ 0.814971] acpiphp: Slot [11] registered [ 0.816543] acpiphp: Slot [12] registered [ 0.818082] acpiphp: Slot [13] registered [ 0.820089] acpiphp: Slot [14] registered [ 0.821637] acpiphp: Slot [15] registered [ 0.823193] acpiphp: Slot [16] registered [ 0.824720] acpiphp: Slot [17] registered [ 0.826561] acpiphp: Slot [18] registered [ 0.828593] acpiphp: Slot [19] registered [ 0.830136] acpiphp: Slot [20] registered [ 0.831712] acpiphp: Slot [21] registered [ 0.833237] acpiphp: Slot [22] registered [ 0.834804] acpiphp: Slot [23] registered [ 0.836350] acpiphp: Slot [24] registered [ 0.837602] acpiphp: Slot [25] registered [ 0.838461] acpiphp: Slot [26] registered [ 0.839828] acpiphp: Slot [27] registered [ 0.841352] acpiphp: Slot [28] registered [ 0.842921] acpiphp: Slot [29] registered [ 0.844536] acpiphp: Slot [30] registered [ 0.845884] acpiphp: Slot [31] registered [ 0.847219] PCI host bridge to bus 0000:00 [ 0.848784] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.851104] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.853457] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.855889] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.858866] pci_bus 0000:00: root bus resource [mem 0x140000000-0x1bfffffff window] [ 0.860704] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.862499] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.863227] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.864075] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.871144] pci 0000:00:01.1: reg 0x20: [io 0xc320-0xc32f] [ 0.872637] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.874655] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.876693] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.878928] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.882255] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.882978] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.886697] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.889417] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.891345] pci 0000:00:02.0: reg 0x10: [io 0xc300-0xc31f] [ 0.901142] pci 0000:00:02.0: reg 0x20: [mem 0xfebe4000-0xfebe7fff 64bit pref] [ 0.903799] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.908170] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.918969] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.930906] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.959671] pci 0000:00:05.0: reg 0x20: [mem 0xfebe8000-0xfebebfff 64bit pref] [ 0.966037] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.975387] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.980597] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.996878] pci 0000:00:06.0: reg 0x20: [mem 0xfebec000-0xfebeffff 64bit pref] [ 1.007790] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 1.012729] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc17f] [ 1.016812] pci 0000:00:07.0: reg 0x14: [mem 0xfebc2000-0xfebc2fff] [ 1.041052] pci 0000:00:07.0: reg 0x20: [mem 0xfebf0000-0xfebf3fff 64bit pref] [ 1.051566] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 1.055624] pci 0000:00:08.0: reg 0x10: [io 0xc180-0xc1ff] [ 1.060019] pci 0000:00:08.0: reg 0x14: [mem 0xfebc3000-0xfebc3fff] [ 1.083395] pci 0000:00:08.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 1.095003] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 1.098035] pci 0000:00:09.0: reg 0x10: [io 0xc200-0xc27f] [ 1.101077] pci 0000:00:09.0: reg 0x14: [mem 0xfebc4000-0xfebc4fff] [ 1.118777] pci 0000:00:09.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 1.125507] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 1.138609] pci 0000:00:0a.0: reg 0x10: [io 0xc280-0xc2ff] [ 1.141106] pci 0000:00:0a.0: reg 0x14: [mem 0xfebc5000-0xfebc5fff] [ 1.151729] pci 0000:00:0a.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 1.175372] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.177935] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 1.180286] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 1.182793] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 1.185132] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.188446] vgaarb: loaded [ 1.189528] SCSI subsystem initialized [ 1.190828] ACPI: bus type USB registered [ 1.192087] usbcore: registered new interface driver usbfs [ 1.193711] usbcore: registered new interface driver hub [ 1.195394] usbcore: registered new device driver usb [ 1.197421] PCI: Using ACPI for IRQ routing [ 1.198778] PCI: pci_cache_line_size set to 64 bytes [ 1.199081] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 1.199086] e820: reserve RAM buffer [mem 0xbffce000-0xbfffffff] [ 1.199088] e820: reserve RAM buffer [mem 0x13ee00000-0x13fffffff] [ 1.199409] NetLabel: Initializing [ 1.200621] NetLabel: domain hash size = 128 [ 1.202096] NetLabel: protocols = UNLABELED CIPSOv4 [ 1.203811] NetLabel: unlabeled traffic allowed by default [ 1.206058] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 1.207839] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 1.211982] amd_nb: Cannot enumerate AMD northbridges [ 1.214528] Switched to clocksource kvm-clock [ 1.233629] pnp: PnP ACPI init [ 1.234697] ACPI: bus type PNP registered [ 1.236099] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.236173] pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) [ 1.236211] pnp 00:02: [dma 2] [ 1.236247] pnp 00:02: Plug and Play ACPI device, IDs PNP0700 (active) [ 1.236321] pnp 00:03: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.236393] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.236463] pnp 00:05: Plug and Play ACPI device, IDs PNP0b00 (active) [ 1.236838] pnp: PnP ACPI: found 6 devices [ 1.238090] ACPI: bus type PNP unregistered [ 1.249798] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.249805] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.249808] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.249810] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.249813] pci_bus 0000:00: resource 8 [mem 0x140000000-0x1bfffffff window] [ 1.249879] NET: Registered protocol family 2 [ 1.251719] TCP established hash table entries: 32768 (order: 6, 262144 bytes) [ 1.254299] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes) [ 1.257128] TCP: Hash tables configured (established 32768 bind 32768) [ 1.259330] TCP: reno registered [ 1.260487] UDP hash table entries: 2048 (order: 5, 196608 bytes) [ 1.262648] UDP-Lite hash table entries: 2048 (order: 5, 196608 bytes) [ 1.265307] NET: Registered protocol family 1 [ 1.267984] RPC: Registered named UNIX socket transport module. [ 1.270040] RPC: Registered udp transport module. [ 1.271258] RPC: Registered tcp transport module. [ 1.272179] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.275119] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.279504] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.282726] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.286034] PCI: CLS 0 bytes, default 64 [ 1.286296] Unpacking initramfs... [ 2.823415] debug: unmapping init [mem 0xffff8800bc2e2000-0xffff8800bffbffff] [ 2.827141] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.828987] software IO TLB [mem 0xb82e2000-0xbc2e2000] (64MB) mapped at [ffff8800b82e2000-ffff8800bc2e1fff] [ 2.832360] RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 10737418240 ms ovfl timer [ 2.834857] RAPL PMU: hw unit of domain pp0-core 2^-0 Joules [ 2.836627] RAPL PMU: hw unit of domain package 2^-0 Joules [ 2.838425] RAPL PMU: hw unit of domain dram 2^-0 Joules [ 2.841791] cryptomgr_test (51) used greatest stack depth: 14480 bytes left [ 2.842603] futex hash table entries: 1024 (order: 4, 65536 bytes) [ 2.842647] Initialise system trusted keyring [ 2.875411] HugeTLB registered 1 GB page size, pre-allocated 0 pages [ 2.877675] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 2.884520] zpool: loaded [ 2.885494] zbud: loaded [ 2.886779] VFS: Disk quotas dquot_6.6.0 [ 2.888033] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 2.892710] NFS: Registering the id_resolver key type [ 2.894261] Key type id_resolver registered [ 2.895328] Key type id_legacy registered [ 2.896551] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 2.898961] Key type big_key registered [ 2.900318] SELinux: Registering netfilter hooks [ 2.903726] cryptomgr_test (57) used greatest stack depth: 13968 bytes left [ 2.907471] cryptomgr_test (60) used greatest stack depth: 13904 bytes left [ 2.911168] NET: Registered protocol family 38 [ 2.912693] Key type asymmetric registered [ 2.914057] Asymmetric key parser 'x509' registered [ 2.915625] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 2.918059] io scheduler noop registered [ 2.919200] io scheduler deadline registered (default) [ 2.920871] io scheduler cfq registered [ 2.922479] io scheduler mq-deadline registered [ 2.923944] io scheduler kyber registered [ 2.928017] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 2.929797] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 2.932463] intel_idle: does not run on family 6 model 62 [ 2.932600] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.935077] ACPI: Power Button [PWRF] [ 2.937192] GHES: HEST is not enabled! [ 2.999284] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10 [ 3.063921] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 11 [ 3.185220] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 3.252475] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10 [ 3.383044] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.411612] 00:03: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A [ 3.443121] 00:04: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 3.447549] Non-volatile memory driver v1.3 [ 3.449093] Linux agpgart interface v0.103 [ 3.450978] crash memory driver: version 1.1 [ 3.453274] nbd: registered device at major 43 [ 3.462131] virtio-pci 0000:00:05.0: irq 24 for MSI/MSI-X [ 3.462186] virtio-pci 0000:00:05.0: irq 25 for MSI/MSI-X [ 3.462232] virtio-pci 0000:00:05.0: irq 26 for MSI/MSI-X [ 3.462274] virtio-pci 0000:00:05.0: irq 27 for MSI/MSI-X [ 3.462314] virtio-pci 0000:00:05.0: irq 28 for MSI/MSI-X [ 3.469120] virtio_blk virtio1: [vda] 60792 512-byte logical blocks (31.1 MB/29.6 MiB) [ 3.479663] virtio-pci 0000:00:06.0: irq 29 for MSI/MSI-X [ 3.479697] virtio-pci 0000:00:06.0: irq 30 for MSI/MSI-X [ 3.479720] virtio-pci 0000:00:06.0: irq 31 for MSI/MSI-X [ 3.479743] virtio-pci 0000:00:06.0: irq 32 for MSI/MSI-X [ 3.479765] virtio-pci 0000:00:06.0: irq 33 for MSI/MSI-X [ 3.487174] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.494034] virtio-pci 0000:00:07.0: irq 34 for MSI/MSI-X [ 3.494089] virtio-pci 0000:00:07.0: irq 35 for MSI/MSI-X [ 3.494132] virtio-pci 0000:00:07.0: irq 36 for MSI/MSI-X [ 3.494172] virtio-pci 0000:00:07.0: irq 37 for MSI/MSI-X [ 3.494211] virtio-pci 0000:00:07.0: irq 38 for MSI/MSI-X [ 3.501445] virtio_blk virtio3: [vdc] 5120000 512-byte logical blocks (2.62 GB/2.44 GiB) [ 3.511270] virtio-pci 0000:00:08.0: irq 39 for MSI/MSI-X [ 3.511317] virtio-pci 0000:00:08.0: irq 40 for MSI/MSI-X [ 3.511358] virtio-pci 0000:00:08.0: irq 41 for MSI/MSI-X [ 3.511399] virtio-pci 0000:00:08.0: irq 42 for MSI/MSI-X [ 3.511456] virtio-pci 0000:00:08.0: irq 43 for MSI/MSI-X [ 3.517851] virtio_blk virtio4: [vdd] 5120000 512-byte logical blocks (2.62 GB/2.44 GiB) [ 3.525260] virtio-pci 0000:00:09.0: irq 44 for MSI/MSI-X [ 3.525309] virtio-pci 0000:00:09.0: irq 45 for MSI/MSI-X [ 3.525355] virtio-pci 0000:00:09.0: irq 46 for MSI/MSI-X [ 3.525400] virtio-pci 0000:00:09.0: irq 47 for MSI/MSI-X [ 3.525465] virtio-pci 0000:00:09.0: irq 48 for MSI/MSI-X [ 3.531654] virtio_blk virtio5: [vde] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) [ 3.543599] virtio-pci 0000:00:0a.0: irq 49 for MSI/MSI-X [ 3.543635] virtio-pci 0000:00:0a.0: irq 50 for MSI/MSI-X [ 3.543665] virtio-pci 0000:00:0a.0: irq 51 for MSI/MSI-X [ 3.543705] virtio-pci 0000:00:0a.0: irq 52 for MSI/MSI-X [ 3.543739] virtio-pci 0000:00:0a.0: irq 53 for MSI/MSI-X [ 3.549236] virtio_blk virtio6: [vdf] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) [ 3.559150] rdac: device handler registered [ 3.561699] hp_sw: device handler registered [ 3.563080] emc: device handler registered [ 3.564548] libphy: Fixed MDIO Bus: probed [ 3.573004] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 3.575228] ehci-pci: EHCI PCI platform driver [ 3.576798] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 3.578710] ohci-pci: OHCI PCI platform driver [ 3.580314] uhci_hcd: USB Universal Host Controller Interface driver [ 3.582561] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.586094] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.587769] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.589827] mousedev: PS/2 mouse device common for all mice [ 3.591741] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.592312] rtc_cmos 00:05: RTC can wake from S4 [ 3.594858] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0 [ 3.595509] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.598277] hidraw: raw HID events driver (C) Jiri Kosina [ 3.598547] usbcore: registered new interface driver usbhid [ 3.598548] usbhid: USB HID core driver [ 3.598640] drop_monitor: Initializing network drop monitor service [ 3.598693] Netfilter messages via NETLINK v0.30. [ 3.598755] TCP: cubic registered [ 3.598762] Initializing XFRM netlink socket [ 3.599089] NET: Registered protocol family 10 [ 3.599679] NET: Registered protocol family 17 [ 3.599728] Key type dns_resolver registered [ 3.600248] mce: Using 10 MCE banks [ 3.600973] Loading compiled-in X.509 certificates [ 3.602063] Loaded X.509 cert 'Magrathea: Glacier signing key: e34d0e1b7fcf5b414cce75d36d8482945c781ed6' [ 3.602118] registered taskstats version 1 [ 3.606564] modprobe (71) used greatest stack depth: 13456 bytes left [ 3.611023] Key type trusted registered [ 3.616488] Key type encrypted registered [ 3.616568] IMA: No TPM chip found, activating TPM-bypass! (rc=-19) [ 3.621843] BERT: Boot Error Record Table support is disabled. Enable it by using bert_enable as kernel parameter. [ 3.628749] rtc_cmos 00:05: setting system clock to 2024-08-22 05:26:43 UTC (1724304403) [ 3.635969] debug: unmapping init [mem 0xffffffff81da0000-0xffffffff82018fff] [ 3.641071] Write protecting the kernel read-only data: 12288k [ 3.643969] debug: unmapping init [mem 0xffff8800017fe000-0xffff8800017fffff] [ 3.646674] debug: unmapping init [mem 0xffff880001b9b000-0xffff880001bfffff] [ 3.661665] random: systemd: uninitialized urandom read (16 bytes read) [ 3.665700] random: systemd: uninitialized urandom read (16 bytes read) [ 3.667472] random: systemd: uninitialized urandom read (16 bytes read) [ 3.671840] systemd[1]: systemd 219 running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 -SECCOMP +BLKID +ELFUTILS +KMOD +IDN) [ 3.680873] systemd[1]: Detected virtualization kvm. [ 3.682501] systemd[1]: Detected architecture x86-64. [ 3.684214] systemd[1]: Running in initial RAM disk. [ 3.690685] systemd[1]: No hostname configured. [ 3.693714] systemd[1]: Set hostname to . [ 3.697085] random: systemd: uninitialized urandom read (16 bytes read) [ 3.699294] systemd[1]: Initializing machine ID from random generator. [ 3.758805] dracut-rootfs-g (86) used greatest stack depth: 13264 bytes left [ 3.761791] random: systemd: uninitialized urandom read (16 bytes read) [ 3.763896] random: systemd: uninitialized urandom read (16 bytes read) [ 3.766305] random: systemd: uninitialized urandom read (16 bytes read) [ 3.768135] random: systemd: uninitialized urandom read (16 bytes read) [ 3.771396] random: systemd: uninitialized urandom read (16 bytes read) [ 3.773968] random: systemd: uninitialized urandom read (16 bytes read) [ 3.786986] systemd[1]: Created slice Root Slice. [ 3.794068] systemd[1]: Created slice System Slice. [ 3.798263] systemd[1]: Listening on udev Control Socket. [ 3.803041] systemd[1]: Reached target Local File Systems. [ 3.807803] systemd[1]: Listening on udev Kernel Socket. [ 3.812751] systemd[1]: Listening on Journal Socket. [ 3.818040] systemd[1]: Starting Journal Service... [ 3.821745] systemd[1]: Reached target Sockets. [ 3.831251] systemd[1]: Starting Create list of required static device nodes for the current kernel... [ 3.838565] systemd[1]: Starting Load Kernel Modules... [ 3.842600] tsc: Refined TSC clocksource calibration: 2399.961 MHz [ 3.846283] systemd[1]: Reached target Swap. [ 3.851989] systemd[1]: Starting dracut cmdline hook... [ 3.857400] systemd[1]: Reached target Timers. [ 3.863505] systemd[1]: Starting Setup Virtual Console... [ 3.867349] systemd[1]: Reached target Slices. [ 3.871977] systemd[1]: Started Journal Service. [ 4.108571] random: fast init done [ 4.458455] libata version 3.00 loaded. [ 4.470251] ata_piix 0000:00:01.1: version 2.13 [ 4.483836] scsi host0: ata_piix [ 4.492076] scsi host1: ata_piix [ 4.494053] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc320 irq 14 [ 4.502196] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc328 irq 15 [ 4.503269] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 [ 4.620440] ip (321) used greatest stack depth: 13080 bytes left [ 4.691989] ip (344) used greatest stack depth: 12336 bytes left [ 11.000424] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ 11.638028] systemd-journald[100]: Received SIGTERM from PID 1 (systemd). [ 12.005145] SELinux: Disabled at runtime. [ 12.008136] SELinux: Unregistering netfilter hooks [ 12.097129] ip_tables: (C) 2000-2006 Netfilter Core Team [ 12.114105] systemd[1]: Inserted module 'ip_tables' [ 13.148505] systemd-journald[569]: Received request to flush runtime journal from PID 1 [ 13.401485] input: PC Speaker as /devices/platform/pcspkr/input/input3 [ 13.472817] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 13.556094] cryptd: max_cpu_qlen set to 1000 [ 13.651402] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ 13.659170] AVX version of gcm_enc/dec engaged. [ 13.660797] AES CTR mode by8 optimization enabled [ 13.760754] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 13.788933] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni) [ 13.803383] alg: No test for __generic-gcm-aes-aesni (__driver-generic-gcm-aes-aesni) [ 14.065929] EDAC MC: Ver: 3.0.0 [ 14.084735] EDAC sbridge: Seeking for: PCI ID 8086:0ea0 [ 14.084750] EDAC sbridge: Ver: 1.1.2 [ 17.151121] mount.nfs (774) used greatest stack depth: 10704 bytes left [ 30.380302] libcfs: loading out-of-tree module taints kernel. [ 30.381820] libcfs: module verification failed: signature and/or required key missing - tainting kernel [ 30.407495] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_hostid [ 35.144788] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 35.353956] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 35.358150] alg: No test for adler32 (adler32-zlib) [ 36.247098] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 36.404359] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 36.405800] LNet: Accept secure, port 988 [ 37.950708] Key type lgssc registered [ 38.238331] Lustre: Echo OBD driver; http://www.lustre.org/ [ 38.682601] icp: module license 'CDDL' taints kernel. [ 38.684123] Disabling lock debugging due to kernel taint [ 40.179040] ZFS: Loaded module v2.1.5-1, ZFS pool version 5000, ZFS filesystem version 5 [ 42.965243] vdc: vdc1 vdc9 [ 46.363300] vde: vde1 vde9 [ 49.606767] vdf: vdf1 vdf9 [ 54.709474] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 56.805239] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 57.906244] Lustre: Setting parameter lustre-MDT0000.mdt.identity_upcall in log lustre-MDT0000 [ 57.957599] Lustre: ctl-lustre-MDT0000: No data found on store. Initialize space. [ 57.992504] Lustre: lustre-MDT0000: new disk, initializing [ 58.073202] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 58.098864] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000200000400-0x0000000240000400]:0:mdt [ 58.161382] mount.lustre (6962) used greatest stack depth: 10256 bytes left [ 58.981677] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 61.107771] Lustre: Modifying parameter general.debug_raw_pointers in log params [ 62.522919] Lustre: lustre-OST0000: new disk, initializing [ 62.525251] Lustre: srv-lustre-OST0000: No data found on store. Initialize space. [ 62.527355] Lustre: Skipped 1 previous similar message [ 62.546271] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 62.580523] random: crng init done [ 62.617690] mount.lustre (8299) used greatest stack depth: 10144 bytes left [ 63.652303] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000240000400-0x0000000280000400]:0:ost [ 63.655963] Lustre: cli-lustre-OST0000-super: Allocated super-sequence [0x0000000240000400-0x0000000280000400]:0:ost] [ 63.682836] Lustre: lustre-OST0000-osc-MDT0000: update sequence from 0x100000000 to 0x240000400 [ 63.893375] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 66.921077] Lustre: lustre-OST0001: new disk, initializing [ 66.922794] Lustre: srv-lustre-OST0001: No data found on store. Initialize space. [ 66.936896] Lustre: lustre-OST0001: Imperative Recovery not enabled, recovery window 60-180 [ 68.116836] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 70.822428] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000280000400-0x00000002c0000400]:1:ost [ 70.826763] Lustre: cli-lustre-OST0001-super: Allocated super-sequence [0x0000000280000400-0x00000002c0000400]:1:ost] [ 70.854601] Lustre: lustre-OST0001-osc-MDT0000: update sequence from 0x100010000 to 0x280000400 [ 72.784645] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 79.986364] Lustre: Setting parameter general.lod.*.mdt_hash in log params [ 86.200989] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing check_logdir /tmp/testlogs/ [ 87.148505] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing yml_node [ 88.206615] Lustre: DEBUG MARKER: Client: 2.15.64.172 [ 88.787659] Lustre: DEBUG MARKER: MDS: 2.15.64.172 [ 89.381448] Lustre: DEBUG MARKER: OSS: 2.15.64.172 [ 89.732200] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 22 01:28:08 EDT 2024 [ 93.479476] Lustre: DEBUG MARKER: excepting tests: 21e 32b 32c 32newtarball 110 [ 93.833482] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 105.849976] Lustre: lustre-MDT0000-lwp-OST0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 105.850257] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 105.861964] Lustre: Skipped 1 previous similar message [ 106.881816] Lustre: server umount lustre-MDT0000 complete [ 108.132553] LustreError: 7045:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304508 with bad export cookie 11088767040171448230 [ 108.133055] LustreError: MGC192.168.204.124@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 108.141077] LustreError: 7045:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 2 previous similar messages [ 110.144137] Lustre: server umount lustre-OST0000 complete [ 117.444079] Lustre: server umount lustre-OST0001 complete [ 119.108894] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_hostid [ 121.060207] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 123.559016] vdc: vdc1 vdc9 [ 126.168607] vde: vde1 vde9 [ 128.935745] vdf: vdf1 vdf9 [ 131.591316] Lustre: Setting parameter lustre-MDT0000.mdt.identity_upcall in log lustre-MDT0000 [ 131.621583] Lustre: ctl-lustre-MDT0000: No data found on store. Initialize space. [ 131.659969] Lustre: lustre-MDT0000: new disk, initializing [ 131.753958] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 131.771493] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000200000400-0x0000000240000400]:0:mdt [ 132.670425] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 135.533072] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 137.259851] Lustre: lustre-OST0000: new disk, initializing [ 137.262580] Lustre: srv-lustre-OST0000: No data found on store. Initialize space. [ 137.266664] Lustre: Skipped 1 previous similar message [ 137.299883] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 137.343796] mount.lustre (18841) used greatest stack depth: 9616 bytes left [ 138.714753] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000240000400-0x0000000280000400]:0:ost [ 138.718976] Lustre: cli-lustre-OST0000-super: Allocated super-sequence [0x0000000240000400-0x0000000280000400]:0:ost] [ 138.752497] Lustre: lustre-OST0000-osc-MDT0000: update sequence from 0x100000000 to 0x240000400 [ 138.808330] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 141.543361] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 142.526028] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing wait_import_state FULL os[cp].lustre-OST0000-osc-MDT0000.ost_server_uuid 50 [ 142.588389] Lustre: DEBUG MARKER: os[cp].lustre-OST0000-osc-MDT0000.ost_server_uuid in FULL state after 0 sec [ 143.690497] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 143.696929] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 143.699290] Lustre: Skipped 1 previous similar message [ 145.228322] Lustre: server umount lustre-OST0000 complete [ 146.602815] Lustre: server umount lustre-MDT0000 complete [ 147.725613] Lustre: DEBUG MARKER: == conf-sanity test 0: single mount setup ================ 01:29:06 (1724304546) [ 149.559607] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 150.627845] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 152.372820] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 155.658982] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 157.144274] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 167.259263] LustreError: lustre-OST0000-osc-MDT0000: operation ost_destroy to node 0@lo failed: rc = -107 [ 167.261723] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 167.267044] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 170.304540] Lustre: server umount lustre-OST0000 complete [ 171.438453] Lustre: server umount lustre-MDT0000 complete [ 174.371197] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 174.845999] Key type lgssc unregistered [ 174.906897] LNet: 24148:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 175.911787] LNet: Removed LNI 192.168.204.124@tcp [ 181.695362] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 181.836962] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 181.866686] alg: No test for adler32 (adler32-zlib) [ 182.677364] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 182.727649] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 182.729883] LNet: Accept secure, port 988 [ 184.258680] Key type lgssc registered [ 184.470847] Lustre: Echo OBD driver; http://www.lustre.org/ [ 185.710250] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 186.894634] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 187.628129] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 188.808596] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 190.107681] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 191.341387] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 192.651678] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 197.105276] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:35 to 0x240000400:65) [ 202.106469] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 202.106640] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 202.113591] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 203.044331] Lustre: server umount lustre-OST0000 complete [ 206.104210] Lustre: server umount lustre-MDT0000 complete [ 208.888075] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 209.339415] Key type lgssc unregistered [ 209.406882] LNet: 28827:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 210.412874] LNet: Removed LNI 192.168.204.124@tcp [ 216.168799] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 216.304800] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 216.331893] alg: No test for adler32 (adler32-zlib) [ 217.144812] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 217.195250] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 217.197360] LNet: Accept secure, port 988 [ 218.723647] Key type lgssc registered [ 218.924171] Lustre: Echo OBD driver; http://www.lustre.org/ [ 220.180343] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 221.372521] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 222.119047] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 223.336541] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 225.609390] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 226.783368] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 227.975592] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 231.615811] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:67 to 0x240000400:97) [ 236.618074] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 236.618118] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 236.625718] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 236.813087] Lustre: server umount lustre-OST0000 complete [ 239.900459] Lustre: server umount lustre-MDT0000 complete [ 242.600450] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 243.038316] Key type lgssc unregistered [ 243.098940] LNet: 932:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 244.103809] LNet: Removed LNI 192.168.204.124@tcp [ 249.826299] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 250.001504] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 250.005626] alg: No test for adler32 (adler32-zlib) [ 250.810644] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 250.853030] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 250.854478] LNet: Accept secure, port 988 [ 252.375678] Key type lgssc registered [ 252.595351] Lustre: Echo OBD driver; http://www.lustre.org/ [ 253.945921] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 255.149126] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 255.969439] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 257.347103] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 258.742433] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 260.019682] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 261.315063] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 265.749588] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:99 to 0x240000400:129) [ 270.746425] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 270.746506] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 270.746858] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 271.538963] Lustre: server umount lustre-OST0000 complete [ 272.705314] Lustre: server umount lustre-MDT0000 complete [ 275.643101] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 276.143724] Key type lgssc unregistered [ 276.202873] LNet: 5220:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 277.210939] LNet: Removed LNI 192.168.204.124@tcp [ 283.413457] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 283.568665] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 283.599405] alg: No test for adler32 (adler32-zlib) [ 284.412745] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 284.464185] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 284.466538] LNet: Accept secure, port 988 [ 285.994688] Key type lgssc registered [ 286.203758] Lustre: Echo OBD driver; http://www.lustre.org/ [ 287.486781] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 288.675301] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 289.452817] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 290.709541] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 292.048686] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 293.324924] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 294.621944] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 299.046476] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:131 to 0x240000400:161) [ 304.058165] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 304.058218] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 304.058538] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 305.747513] Lustre: lustre-OST0000: Not available for connect from 192.168.204.24@tcp (stopping) [ 308.585050] Lustre: server umount lustre-OST0000 complete [ 326.731954] Lustre: server umount lustre-MDT0000 complete [ 329.766507] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 330.337656] Key type lgssc unregistered [ 330.416181] LNet: 9747:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 331.421774] LNet: Removed LNI 192.168.204.124@tcp [ 337.532376] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 337.659130] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 337.668213] alg: No test for adler32 (adler32-zlib) [ 338.480244] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 338.532537] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 338.534959] LNet: Accept secure, port 988 [ 340.065631] Key type lgssc registered [ 340.265348] Lustre: Echo OBD driver; http://www.lustre.org/ [ 341.522447] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 342.711940] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 343.483086] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 344.747545] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 346.032656] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 347.268137] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 348.428916] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 353.031109] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:163 to 0x240000400:193) [ 358.042292] Lustre: lustre-MDT0000-lwp-OST0000: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 358.047162] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 359.537854] Lustre: lustre-MDT0000: Not available for connect from 192.168.204.24@tcp (stopping) [ 362.410153] Lustre: server umount lustre-MDT0000 complete [ 372.933301] LustreError: 11159:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 192.168.204.24@tcp arrived at 1724304772 with bad export cookie 9066866037689083042 [ 372.937028] LustreError: 11159:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 2 previous similar messages [ 373.411601] LustreError: MGC192.168.204.124@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 379.464654] Lustre: server umount lustre-OST0000 complete [ 383.218285] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 383.768466] Key type lgssc unregistered [ 383.832152] LNet: 14274:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 384.837874] LNet: Removed LNI 192.168.204.124@tcp [ 392.299547] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 392.477617] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 392.513629] alg: No test for adler32 (adler32-zlib) [ 393.336830] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 393.394056] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 393.396505] LNet: Accept secure, port 988 [ 394.933733] Key type lgssc registered [ 395.227115] Lustre: Echo OBD driver; http://www.lustre.org/ [ 396.809868] Lustre: lustre-OST0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 413.895781] LustreError: Failed to get MGS log lustre-sptlrpc and no local copy. [ 449.898727] LustreError: 15678:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.204.124@tcp: failed processing log, type 4: rc = -110 [ 479.917901] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 482.029584] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 484.229345] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 647.765859] Lustre: server umount lustre-OST0000 complete [ 656.086630] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 657.965938] Key type lgssc unregistered [ 658.181103] LNet: 17510:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 659.196032] LNet: Removed LNI 192.168.204.124@tcp [ 669.895035] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 670.036782] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 670.045194] alg: No test for adler32 (adler32-zlib) [ 670.867365] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 670.925050] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 670.927514] LNet: Accept secure, port 988 [ 672.461322] Key type lgssc registered [ 672.817273] Lustre: Echo OBD driver; http://www.lustre.org/ [ 674.918842] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 676.302986] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 677.569233] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 679.465383] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 681.537506] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 683.255514] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 684.963177] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 685.741310] Lustre: server umount lustre-OST0000 complete [ 687.225769] Lustre: server umount lustre-MDT0000 complete [ 691.452513] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 692.458973] Key type lgssc unregistered [ 692.573553] LNet: 21669:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 693.582487] LNet: Removed LNI 192.168.204.124@tcp [ 702.818762] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 703.027949] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 703.040752] alg: No test for adler32 (adler32-zlib) [ 703.905141] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 703.979297] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 703.984099] LNet: Accept secure, port 988 [ 705.537744] Key type lgssc registered [ 705.892128] Lustre: Echo OBD driver; http://www.lustre.org/ [ 708.094012] Lustre: lustre-OST0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 725.226354] LustreError: Failed to get MGS log lustre-sptlrpc and no local copy. [ 761.236299] LustreError: 23079:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.204.124@tcp: failed processing log, type 4: rc = -110 [ 791.302626] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 794.206946] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 796.650314] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 800.079731] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 800.172254] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:195 to 0x240000400:225) [ 801.713164] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 804.214084] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 807.229982] Lustre: server umount lustre-OST0000 complete [ 832.790100] Lustre: server umount lustre-MDT0000 complete [ 837.441021] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 838.539400] Key type lgssc unregistered [ 838.632727] LNet: 26249:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 839.642619] LNet: Removed LNI 192.168.204.124@tcp [ 848.587638] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 848.777062] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 848.823204] alg: No test for adler32 (adler32-zlib) [ 849.658548] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 849.722657] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 849.725309] LNet: Accept secure, port 988 [ 851.268672] Key type lgssc registered [ 851.682725] Lustre: Echo OBD driver; http://www.lustre.org/ [ 853.921439] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 855.276654] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 856.588104] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 858.726629] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 861.040702] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 863.088640] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 865.299337] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 866.033501] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:195 to 0x240000400:257) [ 891.066345] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 891.067052] Lustre: lustre-OST0000-osc-MDT0000: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 891.067352] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 892.714819] Lustre: server umount lustre-OST0000 complete [ 894.078476] Lustre: server umount lustre-MDT0000 complete [ 897.474238] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing unload_modules_local [ 898.108548] Key type lgssc unregistered [ 898.198325] LNet: 30647:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 899.208316] LNet: Removed LNI 192.168.204.124@tcp [ 909.301970] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing load_modules_local [ 909.452754] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 909.458621] alg: No test for adler32 (adler32-zlib) [ 910.293500] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 910.356882] LNet: Added LNI 192.168.204.124@tcp [8/256/0/180] [ 910.360365] LNet: Accept secure, port 988 [ 911.895409] Key type lgssc registered [ 912.198184] Lustre: Echo OBD driver; http://www.lustre.org/ [ 914.081838] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 915.375236] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 916.295182] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 917.775648] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 919.675844] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 921.230358] Lustre: DEBUG MARKER: oleg424-server.virtnet: executing set_default_debug -1 all [ 922.695754] Lustre: DEBUG MARKER: oleg424-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 925.669282] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x240000400:195 to 0x240000400:289) [ 930.755283] Lustre: Failing over lustre-MDT0000 [ 930.899496] Lustre: server umount lustre-MDT0000 complete [ 933.414144] LustreError: MGC192.168.204.124@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 933.549455] Lustre: *** cfs_fail_loc=135, val=0*** [ 933.602019] BUG: unable to handle kernel paging request at fffffffffffffffe [ 933.603840] IP: [] obd_setup+0x156/0x390 [obdclass] [ 933.605801] PGD 1c14067 PUD 1c16067 PMD 0 [ 933.606897] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC [ 933.608148] Modules linked in: lustre(OE) osp(OE) ofd(OE) lod(OE) ost(OE) mdt(OE) mdd(OE) mgs(OE) osd_zfs(OE) lquota(OE) lfsck(OE) obdecho(OE) mgc(OE) mdc(OE) lov(OE) osc(OE) lmv(OE) fid(OE) fld(OE) ptlrpc_gss(OE) ptlrpc(OE) obdclass(OE) ksocklnd(OE) lnet(OE) libcfs(OE) zfs(PO) zunicode(PO) zzstd(O) zlua(O) zcommon(PO) znvpair(PO) zavl(PO) icp(PO) spl(O) crc_t10dif crct10dif_generic rpcsec_gss_krb5 sb_edac edac_core iosf_mbi kvm_intel kvm irqbypass crc32_pclmul ghash_clmulni_intel squashfs aesni_intel lrw gf128mul glue_helper ablk_helper cryptd i2c_piix4 i2c_core pcspkr binfmt_misc ip_tables ext4 mbcache jbd2 ata_generic pata_acpi crct10dif_pclmul crct10dif_common crc32c_intel ata_piix serio_raw libata [last unloaded: libcfs] [ 933.628098] CPU: 3 PID: 2677 Comm: llog_process_th Kdump: loaded Tainted: P OE ------------ 3.10.0-7.9-debug #1 [ 933.631285] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-1.fc38 04/01/2014 [ 933.633594] task: ffff8800b53e2220 ti: ffff88009f788000 task.ti: ffff88009f788000 [ 933.635774] RIP: 0010:[] [] obd_setup+0x156/0x390 [obdclass] [ 933.638096] RSP: 0018:ffff88009f78baa0 EFLAGS: 00010246 [ 933.639370] RAX: fffffffffffffffe RBX: fffffffffffffffe RCX: 0000000000000000 [ 933.640867] RDX: 0000000000000003 RSI: 0000000000000000 RDI: ffff88009f2a6b80 [ 933.642121] RBP: ffff88009f78bb40 R08: 000000000000ffff R09: 000000000000ffff [ 933.644045] R10: 0000000000000000 R11: ffff880099484000 R12: ffff88012f993ff0 [ 933.645804] R13: 0000000000000000 R14: ffff8800b52656c0 R15: 0000000000000000 [ 933.647268] FS: 0000000000000000(0000) GS:ffff88013e380000(0000) knlGS:0000000000000000 [ 933.649647] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 933.651455] CR2: fffffffffffffffe CR3: 0000000001c10000 CR4: 0000000000160fe0 [ 933.653611] Call Trace: [ 933.654293] [] class_setup+0x54f/0x830 [obdclass] [ 933.655961] [] class_process_config+0x197e/0x27d0 [obdclass] [ 933.658273] [] class_config_llog_handler+0x817/0x13e0 [obdclass] [ 933.660608] [] llog_process_thread+0xc96/0x1c60 [obdclass] [ 933.662542] [] ? keys_fill+0xdf/0x120 [obdclass] [ 933.664339] [] llog_process_thread_daemonize+0xa2/0xe0 [obdclass] [ 933.666833] [] ? llog_validate+0x3b0/0x3b0 [obdclass] [ 933.668610] [] kthread+0xe4/0xf0 [ 933.669935] [] ? kthread_create_on_node+0x140/0x140 [ 933.671628] [] ret_from_fork_nospec_begin+0x7/0x21 [ 933.673585] [] ? kthread_create_on_node+0x140/0x140 [ 933.675762] Code: 00 e8 cf 5b c9 ff eb 9f 0f 1f 44 00 00 48 8d 85 60 ff ff ff 48 89 de 4c 89 f2 48 8d 7d 90 48 89 45 c0 48 8b 43 10 ff 10 48 89 c3 <8b> 00 85 c0 0f 8e e4 01 00 00 48 8d 7d 90 e8 17 56 01 00 48 81 [ 933.682800] RIP [] obd_setup+0x156/0x390 [obdclass] [ 933.684672] RSP [ 933.685705] CR2: fffffffffffffffe