[ 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 293085102 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.410668] Calibrating delay loop (skipped) preset value.. 4799.99 BogoMIPS (lpj=2399998) [ 0.412230] pid_max: default: 32768 minimum: 301 [ 0.413361] Security Framework initialized [ 0.414068] SELinux: Initializing. [ 0.414740] SELinux: Starting in permissive mode [ 0.415936] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.418832] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.421175] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.423149] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.426081] Initializing cgroup subsys memory [ 0.427843] Initializing cgroup subsys devices [ 0.429631] Initializing cgroup subsys freezer [ 0.431396] Initializing cgroup subsys net_cls [ 0.433111] Initializing cgroup subsys blkio [ 0.434767] Initializing cgroup subsys perf_event [ 0.436772] Initializing cgroup subsys hugetlb [ 0.438879] Initializing cgroup subsys pids [ 0.440417] Initializing cgroup subsys net_prio [ 0.441834] x86/cpu: User Mode Instruction Prevention (UMIP) activated [ 0.444892] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.447276] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.448333] tlb_flushall_shift: 6 [ 0.448954] FEATURE SPEC_CTRL Present [ 0.449770] FEATURE IBPB_SUPPORT Present [ 0.451419] Spectre V2 : Enabling Indirect Branch Prediction Barrier [ 0.452909] Spectre V2 : Vulnerable [ 0.453667] Speculative Store Bypass: Vulnerable [ 0.455732] debug: unmapping init [mem 0xffffffff82019000-0xffffffff8201ffff] [ 0.464319] ACPI: Core revision 20130517 [ 0.466752] ACPI: All ACPI Tables successfully acquired [ 0.467810] ftrace: allocating 30294 entries in 119 pages [ 0.518624] Enabling x2apic [ 0.519212] Enabled x2apic [ 0.520276] Switched APIC routing to physical x2apic. [ 0.523119] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.525468] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2695 v2 @ 2.40GHz (fam: 06, model: 3e, stepping: 04) [ 0.529066] TSC deadline timer enabled [ 0.529251] Performance Events: IvyBridge events, full-width counters, Intel PMU driver. [ 0.532060] ... version: 2 [ 0.533382] ... bit width: 48 [ 0.534736] ... generic registers: 4 [ 0.536032] ... value mask: 0000ffffffffffff [ 0.537689] ... max period: 00007fffffffffff [ 0.539369] ... fixed-purpose events: 3 [ 0.540589] ... event mask: 000000070000000f [ 0.542367] KVM setup paravirtual spinlock [ 0.547873] kvm-clock: cpu 1, msr 1:3e592041, secondary cpu clock [ 0.550735] KVM setup async PF for cpu 1 [ 0.551835] kvm-stealtime: cpu 1, msr 13e2935c0 [ 0.553951] kvm-clock: cpu 2, msr 1:3e592081, secondary cpu clock [ 0.556932] KVM setup async PF for cpu 2 [ 0.545883] smpboot: Booting Node 0, Processors #1 #2 #3 OK [ 0.557891] kvm-clock: cpu 3, msr 1:3e5920c1, secondary cpu clock [ 0.560116] kvm-stealtime: cpu 2, msr 13e3135c0 [ 0.561844] Brought up 4 CPUs [ 0.562013] KVM setup async PF for cpu 3 [ 0.562078] kvm-stealtime: cpu 3, msr 13e3935c0 [ 0.564977] smpboot: Max logical packages: 1 [ 0.566023] smpboot: Total of 4 processors activated (19199.98 BogoMIPS) [ 0.570071] devtmpfs: initialized [ 0.571242] x86/mm: Memory block size: 128MB [ 0.575639] EVM: security.selinux [ 0.576689] EVM: security.ima [ 0.577580] EVM: security.capability [ 0.580500] atomic64 test passed for x86-64 platform with CX8 and with SSE [ 0.582964] NET: Registered protocol family 16 [ 0.584885] cpuidle: using governor haltpoll [ 0.587028] ACPI: bus type PCI registered [ 0.588482] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.591026] PCI: Using configuration type 1 for base access [ 0.593078] core: PMU erratum BJ122, BV98, HSD29 worked around, HT is on [ 0.602256] ACPI: Added _OSI(Module Device) [ 0.603535] ACPI: Added _OSI(Processor Device) [ 0.604623] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.605966] ACPI: Added _OSI(Processor Aggregator Device) [ 0.607681] ACPI: Added _OSI(Linux-Dell-Video) [ 0.610135] ACPI: EC: Look up EC in DSDT [ 0.613214] ACPI: Interpreter enabled [ 0.614379] ACPI: (supports S0 S3 S4 S5) [ 0.615614] ACPI: Using IOAPIC for interrupt routing [ 0.616967] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.620055] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.627183] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.629191] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] [ 0.630442] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.632394] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.635639] acpiphp: Slot [2] registered [ 0.636366] acpiphp: Slot [3] registered [ 0.637072] acpiphp: Slot [4] registered [ 0.638013] acpiphp: Slot [5] registered [ 0.638739] acpiphp: Slot [6] registered [ 0.639719] acpiphp: Slot [7] registered [ 0.640503] acpiphp: Slot [8] registered [ 0.641178] acpiphp: Slot [9] registered [ 0.641919] acpiphp: Slot [10] registered [ 0.642795] acpiphp: Slot [11] registered [ 0.643498] acpiphp: Slot [12] registered [ 0.644487] acpiphp: Slot [13] registered [ 0.645154] acpiphp: Slot [14] registered [ 0.646207] acpiphp: Slot [15] registered [ 0.647279] acpiphp: Slot [16] registered [ 0.648382] acpiphp: Slot [17] registered [ 0.649542] acpiphp: Slot [18] registered [ 0.650687] acpiphp: Slot [19] registered [ 0.651794] acpiphp: Slot [20] registered [ 0.652679] acpiphp: Slot [21] registered [ 0.653486] acpiphp: Slot [22] registered [ 0.654850] acpiphp: Slot [23] registered [ 0.656156] acpiphp: Slot [24] registered [ 0.657479] acpiphp: Slot [25] registered [ 0.658864] acpiphp: Slot [26] registered [ 0.660085] acpiphp: Slot [27] registered [ 0.660771] acpiphp: Slot [28] registered [ 0.661644] acpiphp: Slot [29] registered [ 0.662300] acpiphp: Slot [30] registered [ 0.664134] acpiphp: Slot [31] registered [ 0.665506] PCI host bridge to bus 0000:00 [ 0.666839] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.669071] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.671267] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.673747] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.676130] pci_bus 0000:00: root bus resource [mem 0x140000000-0x1bfffffff window] [ 0.678376] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.680120] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.680985] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.681948] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.689078] pci 0000:00:01.1: reg 0x20: [io 0xc320-0xc32f] [ 0.691935] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.695122] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.697179] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.699315] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.701741] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.702385] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.704698] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.707410] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 [ 0.709271] pci 0000:00:02.0: reg 0x10: [io 0xc300-0xc31f] [ 0.718451] pci 0000:00:02.0: reg 0x20: [mem 0xfebe4000-0xfebe7fff 64bit pref] [ 0.720045] pci 0000:00:02.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.721335] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.729786] pci 0000:00:05.0: reg 0x10: [io 0xc000-0xc07f] [ 0.735518] pci 0000:00:05.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff] [ 0.797020] pci 0000:00:05.0: reg 0x20: [mem 0xfebe8000-0xfebebfff 64bit pref] [ 0.801198] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.804242] pci 0000:00:06.0: reg 0x10: [io 0xc080-0xc0ff] [ 0.821272] pci 0000:00:06.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff] [ 0.836758] pci 0000:00:06.0: reg 0x20: [mem 0xfebec000-0xfebeffff 64bit pref] [ 0.843230] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 0.846876] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc17f] [ 0.849141] pci 0000:00:07.0: reg 0x14: [mem 0xfebc2000-0xfebc2fff] [ 0.864844] pci 0000:00:07.0: reg 0x20: [mem 0xfebf0000-0xfebf3fff 64bit pref] [ 0.875219] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 0.881901] pci 0000:00:08.0: reg 0x10: [io 0xc180-0xc1ff] [ 0.892451] pci 0000:00:08.0: reg 0x14: [mem 0xfebc3000-0xfebc3fff] [ 0.905987] pci 0000:00:08.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref] [ 0.915177] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 0.918742] pci 0000:00:09.0: reg 0x10: [io 0xc200-0xc27f] [ 0.925958] pci 0000:00:09.0: reg 0x14: [mem 0xfebc4000-0xfebc4fff] [ 0.941589] pci 0000:00:09.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.945887] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 0.948434] pci 0000:00:0a.0: reg 0x10: [io 0xc280-0xc2ff] [ 0.950803] pci 0000:00:0a.0: reg 0x14: [mem 0xfebc5000-0xfebc5fff] [ 0.963347] pci 0000:00:0a.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.971343] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.973253] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.974948] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.976648] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.978692] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.980945] vgaarb: loaded [ 0.982009] SCSI subsystem initialized [ 0.983101] ACPI: bus type USB registered [ 0.984016] usbcore: registered new interface driver usbfs [ 0.985888] usbcore: registered new interface driver hub [ 0.987231] usbcore: registered new device driver usb [ 0.988543] PCI: Using ACPI for IRQ routing [ 0.989940] PCI: pci_cache_line_size set to 64 bytes [ 0.990206] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.990210] e820: reserve RAM buffer [mem 0xbffce000-0xbfffffff] [ 0.990212] e820: reserve RAM buffer [mem 0x13ee00000-0x13fffffff] [ 0.990540] NetLabel: Initializing [ 0.991516] NetLabel: domain hash size = 128 [ 0.992826] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.994391] NetLabel: unlabeled traffic allowed by default [ 0.996626] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.998313] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 1.003531] amd_nb: Cannot enumerate AMD northbridges [ 1.005263] Switched to clocksource kvm-clock [ 1.023638] pnp: PnP ACPI init [ 1.024594] ACPI: bus type PNP registered [ 1.025972] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.026056] pnp 00:01: Plug and Play ACPI device, IDs PNP0f13 (active) [ 1.026102] pnp 00:02: [dma 2] [ 1.026135] pnp 00:02: Plug and Play ACPI device, IDs PNP0700 (active) [ 1.026225] pnp 00:03: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.026318] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.026409] pnp 00:05: Plug and Play ACPI device, IDs PNP0b00 (active) [ 1.026763] pnp: PnP ACPI: found 6 devices [ 1.027975] ACPI: bus type PNP unregistered [ 1.042620] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.042627] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.042630] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.042633] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.042635] pci_bus 0000:00: resource 8 [mem 0x140000000-0x1bfffffff window] [ 1.042715] NET: Registered protocol family 2 [ 1.044766] TCP established hash table entries: 32768 (order: 6, 262144 bytes) [ 1.048085] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes) [ 1.051441] TCP: Hash tables configured (established 32768 bind 32768) [ 1.053842] TCP: reno registered [ 1.054948] UDP hash table entries: 2048 (order: 5, 196608 bytes) [ 1.056954] UDP-Lite hash table entries: 2048 (order: 5, 196608 bytes) [ 1.059084] NET: Registered protocol family 1 [ 1.061048] RPC: Registered named UNIX socket transport module. [ 1.062824] RPC: Registered udp transport module. [ 1.064428] RPC: Registered tcp transport module. [ 1.066129] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.068379] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.070334] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.072267] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.074112] PCI: CLS 0 bytes, default 64 [ 1.074259] Unpacking initramfs... [ 2.509800] debug: unmapping init [mem 0xffff8800bc2e2000-0xffff8800bffbffff] [ 2.513581] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 2.515683] software IO TLB [mem 0xb82e2000-0xbc2e2000] (64MB) mapped at [ffff8800b82e2000-ffff8800bc2e1fff] [ 2.518347] RAPL PMU: API unit is 2^-32 Joules, 3 fixed counters, 10737418240 ms ovfl timer [ 2.521009] RAPL PMU: hw unit of domain pp0-core 2^-0 Joules [ 2.522988] RAPL PMU: hw unit of domain package 2^-0 Joules [ 2.524823] RAPL PMU: hw unit of domain dram 2^-0 Joules [ 2.528976] cryptomgr_test (51) used greatest stack depth: 14480 bytes left [ 2.530349] futex hash table entries: 1024 (order: 4, 65536 bytes) [ 2.530389] Initialise system trusted keyring [ 2.567775] HugeTLB registered 1 GB page size, pre-allocated 0 pages [ 2.570077] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 2.578011] zpool: loaded [ 2.578898] zbud: loaded [ 2.580145] VFS: Disk quotas dquot_6.6.0 [ 2.581400] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 2.584569] NFS: Registering the id_resolver key type [ 2.586303] Key type id_resolver registered [ 2.587626] Key type id_legacy registered [ 2.588884] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 2.591435] Key type big_key registered [ 2.592566] SELinux: Registering netfilter hooks [ 2.595134] cryptomgr_test (57) used greatest stack depth: 14048 bytes left [ 2.597796] cryptomgr_test (62) used greatest stack depth: 13984 bytes left [ 2.600589] cryptomgr_test (60) used greatest stack depth: 13968 bytes left [ 2.601083] NET: Registered protocol family 38 [ 2.601094] Key type asymmetric registered [ 2.601097] Asymmetric key parser 'x509' registered [ 2.601229] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 2.601737] io scheduler noop registered [ 2.601742] io scheduler deadline registered (default) [ 2.601817] io scheduler cfq registered [ 2.601822] io scheduler mq-deadline registered [ 2.601826] io scheduler kyber registered [ 2.604955] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 2.604983] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 2.630733] intel_idle: does not run on family 6 model 62 [ 2.631521] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 2.634754] ACPI: Power Button [PWRF] [ 2.636700] GHES: HEST is not enabled! [ 2.706247] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10 [ 2.770551] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 11 [ 2.905159] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 2.991141] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10 [ 3.122408] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.167368] 00:03: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A [ 3.207525] 00:04: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 3.212719] Non-volatile memory driver v1.3 [ 3.214626] Linux agpgart interface v0.103 [ 3.217691] crash memory driver: version 1.1 [ 3.222228] nbd: registered device at major 43 [ 3.236009] virtio-pci 0000:00:05.0: irq 24 for MSI/MSI-X [ 3.236054] virtio-pci 0000:00:05.0: irq 25 for MSI/MSI-X [ 3.236093] virtio-pci 0000:00:05.0: irq 26 for MSI/MSI-X [ 3.236137] virtio-pci 0000:00:05.0: irq 27 for MSI/MSI-X [ 3.236176] virtio-pci 0000:00:05.0: irq 28 for MSI/MSI-X [ 3.252249] virtio_blk virtio1: [vda] 60792 512-byte logical blocks (31.1 MB/29.6 MiB) [ 3.261384] virtio-pci 0000:00:06.0: irq 29 for MSI/MSI-X [ 3.261431] virtio-pci 0000:00:06.0: irq 30 for MSI/MSI-X [ 3.261470] virtio-pci 0000:00:06.0: irq 31 for MSI/MSI-X [ 3.261509] virtio-pci 0000:00:06.0: irq 32 for MSI/MSI-X [ 3.261551] virtio-pci 0000:00:06.0: irq 33 for MSI/MSI-X [ 3.268779] virtio_blk virtio2: [vdb] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [ 3.278454] virtio-pci 0000:00:07.0: irq 34 for MSI/MSI-X [ 3.278499] virtio-pci 0000:00:07.0: irq 35 for MSI/MSI-X [ 3.278538] virtio-pci 0000:00:07.0: irq 36 for MSI/MSI-X [ 3.278586] virtio-pci 0000:00:07.0: irq 37 for MSI/MSI-X [ 3.278628] virtio-pci 0000:00:07.0: irq 38 for MSI/MSI-X [ 3.285008] virtio_blk virtio3: [vdc] 5120000 512-byte logical blocks (2.62 GB/2.44 GiB) [ 3.299313] virtio-pci 0000:00:08.0: irq 39 for MSI/MSI-X [ 3.299358] virtio-pci 0000:00:08.0: irq 40 for MSI/MSI-X [ 3.299398] virtio-pci 0000:00:08.0: irq 41 for MSI/MSI-X [ 3.299442] virtio-pci 0000:00:08.0: irq 42 for MSI/MSI-X [ 3.299481] virtio-pci 0000:00:08.0: irq 43 for MSI/MSI-X [ 3.309125] virtio_blk virtio4: [vdd] 5120000 512-byte logical blocks (2.62 GB/2.44 GiB) [ 3.323147] virtio-pci 0000:00:09.0: irq 44 for MSI/MSI-X [ 3.323213] virtio-pci 0000:00:09.0: irq 45 for MSI/MSI-X [ 3.323273] virtio-pci 0000:00:09.0: irq 46 for MSI/MSI-X [ 3.323315] virtio-pci 0000:00:09.0: irq 47 for MSI/MSI-X [ 3.323355] virtio-pci 0000:00:09.0: irq 48 for MSI/MSI-X [ 3.330197] virtio_blk virtio5: [vde] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) [ 3.337848] virtio-pci 0000:00:0a.0: irq 49 for MSI/MSI-X [ 3.337891] virtio-pci 0000:00:0a.0: irq 50 for MSI/MSI-X [ 3.337929] virtio-pci 0000:00:0a.0: irq 51 for MSI/MSI-X [ 3.337974] virtio-pci 0000:00:0a.0: irq 52 for MSI/MSI-X [ 3.340624] virtio-pci 0000:00:0a.0: irq 53 for MSI/MSI-X [ 3.347013] virtio_blk virtio6: [vdf] 8388608 512-byte logical blocks (4.29 GB/4.00 GiB) [ 3.358497] rdac: device handler registered [ 3.359999] hp_sw: device handler registered [ 3.361378] emc: device handler registered [ 3.362816] libphy: Fixed MDIO Bus: probed [ 3.376304] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 3.378389] ehci-pci: EHCI PCI platform driver [ 3.379841] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 3.381659] ohci-pci: OHCI PCI platform driver [ 3.382814] uhci_hcd: USB Universal Host Controller Interface driver [ 3.384834] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.388608] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.390155] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.392694] mousedev: PS/2 mouse device common for all mice [ 3.396084] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 3.397111] rtc_cmos 00:05: RTC can wake from S4 [ 3.398785] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0 [ 3.398995] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [ 3.405664] hidraw: raw HID events driver (C) Jiri Kosina [ 3.405933] usbcore: registered new interface driver usbhid [ 3.405933] usbhid: USB HID core driver [ 3.406029] drop_monitor: Initializing network drop monitor service [ 3.406104] Netfilter messages via NETLINK v0.30. [ 3.406287] TCP: cubic registered [ 3.406295] Initializing XFRM netlink socket [ 3.406697] NET: Registered protocol family 10 [ 3.408958] NET: Registered protocol family 17 [ 3.409007] Key type dns_resolver registered [ 3.410812] mce: Using 10 MCE banks [ 3.412009] Loading compiled-in X.509 certificates [ 3.413109] Loaded X.509 cert 'Magrathea: Glacier signing key: e34d0e1b7fcf5b414cce75d36d8482945c781ed6' [ 3.413158] registered taskstats version 1 [ 3.418634] modprobe (71) used greatest stack depth: 13456 bytes left [ 3.429434] Key type trusted registered [ 3.441131] Key type encrypted registered [ 3.442757] IMA: No TPM chip found, activating TPM-bypass! (rc=-19) [ 3.446853] BERT: Boot Error Record Table support is disabled. Enable it by using bert_enable as kernel parameter. [ 3.451067] rtc_cmos 00:05: setting system clock to 2024-08-22 05:26:39 UTC (1724304399) [ 3.454144] debug: unmapping init [mem 0xffffffff81da0000-0xffffffff82018fff] [ 3.457288] Write protecting the kernel read-only data: 12288k [ 3.460507] debug: unmapping init [mem 0xffff8800017fe000-0xffff8800017fffff] [ 3.463188] debug: unmapping init [mem 0xffff880001b9b000-0xffff880001bfffff] [ 3.472596] random: systemd: uninitialized urandom read (16 bytes read) [ 3.476276] random: systemd: uninitialized urandom read (16 bytes read) [ 3.478440] random: systemd: uninitialized urandom read (16 bytes read) [ 3.482336] 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.487936] systemd[1]: Detected virtualization kvm. [ 3.489630] systemd[1]: Detected architecture x86-64. [ 3.492669] systemd[1]: Running in initial RAM disk. [ 3.498594] systemd[1]: No hostname configured. [ 3.500507] systemd[1]: Set hostname to . [ 3.502116] random: systemd: uninitialized urandom read (16 bytes read) [ 3.504380] systemd[1]: Initializing machine ID from random generator. [ 3.528313] tsc: Refined TSC clocksource calibration: 2399.954 MHz [ 3.565504] dracut-rootfs-g (86) used greatest stack depth: 13264 bytes left [ 3.570274] random: systemd: uninitialized urandom read (16 bytes read) [ 3.572747] random: systemd: uninitialized urandom read (16 bytes read) [ 3.574774] random: systemd: uninitialized urandom read (16 bytes read) [ 3.576955] random: systemd: uninitialized urandom read (16 bytes read) [ 3.580375] random: systemd: uninitialized urandom read (16 bytes read) [ 3.582590] random: systemd: uninitialized urandom read (16 bytes read) [ 3.596098] systemd[1]: Reached target Timers. [ 3.599379] systemd[1]: Reached target Swap. [ 3.603158] systemd[1]: Created slice Root Slice. [ 3.610991] systemd[1]: Listening on udev Control Socket. [ 3.616175] systemd[1]: Created slice System Slice. [ 3.620579] systemd[1]: Reached target Slices. [ 3.627912] systemd[1]: Listening on udev Kernel Socket. [ 3.632184] systemd[1]: Listening on Journal Socket. [ 3.639388] systemd[1]: Starting Setup Virtual Console... [ 3.648894] systemd[1]: Reached target Sockets. [ 3.656753] systemd[1]: Starting Load Kernel Modules... [ 3.667936] systemd[1]: Starting dracut cmdline hook... [ 3.673608] systemd[1]: Reached target Local File Systems. [ 3.685836] systemd[1]: Starting Create list of required static device nodes for the current kernel... [ 3.694351] systemd[1]: Starting Journal Service... [ 3.702107] systemd[1]: Started Setup Virtual Console. [ 3.712451] systemd[1]: Started Load Kernel Modules. [ 3.720828] systemd[1]: Started Create list of required static device nodes for the current kernel. [ 3.733915] systemd[1]: Starting Create Static Device Nodes in /dev... [ 3.741812] systemd[1]: Starting Apply Kernel Variables... [ 3.747933] systemd[1]: Started Journal Service. [ 4.269174] random: fast init done [ 4.276983] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 [ 4.450257] libata version 3.00 loaded. [ 4.455785] ata_piix 0000:00:01.1: version 2.13 [ 4.480126] scsi host0: ata_piix [ 4.484104] scsi host1: ata_piix [ 4.489009] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc320 irq 14 [ 4.491572] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc328 irq 15 [ 4.596866] ip (320) used greatest stack depth: 13080 bytes left [ 4.705115] ip (343) used greatest stack depth: 12336 bytes left [ 7.909633] EXT4-fs (nbd0): mounted filesystem with ordered data mode. Opts: (null) [ 8.354498] systemd-journald[111]: Received SIGTERM from PID 1 (systemd). [ 8.603663] SELinux: Disabled at runtime. [ 8.605111] SELinux: Unregistering netfilter hooks [ 8.686318] ip_tables: (C) 2000-2006 Netfilter Core Team [ 8.689969] systemd[1]: Inserted module 'ip_tables' [ 9.123916] systemd-journald[566]: Received request to flush runtime journal from PID 1 [ 9.267295] input: PC Speaker as /devices/platform/pcspkr/input/input3 [ 9.282690] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [ 9.319629] cryptd: max_cpu_qlen set to 1000 [ 9.345672] AVX version of gcm_enc/dec engaged. [ 9.347589] AES CTR mode by8 optimization enabled [ 9.375702] Adding 1048572k swap on /dev/vdb. Priority:-2 extents:1 across:1048572k FS [ 9.404186] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni) [ 9.408079] alg: No test for __generic-gcm-aes-aesni (__driver-generic-gcm-aes-aesni) [ 9.414701] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 9.489717] cpio (701) used greatest stack depth: 11824 bytes left [ 9.543839] EDAC MC: Ver: 3.0.0 [ 9.555634] EDAC sbridge: Seeking for: PCI ID 8086:0ea0 [ 9.555650] EDAC sbridge: Ver: 1.1.2 [ 14.068402] mount.nfs (774) used greatest stack depth: 10704 bytes left [ 26.983486] device-mapper: uevent: version 1.0.3 [ 26.985498] device-mapper: ioctl: 4.37.1-ioctl (2018-04-03) initialised: dm-devel@redhat.com [ 31.619316] libcfs: loading out-of-tree module taints kernel. [ 31.621060] libcfs: module verification failed: signature and/or required key missing - tainting kernel [ 31.652653] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_hostid [ 36.293414] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 36.483402] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 36.487819] alg: No test for adler32 (adler32-zlib) [ 37.393177] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 37.561872] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 37.563872] LNet: Accept secure, port 988 [ 39.108340] Key type lgssc registered [ 39.416119] Lustre: Echo OBD driver; http://www.lustre.org/ [ 42.156660] icp: module license 'CDDL' taints kernel. [ 42.158408] Disabling lock debugging due to kernel taint [ 43.716900] ZFS: Loaded module v2.1.5-1, ZFS pool version 5000, ZFS filesystem version 5 [ 46.890181] LDISKFS-fs (vdc): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 52.561768] LDISKFS-fs (vdd): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 55.582038] LDISKFS-fs (vde): file extents enabled, maximum tree depth=5 [ 55.591788] LDISKFS-fs (vde): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 57.959244] LDISKFS-fs (vdf): file extents enabled, maximum tree depth=5 [ 57.965028] LDISKFS-fs (vdf): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 61.176692] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 64.378509] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 64.402122] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 64.410309] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 65.483285] Lustre: Setting parameter lustre-MDT0000.mdt.identity_upcall in log lustre-MDT0000 [ 65.491891] Lustre: ctl-lustre-MDT0000: No data found on store. Initialize space. [ 65.522878] Lustre: lustre-MDT0000: new disk, initializing [ 65.541829] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 65.548799] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000200000400-0x0000000240000400]:0:mdt [ 65.576328] mount.lustre (7192) used greatest stack depth: 9792 bytes left [ 66.338562] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 70.448088] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 70.474045] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 70.492019] Lustre: Modifying parameter lustre-MDT0001.mdt.identity_upcall in log lustre-MDT0001 [ 70.497692] Lustre: srv-lustre-MDT0001: No data found on store. Initialize space. [ 70.499411] Lustre: Skipped 1 previous similar message [ 70.526573] Lustre: lustre-MDT0001: new disk, initializing [ 70.537634] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 70.543196] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000240000400-0x0000000280000400]:1:mdt [ 70.546484] Lustre: cli-ctl-lustre-MDT0001: Allocated super-sequence [0x0000000240000400-0x0000000280000400]:1:mdt] [ 71.224531] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 73.169028] Lustre: Modifying parameter general.debug_raw_pointers in log params [ 75.454222] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 75.457506] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 75.473951] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 75.476874] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 75.534795] Lustre: lustre-OST0000: new disk, initializing [ 75.536994] Lustre: srv-lustre-OST0000: No data found on store. Initialize space. [ 75.547731] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 76.710350] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 78.452597] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000280000400-0x00000002c0000400]:0:ost [ 78.457536] Lustre: cli-lustre-OST0000-super: Allocated super-sequence [0x0000000280000400-0x00000002c0000400]:0:ost] [ 78.467660] Lustre: lustre-OST0000-osc-MDT0000: update sequence from 0x100000000 to 0x280000401 [ 80.881249] LDISKFS-fs (dm-3): file extents enabled, maximum tree depth=5 [ 80.884159] LDISKFS-fs (dm-3): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 80.904116] LDISKFS-fs (dm-3): file extents enabled, maximum tree depth=5 [ 80.907180] LDISKFS-fs (dm-3): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 80.932562] Lustre: lustre-OST0001: new disk, initializing [ 80.935011] Lustre: srv-lustre-OST0001: No data found on store. Initialize space. [ 80.948216] Lustre: lustre-OST0001: Imperative Recovery not enabled, recovery window 60-180 [ 82.146439] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug vfstrace rpctrace dlmtrace neterror ha config ioctl super lfsck all [ 85.694506] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x00000002c0000400-0x0000000300000400]:1:ost [ 85.698947] Lustre: cli-lustre-OST0001-super: Allocated super-sequence [0x00000002c0000400-0x0000000300000400]:1:ost] [ 85.707171] Lustre: lustre-OST0001-osc-MDT0000: update sequence from 0x100010000 to 0x2c0000401 [ 87.015462] Lustre: DEBUG MARKER: Using TIMEOUT=20 [ 91.308924] Lustre: Setting parameter general.lod.*.mdt_hash in log params [ 91.797073] random: crng init done [ 97.464474] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing check_logdir /tmp/testlogs/ [ 98.281640] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing yml_node [ 99.229902] Lustre: DEBUG MARKER: Client: 2.15.64.172 [ 99.863673] Lustre: DEBUG MARKER: MDS: 2.15.64.172 [ 100.491545] Lustre: DEBUG MARKER: OSS: 2.15.64.172 [ 100.893825] Lustre: DEBUG MARKER: -----============= acceptance-small: conf-sanity ============----- Thu Aug 22 01:28:16 EDT 2024 [ 105.475821] Lustre: DEBUG MARKER: excepting tests: 21e 32b 32c 32newtarball 110 [ 105.898525] Lustre: DEBUG MARKER: skipping tests SLOW=no: 45 69 106 111 114 [ 120.614688] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 120.618967] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 120.624873] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 122.878702] Lustre: server umount lustre-MDT0000 complete [ 124.127151] LustreError: 7202:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304520 with bad export cookie 18021251279240009799 [ 124.127925] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 124.141351] LustreError: 7202:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 2 previous similar messages [ 125.766839] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 125.766978] Lustre: lustre-MDT0001-lwp-OST0000: Connection to lustre-MDT0001 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 125.766979] Lustre: Skipped 3 previous similar messages [ 125.767291] Lustre: lustre-MDT0001: Not available for connect from 0@lo (stopping) [ 125.767292] Lustre: Skipped 3 previous similar messages [ 125.784913] LustreError: Skipped 1 previous similar message [ 128.774837] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 128.774838] Lustre: lustre-MDT0001: Not available for connect from 0@lo (stopping) [ 128.774843] Lustre: Skipped 1 previous similar message [ 128.783787] LustreError: Skipped 1 previous similar message [ 130.260108] Lustre: server umount lustre-MDT0001 complete [ 137.455618] Lustre: server umount lustre-OST0000 complete [ 144.656362] Lustre: server umount lustre-OST0001 complete [ 146.250950] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_hostid [ 147.996174] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 150.643590] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 152.655226] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 154.708962] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 154.719039] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 156.798872] LDISKFS-fs (dm-3): file extents enabled, maximum tree depth=5 [ 156.805323] LDISKFS-fs (dm-3): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 158.966081] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 158.995459] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 159.083101] Lustre: Setting parameter lustre-MDT0000.mdt.identity_upcall in log lustre-MDT0000 [ 159.096833] Lustre: ctl-lustre-MDT0000: No data found on store. Initialize space. [ 159.136487] Lustre: lustre-MDT0000: new disk, initializing [ 159.171124] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 159.183229] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000200000400-0x0000000240000400]:0:mdt [ 160.055436] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 163.574128] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 163.592596] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 163.692426] Lustre: cli-ctl-lustre-MDT0001: Allocated super-sequence [0x0000000240000400-0x0000000280000400]:1:mdt] [ 164.497787] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 167.045446] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 167.832699] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 169.527834] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 169.531266] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: errors=remount-ro [ 169.548989] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 169.552662] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 169.622569] Lustre: lustre-OST0000: new disk, initializing [ 169.623964] Lustre: Skipped 1 previous similar message [ 169.625998] Lustre: srv-lustre-OST0000: No data found on store. Initialize space. [ 169.628207] Lustre: Skipped 2 previous similar messages [ 169.648452] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 169.651282] Lustre: Skipped 1 previous similar message [ 170.717072] Lustre: ctl-lustre-MDT0000: super-sequence allocation rc = 0 [0x0000000280000400-0x00000002c0000400]:0:ost [ 170.720785] Lustre: Skipped 1 previous similar message [ 170.722498] Lustre: cli-lustre-OST0000-super: Allocated super-sequence [0x0000000280000400-0x00000002c0000400]:0:ost] [ 170.739412] Lustre: lustre-OST0000-osc-MDT0000: update sequence from 0x100000000 to 0x280000401 [ 170.891832] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 173.378538] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 174.148517] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing wait_import_state FULL os[cp].lustre-OST0000-osc-MDT0000.ost_server_uuid 50 [ 174.198771] Lustre: DEBUG MARKER: os[cp].lustre-OST0000-osc-MDT0000.ost_server_uuid in FULL state after 0 sec [ 174.990768] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing wait_import_state FULL os[cp].lustre-OST0000-osc-MDT0001.ost_server_uuid 50 [ 175.040493] Lustre: DEBUG MARKER: os[cp].lustre-OST0000-osc-MDT0001.ost_server_uuid in FULL state after 0 sec [ 175.735012] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 175.737768] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 175.741663] Lustre: Skipped 1 previous similar message [ 175.743563] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 175.746354] Lustre: Skipped 1 previous similar message [ 180.759280] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 180.762224] Lustre: Skipped 2 previous similar messages [ 181.592461] Lustre: server umount lustre-OST0000 complete [ 183.702993] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 183.705290] LustreError: Skipped 1 previous similar message [ 183.706757] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 183.712187] Lustre: Skipped 1 previous similar message [ 188.568605] Lustre: server umount lustre-MDT0000 complete [ 189.481971] LustreError: 19653:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304585 with bad export cookie 18021251279240011283 [ 189.483016] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 189.487975] LustreError: 19653:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 189.576064] Lustre: server umount lustre-MDT0001 complete [ 190.370910] Lustre: DEBUG MARKER: == conf-sanity test 0: single mount setup ================ 01:29:45 (1724304585) [ 191.972628] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 192.096166] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 192.114527] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 192.860726] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 195.075124] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 195.964522] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 197.238590] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 198.058538] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 199.827535] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 199.832770] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 201.122869] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 202.372409] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 210.935241] 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 [ 210.935456] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 210.935793] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 210.935794] Lustre: Skipped 3 previous similar messages [ 210.944809] Lustre: Skipped 2 previous similar messages [ 211.433295] Lustre: server umount lustre-OST0000 complete [ 214.415725] Lustre: server umount lustre-MDT0000 complete [ 215.190788] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 215.193773] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 215.345980] LustreError: 22234:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304611 with bad export cookie 18021251279240012137 [ 215.347600] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 215.353612] LustreError: 22234:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 2 previous similar messages [ 215.451506] Lustre: server umount lustre-MDT0001 complete [ 218.179497] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 218.647481] Key type lgssc unregistered [ 218.708651] LNet: 26092:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 219.717529] LNet: Removed LNI 192.168.204.126@tcp [ 225.551263] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 225.701039] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 225.705675] alg: No test for adler32 (adler32-zlib) [ 226.519874] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 226.562635] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 226.564386] LNet: Accept secure, port 988 [ 228.090362] Key type lgssc registered [ 228.285700] Lustre: Echo OBD driver; http://www.lustre.org/ [ 230.122440] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 230.127649] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 231.246211] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 231.260520] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 232.014873] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 234.119228] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 234.207402] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 234.954157] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 236.197578] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 236.973333] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 238.645595] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 238.649700] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 238.740866] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 239.989023] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 241.230089] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 241.741851] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:35 to 0x280000401:65) [ 251.766798] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 251.769109] 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 [ 251.772679] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 254.759053] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 254.759145] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 254.759298] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 256.031910] Lustre: server umount lustre-OST0000 complete [ 259.238874] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 259.242254] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 259.247860] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 259.249679] Lustre: Skipped 1 previous similar message [ 263.071335] Lustre: server umount lustre-MDT0000 complete [ 264.022984] LustreError: 27585:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304660 with bad export cookie 15694418283955627760 [ 264.024288] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 264.031133] LustreError: 27585:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 264.118260] Lustre: server umount lustre-MDT0001 complete [ 267.023252] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 267.454098] Key type lgssc unregistered [ 267.513625] LNet: 32029:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 268.518506] LNet: Removed LNI 192.168.204.126@tcp [ 274.666340] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 274.809437] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 274.813899] alg: No test for adler32 (adler32-zlib) [ 275.632971] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 275.684662] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 275.686114] LNet: Accept secure, port 988 [ 277.216375] Key type lgssc registered [ 277.390692] Lustre: Echo OBD driver; http://www.lustre.org/ [ 279.255308] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 279.260485] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 280.378896] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 280.388801] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 281.106210] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 283.249038] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 283.337951] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 283.356634] mount.lustre (1971) used greatest stack depth: 9648 bytes left [ 284.039957] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 285.304356] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 286.135751] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 289.406531] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 289.409901] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 289.498782] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 290.498532] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:67 to 0x280000401:97) [ 290.609108] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 291.813429] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 300.518959] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 300.521488] 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 [ 300.525664] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 303.510895] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 303.511303] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 303.511405] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 304.692117] Lustre: server umount lustre-OST0000 complete [ 308.359035] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 308.362190] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 308.367419] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 308.369682] Lustre: Skipped 1 previous similar message [ 311.768049] Lustre: server umount lustre-MDT0000 complete [ 312.771151] LustreError: 1095:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304708 with bad export cookie 6628933241987867262 [ 312.772589] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 312.779582] LustreError: 1095:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 312.880810] Lustre: server umount lustre-MDT0001 complete [ 315.892440] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 316.432467] Key type lgssc unregistered [ 316.505636] LNet: 5425:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 317.512530] LNet: Removed LNI 192.168.204.126@tcp [ 323.900716] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 324.085480] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 324.091316] alg: No test for adler32 (adler32-zlib) [ 324.916165] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 324.975154] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 324.977825] LNet: Accept secure, port 988 [ 326.508417] Key type lgssc registered [ 326.744475] Lustre: Echo OBD driver; http://www.lustre.org/ [ 328.788093] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 328.793756] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 329.935507] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 329.947061] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 330.758871] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 333.094940] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 333.222411] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 333.246728] mount.lustre (7798) used greatest stack depth: 9616 bytes left [ 334.099079] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 335.481897] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 336.293715] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 337.978455] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 337.982097] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 338.070837] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 339.071397] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:99 to 0x280000401:129) [ 339.307949] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 340.632867] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 348.071249] 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 [ 348.071815] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 348.078486] Lustre: Skipped 1 previous similar message [ 349.553643] Lustre: server umount lustre-OST0000 complete [ 352.563291] Lustre: server umount lustre-MDT0000 complete [ 353.078854] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 353.079214] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 353.087325] Lustre: Skipped 1 previous similar message [ 353.526164] LustreError: 6920:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304749 with bad export cookie 9840656608859209921 [ 353.527701] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 353.533511] LustreError: 6920:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 353.631187] Lustre: server umount lustre-MDT0001 complete [ 356.500472] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 356.981629] Key type lgssc unregistered [ 357.045637] LNet: 10783:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 358.051681] LNet: Removed LNI 192.168.204.126@tcp [ 364.241582] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 364.393424] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 364.397304] alg: No test for adler32 (adler32-zlib) [ 365.204172] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 365.250877] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 365.252554] LNet: Accept secure, port 988 [ 366.778314] Key type lgssc registered [ 366.979418] Lustre: Echo OBD driver; http://www.lustre.org/ [ 368.796966] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 368.804298] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 369.921694] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 369.934360] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 370.679384] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 372.807228] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 372.904688] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 373.648675] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 374.900009] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 375.649562] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 377.290339] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 377.294417] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 377.386477] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 378.612347] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 379.388074] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:131 to 0x280000401:161) [ 379.845139] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 387.398902] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 387.402177] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 387.407086] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 387.409446] Lustre: Skipped 1 previous similar message [ 388.559526] Lustre: server umount lustre-OST0000 complete [ 400.551587] Lustre: lustre-MDT0000-lwp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 400.555888] Lustre: Skipped 2 previous similar messages [ 400.556390] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 405.559322] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 405.561548] Lustre: Skipped 2 previous similar messages [ 406.604796] Lustre: server umount lustre-MDT0000 complete [ 407.561002] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 407.565564] LustreError: Skipped 1 previous similar message [ 407.578334] LustreError: 15539:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304803 with bad export cookie 13849594917210929607 [ 407.579033] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 407.586328] LustreError: 15539:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 2 previous similar messages [ 413.675261] Lustre: server umount lustre-MDT0001 complete [ 416.522741] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 416.985067] Key type lgssc unregistered [ 417.048556] LNet: 16348:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 418.054605] LNet: Removed LNI 192.168.204.126@tcp [ 423.838675] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 423.939929] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 423.965303] alg: No test for adler32 (adler32-zlib) [ 424.766898] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 424.810645] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 424.812389] LNet: Accept secure, port 988 [ 426.336338] Key type lgssc registered [ 426.530360] Lustre: Echo OBD driver; http://www.lustre.org/ [ 428.344087] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 428.350108] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 429.487838] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 429.501309] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 430.293751] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 432.490552] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 432.592762] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 433.353653] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 434.636657] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 435.405594] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 437.072579] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 437.076081] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 437.165413] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 438.299882] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 439.166962] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:163 to 0x280000401:193) [ 439.489776] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 447.175081] 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 [ 447.175548] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 447.181207] Lustre: Skipped 2 previous similar messages [ 450.594452] Lustre: lustre-MDT0000: Not available for connect from 192.168.204.26@tcp (stopping) [ 450.596584] Lustre: Skipped 2 previous similar messages [ 452.137381] Lustre: server umount lustre-MDT0000 complete [ 452.182839] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 452.187019] LustreError: Skipped 2 previous similar messages [ 453.188951] LustreError: 17840:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724304849 with bad export cookie 6455798299383230906 [ 453.189954] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 453.194509] LustreError: 17840:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 455.596697] LustreError: lustre-MDT0000: not available for connect from 192.168.204.26@tcp (no target). If you are running an HA pair check that the target is mounted on the other server. [ 455.601170] Lustre: lustre-MDT0001: Not available for connect from 192.168.204.26@tcp (stopping) [ 457.190929] Lustre: lustre-MDT0001-lwp-OST0000: Connection to lustre-MDT0001 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 458.192818] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 458.192825] Lustre: lustre-MDT0001: Not available for connect from 0@lo (stopping) [ 458.192827] Lustre: Skipped 1 previous similar message [ 458.199787] LustreError: Skipped 1 previous similar message [ 459.300479] Lustre: server umount lustre-MDT0001 complete [ 469.784807] LustreError: 17840:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 192.168.204.26@tcp arrived at 1724304865 with bad export cookie 6455798299383231746 [ 469.784810] LustreError: 17841:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 192.168.204.26@tcp arrived at 1724304865 with bad export cookie 6455798299383231746 [ 469.795852] LustreError: 17840:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 1 previous similar message [ 476.397689] Lustre: server umount lustre-OST0000 complete [ 481.852159] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 482.686289] Key type lgssc unregistered [ 482.814037] LNet: 22118:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 483.825864] LNet: Removed LNI 192.168.204.126@tcp [ 492.680572] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 492.856686] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 492.862394] alg: No test for adler32 (adler32-zlib) [ 493.691309] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 493.745089] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 493.747135] LNet: Accept secure, port 988 [ 495.277428] Key type lgssc registered [ 495.528536] Lustre: Echo OBD driver; http://www.lustre.org/ [ 497.684389] Lustre: lustre-OST0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 497.688734] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 497.694033] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 514.765607] LustreError: Failed to get MGS log lustre-sptlrpc and no local copy. [ 550.771401] LustreError: 23607:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.204.126@tcp: failed processing log, type 4: rc = -110 [ 580.786317] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 582.010707] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 583.252366] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 746.235386] Lustre: server umount lustre-OST0000 complete [ 753.088320] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 754.155135] Key type lgssc unregistered [ 754.298964] LNet: 25540:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 755.318761] LNet: Removed LNI 192.168.204.126@tcp [ 764.612159] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 764.853890] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 764.858812] alg: No test for adler32 (adler32-zlib) [ 765.683778] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 765.745797] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 765.748369] LNet: Accept secure, port 988 [ 767.285950] Key type lgssc registered [ 767.657080] Lustre: Echo OBD driver; http://www.lustre.org/ [ 771.012058] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 771.031542] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 772.314359] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 772.348512] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 774.102663] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 779.524965] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 780.022513] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 782.334684] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 785.177937] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 787.091466] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 790.839140] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 790.845578] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 791.053143] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 793.612136] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 796.366177] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 797.052381] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:195 to 0x280000401:225) [ 802.056270] 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 [ 802.057032] LustreError: lustre-OST0000-osc-MDT0000: operation ost_statfs to node 0@lo failed: rc = -107 [ 802.073286] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 803.905692] Lustre: server umount lustre-OST0000 complete [ 809.992848] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 809.998985] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 810.009898] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 812.030254] Lustre: server umount lustre-MDT0000 complete [ 813.819499] LustreError: 27037:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724305209 with bad export cookie 13436592864422131659 [ 813.821696] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 813.830377] LustreError: 27037:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 3 previous similar messages [ 814.001285] Lustre: server umount lustre-MDT0001 complete [ 818.821019] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 819.992007] Key type lgssc unregistered [ 820.093387] LNet: 30899:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 821.102485] LNet: Removed LNI 192.168.204.126@tcp [ 831.484707] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 831.727739] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 831.738308] alg: No test for adler32 (adler32-zlib) [ 832.637706] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 832.730788] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 832.732746] LNet: Accept secure, port 988 [ 834.279361] Key type lgssc registered [ 834.706238] Lustre: Echo OBD driver; http://www.lustre.org/ [ 838.265073] Lustre: lustre-OST0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 838.271920] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 838.283694] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 855.462467] LustreError: Failed to get MGS log lustre-sptlrpc and no local copy. [ 891.471377] LustreError: 32388:0:(mgc_request.c:233:do_config_log_add()) MGC192.168.204.126@tcp: failed processing log, type 4: rc = -110 [ 921.497344] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 923.391859] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 925.043389] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 927.075309] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 927.232041] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 927.253717] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 927.273729] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:195 to 0x280000401:257) [ 928.185735] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 930.708549] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 930.824837] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 931.715016] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 933.314075] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 934.364763] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 935.815738] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 935.818728] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 935.823998] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 937.055628] Lustre: server umount lustre-OST0000 complete [ 950.240660] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 950.241477] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 950.241478] Lustre: Skipped 1 previous similar message [ 950.247515] Lustre: Skipped 2 previous similar messages [ 955.250172] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 955.252435] Lustre: Skipped 2 previous similar messages [ 956.329572] Lustre: server umount lustre-MDT0000 complete [ 957.603326] LustreError: 32394:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724305353 with bad export cookie 4738970777043191507 [ 957.605868] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 957.612789] LustreError: 32394:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 963.710598] Lustre: server umount lustre-MDT0001 complete [ 966.748475] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 967.297322] Key type lgssc unregistered [ 967.360958] LNet: 4106:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 968.372906] LNet: Removed LNI 192.168.204.126@tcp [ 979.670086] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 980.061056] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 980.159091] alg: No test for adler32 (adler32-zlib) [ 981.100971] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 981.207472] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 981.211741] LNet: Accept secure, port 988 [ 982.762757] Key type lgssc registered [ 983.483874] Lustre: Echo OBD driver; http://www.lustre.org/ [ 988.144418] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 988.155623] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 989.448912] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 989.494232] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 991.895377] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 997.928295] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 998.284500] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 998.348894] mount.lustre (6503) used greatest stack depth: 9552 bytes left [ 1000.018114] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 1002.723333] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1004.626418] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1008.231580] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 1008.238890] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 1008.295285] LustreError: lustre-OST0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 1008.438995] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 1011.040454] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 1013.981846] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:195 to 0x280000401:289) [ 1014.123065] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1038.026619] LustreError: lustre-OST0000-osc-MDT0001: operation ost_statfs to node 0@lo failed: rc = -107 [ 1038.036286] Lustre: lustre-OST0000-osc-MDT0001: Connection to lustre-OST0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 1038.055384] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 1039.001013] 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 [ 1039.009870] Lustre: lustre-OST0000: Not available for connect from 0@lo (stopping) [ 1042.060608] Lustre: server umount lustre-OST0000 complete [ 1048.313506] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 1048.316615] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 1048.330392] Lustre: lustre-MDT0000: Not available for connect from 0@lo (stopping) [ 1048.335985] Lustre: Skipped 1 previous similar message [ 1050.523081] Lustre: server umount lustre-MDT0000 complete [ 1052.504084] LustreError: 5621:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) ldlm_cancel from 0@lo arrived at 1724305448 with bad export cookie 15260636222575855616 [ 1052.515267] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 1052.521715] LustreError: 5621:0:(ldlm_lockd.c:2569:ldlm_cancel_handler()) Skipped 4 previous similar messages [ 1052.694775] Lustre: server umount lustre-MDT0001 complete [ 1057.854042] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing unload_modules_local [ 1059.078225] Key type lgssc unregistered [ 1059.200387] LNet: 9521:0:(lib-ptl.c:966:lnet_clear_lazy_portal()) Active lazy portal 0 on exit [ 1060.210710] LNet: Removed LNI 192.168.204.126@tcp [ 1075.957687] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing load_modules_local [ 1076.153732] libcfs: HW NUMA nodes: 1, HW CPU cores: 4, npartitions: 1 [ 1076.166355] alg: No test for adler32 (adler32-zlib) [ 1077.027661] Lustre: Lustre: Build Version: 2.15.64_172_g02d7af7 [ 1077.102788] LNet: Added LNI 192.168.204.126@tcp [8/256/0/180] [ 1077.105465] LNet: Accept secure, port 988 [ 1078.655378] Key type lgssc registered [ 1079.024945] Lustre: Echo OBD driver; http://www.lustre.org/ [ 1082.777870] Lustre: lustre-MDT0000: mounting server target with '-t lustre' deprecated, use '-t lustre_tgt' [ 1082.793158] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 1084.049796] LustreError: lustre-MDT0001: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 1084.077916] Lustre: lustre-MDT0000: Imperative Recovery not enabled, recovery window 60-180 [ 1085.512430] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 1089.792342] LDISKFS-fs (dm-1): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 1090.020680] Lustre: lustre-MDT0001: Imperative Recovery not enabled, recovery window 60-180 [ 1091.565196] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 1094.383907] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0000-mdc-*.mds_server_uuid [ 1096.448860] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount FULL mdc.lustre-MDT0001-mdc-*.mds_server_uuid [ 1100.246480] LDISKFS-fs (dm-2): file extents enabled, maximum tree depth=5 [ 1100.255822] LDISKFS-fs (dm-2): mounted filesystem with ordered data mode. Opts: user_xattr,acl,no_mbcache,nodelalloc [ 1100.473823] Lustre: lustre-OST0000: Imperative Recovery not enabled, recovery window 60-180 [ 1102.985630] Lustre: DEBUG MARKER: oleg426-server.virtnet: executing set_default_debug -1 all [ 1105.341074] Lustre: DEBUG MARKER: oleg426-client.virtnet: executing wait_import_state_mount (FULL|IDLE) osc.lustre-OST0000-osc-[-0-9a-f]*.ost_server_uuid [ 1109.490435] Lustre: lustre-OST0000: new connection from lustre-MDT0000-mdtlov (cleaning up unused objects from 0x280000401:195 to 0x280000401:321) [ 1117.278397] Lustre: Failing over lustre-MDT0000 [ 1117.363843] Lustre: server umount lustre-MDT0000 complete [ 1120.040022] LustreError: lustre-MDT0000-osp-MDT0001: operation mds_statfs to node 0@lo failed: rc = -107 [ 1120.043459] Lustre: lustre-MDT0000-osp-MDT0001: Connection to lustre-MDT0000 (at 0@lo) was lost; in progress operations using this service will wait for recovery to complete [ 1120.065968] LustreError: lustre-MDT0000: not available for connect from 0@lo (no target). If you are running an HA pair check that the target is mounted on the other server. [ 1121.592365] LustreError: lustre-MDT0000: not available for connect from 192.168.204.26@tcp (no target). If you are running an HA pair check that the target is mounted on the other server. [ 1121.604082] LustreError: Skipped 2 previous similar messages [ 1121.923281] LDISKFS-fs (dm-0): mounted filesystem with ordered data mode. Opts: user_xattr,errors=remount-ro,no_mbcache,nodelalloc [ 1121.985272] LustreError: MGC192.168.204.126@tcp: Connection to MGS (at 0@lo) was lost; in progress operations using this service will fail [ 1122.053445] Lustre: *** cfs_fail_loc=135, val=0*** [ 1122.132483] BUG: unable to handle kernel paging request at fffffffffffffffe [ 1122.139090] IP: [] obd_setup+0x156/0x390 [obdclass] [ 1122.145621] PGD 1c14067 PUD 1c16067 PMD 0 [ 1122.147825] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC [ 1122.154239] Modules linked in: lustre(OE) osp(OE) ofd(OE) lod(OE) ost(OE) mdt(OE) mdd(OE) mgs(OE) osd_ldiskfs(OE) ldiskfs(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) dm_flakey dm_mod 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 libata serio_raw [last unloaded: libcfs] [ 1122.221431] CPU: 0 PID: 14878 Comm: llog_process_th Kdump: loaded Tainted: P OE ------------ 3.10.0-7.9-debug #1 [ 1122.229074] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-1.fc38 04/01/2014 [ 1122.232675] task: ffff8800ad53e660 ti: ffff88009133c000 task.ti: ffff88009133c000 [ 1122.234656] RIP: 0010:[] [] obd_setup+0x156/0x390 [obdclass] [ 1122.239074] RSP: 0018:ffff88009133faa0 EFLAGS: 00010246 [ 1122.240780] RAX: fffffffffffffffe RBX: fffffffffffffffe RCX: 0000000000000000 [ 1122.243412] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff88007fe5be00 [ 1122.246731] RBP: ffff88009133fb40 R08: 000000000000ffff R09: 000000000000ffff [ 1122.253423] R10: 0000000000000000 R11: ffff88009ddb8000 R12: ffff88008eac8000 [ 1122.255475] R13: 0000000000000000 R14: ffff8800b23f3300 R15: 0000000000000000 [ 1122.265763] FS: 0000000000000000(0000) GS:ffff88013e200000(0000) knlGS:0000000000000000 [ 1122.268459] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1122.271803] CR2: fffffffffffffffe CR3: 0000000001c10000 CR4: 0000000000160ff0 [ 1122.276290] Call Trace: [ 1122.277324] [] class_setup+0x54f/0x830 [obdclass] [ 1122.280119] [] class_process_config+0x197e/0x27d0 [obdclass] [ 1122.286390] [] class_config_llog_handler+0x817/0x13e0 [obdclass] [ 1122.298046] [] llog_process_thread+0xc96/0x1c60 [obdclass] [ 1122.301539] [] ? keys_fill+0xdf/0x120 [obdclass] [ 1122.304601] [] llog_process_thread_daemonize+0xa2/0xe0 [obdclass] [ 1122.311830] [] ? llog_validate+0x3b0/0x3b0 [obdclass] [ 1122.318250] [] kthread+0xe4/0xf0 [ 1122.320012] [] ? kthread_create_on_node+0x140/0x140 [ 1122.324888] [] ret_from_fork_nospec_begin+0x7/0x21 [ 1122.329295] [] ? kthread_create_on_node+0x140/0x140 [ 1122.331487] Code: 00 e8 cf 6b d7 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 [ 1122.338480] RIP [] obd_setup+0x156/0x390 [obdclass] [ 1122.340017] RSP [ 1122.340891] CR2: fffffffffffffffe