On Tue, 10 Jan 2023 at 23:44, Greg Kroah-Hartman <gregkh@xxxxxxxxxxxxxxxxxxx> wrote: > > This is the start of the stable review cycle for the 6.1.5 release. > There are 159 patches in this series, all will be posted as a response > to this one. If anyone has any issues with these being applied, please > let me know. > > Responses should be made by Thu, 12 Jan 2023 17:59:42 +0000. > Anything received after that time might be too late. > > The whole patch series can be found in one patch at: > https://www.kernel.org/pub/linux/kernel/v6.x/stable-review/patch-6.1.5-rc1.gz > or in the git tree and branch at: > git://git.kernel.org/pub/scm/linux/kernel/git/stable/linux-stable-rc.git linux-6.1.y > and the diffstat can be found below. > > thanks, > > greg k-h Results from Linaro’s test farm. Regressions on arm64 FVP. Reported-by: Linux Kernel Functional Testing <lkft@xxxxxxxxxx> Following kernel panic and warning notices on FVP 64k page size enabled gcc-12 build on 6.1 and 6.0 kernel Image while running LTP mm test cases. CONFIG_ARM64_64K_PAGES=y SError Interrupt on CPU3, code 0x00000000be000000 -- SError Kernel panic - not syncing: Asynchronous SError Interrupt WARNING: CPU: 3 PID: 685 at kernel/sched/core.c:3113 set_task_cpu Boot log: ------------ mem.c:346: TINFO: child 1 continues... mem.c:353: TINFO: child 1 allocates 128 MB filled with 'd' except one page with 'e' [ 257.654082] SError Interrupt on CPU3, code 0x00000000be000000 -- SError [ 257.654122] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.654181] Hardware name: FVP Base RevC (DT) [ 257.654205] pstate: 80000000 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--) [ 257.654276] pc : 000000000041f758 [ 257.654298] lr : 000000000041f8c0 [ 257.654319] sp : 0000ffffc9e14cb0 [ 257.654341] x29: 0000ffffc9e14cc0 x28: 0000000008000000 x27: 00000000004296c0 [ 257.654437] x26: 00000000194fa4b0 x25: 0000000000000064 x24: 0000000008000000 [ 257.654530] x23: 0000000008000000 x22: 0000000000429550 x21: 0000000000000000 [ 257.654626] x20: 0000ffffc9e14de8 x19: 0000000000000001 x18: 0000000000000000 [ 257.654719] x17: 0000ffff93c6a290 x16: 0000000000441340 x15: 0000000000008000 [ 257.654815] x14: 0000000000040000 x13: 2e746e65746e6f63 x12: 0000ffff93cd7160 [ 257.654913] x11: 0000ffffc9e146b0 x10: 00000000ffffffd8 x9 : 00000000ffffff80 [ 257.655009] x8 : 0000000000000040 x7 : 00000000ffffffff x6 : 0000000000000000 [ 257.655100] x5 : 0000000000000063 x4 : 0000000000000020 x3 : 0000ffff93dbed60 [ 257.655191] x2 : 0000000000000000 x1 : 0000ffff8bb90000 x0 : 00000000068af001 [ 257.655293] Kernel panic - not syncing: Asynchronous SError Interrupt [ 257.655319] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.655379] Hardware name: FVP Base RevC (DT) [ 257.655403] Call trace: [ 257.655419] dump_backtrace+0xe4/0x140 [ 257.655475] show_stack+0x20/0x30 [ 257.655528] dump_stack_lvl+0x88/0xb4 [ 257.655598] dump_stack+0x18/0x34 [ 257.655667] panic+0x1a0/0x37c [ 257.655729] add_taint+0x0/0xc0 [ 257.655787] arm64_serror_panic+0x78/0x84 [ 257.655853] do_serror+0x0/0x60 [ 257.655911] do_serror+0x3c/0x60 [ 257.655970] __el0_error_handler_common+0x48/0xc0 [ 257.656050] el0t_64_error_handler+0x10/0x20 [ 257.656131] el0t_64_error+0x18c/0x190 [ 257.656191] SMP: stopping secondary CPUs [ 257.656326] Kernel Offset: 0x57c5cb540000 from 0xffff800008000000 [ 257.656361] PHYS_OFFSET: 0x80000000 [ 257.656383] CPU features: 0x00000,000a1cff,e69e772f [ 257.656414] Memory Limit: none [ 257.945661] ---[ end Kernel panic - not syncing: Asynchronous SError Interrupt ]--- [ 257.945856] ------------[ cut here ]------------ [ 257.945873] WARNING: CPU: 3 PID: 685 at kernel/sched/core.c:3113 set_task_cpu+0x170/0x254 [ 257.945960] Modules linked in: pl111_drm drm_dma_helper crct10dif_ce arm_spe_pmu drm_kms_helper panel_simple cfg80211 rfkill fuse drm [ 257.946182] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.946243] Hardware name: FVP Base RevC (DT) [ 257.946267] pstate: 424020c9 (nZcv daIF +PAN -UAO +TCO -DIT -SSBS BTYPE=--) [ 257.946338] pc : set_task_cpu+0x170/0x254 [ 257.946393] lr : try_to_wake_up+0x1a0/0x63c [ 257.946451] sp : ffff80000806fbe0 [ 257.946474] x29: ffff80000806fbe0 x28: ffff00087f7c5680 x27: 0000000000000000 [ 257.946572] x26: 0000000000000000 x25: ffffd7c5d609d410 x24: 0000000000000005 [ 257.946666] x23: ffff000805633d04 x22: 0000000000000005 x21: ffffd7c5d6098a78 [ 257.946762] x20: 0000000000000005 x19: ffff0008056334c0 x18: 0000000000000006 [ 257.946858] x17: 75727265746e4920 x16: 726f727245532073 x15: 756f6e6f7268636e [ 257.946960] x14: 797341203a676e69 x13: 2d2d2d5d20747075 x12: 727265746e492072 [ 257.947061] x11: 6f72724553207375 x10: ffffd7c5d6114d18 x9 : ffffd7c5d3617154 [ 257.947161] x8 : ffffd7c5d574b000 x7 : ffff2842aa100000 x6 : 0000000000000003 [ 257.947257] x5 : ffffd7c5d609d000 x4 : 0000000000000005 x3 : 00000000000000ff [ 257.947350] x2 : 0000000000000000 x1 : 0000000000000005 x0 : 0000000000000000 [ 257.947440] Call trace: [ 257.947452] set_task_cpu+0x170/0x254 [ 257.947514] try_to_wake_up+0x1a0/0x63c [ 257.947575] default_wake_function+0x24/0x50 [ 257.947639] autoremove_wake_function+0x20/0x50 [ 257.947734] __wake_up_common+0x90/0x190 [ 257.947815] __wake_up_common_lock+0x80/0xd0 [ 257.947903] __wake_up+0x20/0x30 [ 257.947981] wake_up_klogd_work_func+0xac/0xc0 [ 257.948059] irq_work_single+0x7c/0xbc [ 257.948139] irq_work_run_list+0x4c/0x70 [ 257.948221] irq_work_tick+0x28/0x6c [ 257.948299] update_process_times+0xa4/0xc0 [ 257.948394] tick_sched_handle+0x3c/0x60 [ 257.948465] tick_sched_timer+0x54/0xac [ 257.948535] __hrtimer_run_queues+0x2e4/0x380 [ 257.948632] hrtimer_interrupt+0xf0/0x250 [ 257.948729] arch_timer_handler_phys+0x34/0x50 [ 257.948807] handle_percpu_devid_irq+0x90/0x230 [ 257.948873] generic_handle_domain_irq+0x34/0x50 [ 257.948962] gic_handle_irq+0x58/0x140 [ 257.949015] call_on_irq_stack+0x2c/0x54 [ 257.949088] do_interrupt_handler+0x88/0x94 [ 257.949172] el1_interrupt+0x34/0x70 [ 257.949245] el1h_64_irq_handler+0x18/0x2c [ 257.949324] el1h_64_irq+0x64/0x68 [ 257.949380] panic+0x324/0x37c [ 257.949444] add_taint+0x0/0xc0 [ 257.949505] arm64_serror_panic+0x78/0x84 [ 257.949566] do_serror+0x0/0x60 [ 257.949625] do_serror+0x3c/0x60 [ 257.949684] __el0_error_handler_common+0x48/0xc0 [ 257.949764] el0t_64_error_handler+0x10/0x20 [ 257.949845] el0t_64_error+0x18c/0x190 [ 257.949904] ---[ end trace 0000000000000000 ]--- https://qa-reports.linaro.org/lkft/linux-stable-rc-linux-6.1.y/build/v6.1.4-160-g06bcfb15cd3b/testrun/14089643/suite/log-parser-test/tests/ https://qa-reports.linaro.org/lkft/linux-stable-rc-linux-6.0.y/build/v6.0.18-149-ga7ffaeeaf9bb/testrun/14090240/suite/log-parser-test/test/check-kernel-warning-de62c77a22d6287fbc68ad7f081dfc8e3020755f775d8857e304afa254d2322a/log Kconfig: https://storage.tuxsuite.com/public/linaro/lkft/builds/2K9Is9mmM4gPI7HP7LIle0gAdm7/config vmlinux: https://storage.tuxsuite.com/public/linaro/lkft/builds/2K9JI1PZ8qBcVmNXpYWvL8wgPTm/vmlinux.xz System.map: https://storage.tuxsuite.com/public/linaro/lkft/builds/2K9JI1PZ8qBcVmNXpYWvL8wgPTm/System.map Image: https://storage.tuxsuite.com/public/linaro/lkft/builds/2K9JI1PZ8qBcVmNXpYWvL8wgPTm/Image.gz -- Linaro LKFT https://lkft.linaro.org
EFI stub: Booting Linux Kernel... EFI stub: EFI_RNG_PROTOCOL unavailable EFI stub: Using DTB from command line EFI stub: Exiting boot services... [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd0f0] [ 0.000000] Linux version 6.1.5-rc1 (tuxmake@tuxmake) (aarch64-linux-gnu-gcc (Debian 12.2.0-9) 12.2.0, GNU ld (GNU Binutils for Debian) 2.39) #1 SMP PREEMPT @1673381434 [ 0.000000] Machine model: FVP Base RevC [ 0.000000] earlycon: pl11 at MMIO 0x000000001c090000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: ACPI 2.0=0xf5e30018 MEMATTR=0xfadaf018 MEMRESERVE=0xf5f8bf18 [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000018000000, size 8 MiB [ 0.000000] OF: reserved mem: initialized node vram@18000000, compatible id shared-dma-pool [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000080000000-0x00000008ffffffff] [ 0.000000] NUMA: NODE_DATA [mem 0x8fff220c0-0x8fff24abf] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000008ffffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000080000000-0x00000000f59effff] [ 0.000000] node 0: [mem 0x00000000f59f0000-0x00000000f5a5ffff] [ 0.000000] node 0: [mem 0x00000000f5a60000-0x00000000f5b4ffff] [ 0.000000] node 0: [mem 0x00000000f5b50000-0x00000000f5e2ffff] [ 0.000000] node 0: [mem 0x00000000f5e30000-0x00000000f5e3ffff] [ 0.000000] node 0: [mem 0x00000000f5e40000-0x00000000f5f7ffff] [ 0.000000] node 0: [mem 0x00000000f5f80000-0x00000000faf4ffff] [ 0.000000] node 0: [mem 0x00000000faf50000-0x00000000faf8ffff] [ 0.000000] node 0: [mem 0x00000000faf90000-0x00000000faf9ffff] [ 0.000000] node 0: [mem 0x00000000fafa0000-0x00000000fafeffff] [ 0.000000] node 0: [mem 0x00000000faff0000-0x00000000feffffff] [ 0.000000] node 0: [mem 0x0000000880000000-0x00000008ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000008ffffffff] [ 0.000000] On node 0, zone Normal: 256 pages in unavailable ranges [ 0.000000] cma: Reserved 512 MiB at 0x00000000c0000000 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.2 [ 0.000000] percpu: Embedded 10 pages/cpu s574568 r8192 d72600 u655360 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Virtualization Host Extensions [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Memory Tagging Extension [ 0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] alternatives: applying boot alternatives [ 0.000000] Fallback order for Node 0: 0 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 65216 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: Image dtb=fvp-base-revc.dtb console=ttyAMA0 earlycon=pl011,0x1c090000 root=/dev/vda ip=dhcp [ 0.000000] Unknown kernel command line parameters \"Image dtb=fvp-base-revc.dtb\", will be passed to user space. [ 0.000000] random: crng init done [ 0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off [ 0.000000] software IO TLB: area num 8. [ 0.000000] software IO TLB: mapped [mem 0x00000000fb000000-0x00000000ff000000] (64MB) [ 0.000000] Memory: 3481472K/4177920K available (20096K kernel code, 5458K rwdata, 11072K rodata, 12416K init, 1571K bss, 172160K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 [ 0.000000] ftrace: allocating 66065 entries in 17 pages [ 0.000000] ftrace: allocated 17 pages with 2 groups [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=8. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 224 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] Root IRQ handler: gic_handle_irq [ 0.000000] GICv3: GICv3 features: 16 PPIs [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x000000002f100000 [ 0.000000] ITS [mem 0x2f020000-0x2f03ffff] [ 0.000000] ITS@0x000000002f020000: allocated 8192 Devices @880380000 (indirect, esz 8, psz 64K, shr 1) [ 0.000000] ITS@0x000000002f020000: allocated 8192 Virtual CPUs @880390000 (indirect, esz 8, psz 64K, shr 1) [ 0.000000] ITS@0x000000002f020000: allocated 8192 Interrupt Collections @8803a0000 (flat, esz 8, psz 64K, shr 1) [ 0.000000] GICv3: using LPI property table @0x00000008803b0000 [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008803d0000 [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] timer_sp804: timer clock not found: -517 [ 0.000000] timer_sp804: arm,sp804 clock not found: -2 [ 0.000000] Failed to initialize '/bus@8000000/motherboard-bus@8000000/iofpga-bus@300000000/timer@110000': -22 [ 0.000000] timer_sp804: timer clock not found: -517 [ 0.000000] timer_sp804: arm,sp804 clock not found: -2 [ 0.000000] Failed to initialize '/bus@8000000/motherboard-bus@8000000/iofpga-bus@300000000/timer@120000': -22 [ 0.000000] arch_timer: cp15 timer(s) running at 100.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x171024e7e0, max_idle_ns: 440795205315 ns [ 0.000003] sched_clock: 57 bits at 100MHz, resolution 10ns, wraps every 4398046511100ns [ 0.001503] kfence: initialized - using 33554432 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) [ 0.002748] Console: colour dummy device 80x25 [ 0.003735] Calibrating delay loop (skipped), value calculated using timer frequency.. 200.00 BogoMIPS (lpj=400000) [ 0.003982] pid_max: default: 32768 minimum: 301 [ 0.004833] LSM: Security Framework initializing [ 0.005532] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.005728] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.013998] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 0.028721] cblist_init_generic: Setting adjustable number of callback queues. [ 0.028838] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.029938] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.031186] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.033853] rcu: Hierarchical SRCU implementation. [ 0.033982] rcu: Max phase no-delay instances is 1000. [ 0.046180] Platform MSI: msi-controller@2f020000 domain created [ 0.047156] PCI/MSI: /interrupt-controller@2f000000/msi-controller@2f020000 domain created [ 0.048340] fsl-mc MSI: msi-controller@2f020000 domain created [ 0.056223] Remapping and enabling EFI services. [ 0.062279] smp: Bringing up secondary CPUs ... [ 0.069599] Detected PIPT I-cache on CPU1 [ 0.069911] cacheinfo: Unable to detect cache hierarchy for CPU 1 [ 0.069951] GICv3: CPU1: found redistributor 100 region 0:0x000000002f120000 [ 0.070007] GICv3: CPU1: using allocated LPI pending table @0x00000008803e0000 [ 0.070115] CPU1: Booted secondary processor 0x0000000100 [0x410fd0f0] [ 0.078631] Detected PIPT I-cache on CPU2 [ 0.078963] cacheinfo: Unable to detect cache hierarchy for CPU 2 [ 0.079003] GICv3: CPU2: found redistributor 200 region 0:0x000000002f140000 [ 0.079061] GICv3: CPU2: using allocated LPI pending table @0x00000008803f0000 [ 0.079169] CPU2: Booted secondary processor 0x0000000200 [0x410fd0f0] [ 0.087806] Detected PIPT I-cache on CPU3 [ 0.088146] cacheinfo: Unable to detect cache hierarchy for CPU 3 [ 0.088199] GICv3: CPU3: found redistributor 300 region 0:0x000000002f160000 [ 0.088257] GICv3: CPU3: using allocated LPI pending table @0x0000000880400000 [ 0.088364] CPU3: Booted secondary processor 0x0000000300 [0x410fd0f0] [ 0.096621] Detected PIPT I-cache on CPU4 [ 0.096990] cacheinfo: Unable to detect cache hierarchy for CPU 4 [ 0.097034] GICv3: CPU4: found redistributor 10000 region 0:0x000000002f180000 [ 0.097093] GICv3: CPU4: using allocated LPI pending table @0x0000000880410000 [ 0.097201] CPU4: Booted secondary processor 0x0000010000 [0x410fd0f0] [ 0.105784] Detected PIPT I-cache on CPU5 [ 0.106172] cacheinfo: Unable to detect cache hierarchy for CPU 5 [ 0.106218] GICv3: CPU5: found redistributor 10100 region 0:0x000000002f1a0000 [ 0.106274] GICv3: CPU5: using allocated LPI pending table @0x0000000880420000 [ 0.106384] CPU5: Booted secondary processor 0x0000010100 [0x410fd0f0] [ 0.114878] Detected PIPT I-cache on CPU6 [ 0.115276] cacheinfo: Unable to detect cache hierarchy for CPU 6 [ 0.115331] GICv3: CPU6: found redistributor 10200 region 0:0x000000002f1c0000 [ 0.115391] GICv3: CPU6: using allocated LPI pending table @0x0000000880430000 [ 0.115498] CPU6: Booted secondary processor 0x0000010200 [0x410fd0f0] [ 0.124047] Detected PIPT I-cache on CPU7 [ 0.124459] cacheinfo: Unable to detect cache hierarchy for CPU 7 [ 0.124522] GICv3: CPU7: found redistributor 10300 region 0:0x000000002f1e0000 [ 0.124582] GICv3: CPU7: using allocated LPI pending table @0x0000000880440000 [ 0.124689] CPU7: Booted secondary processor 0x0000010300 [0x410fd0f0] [ 0.126408] smp: Brought up 1 node, 8 CPUs [ 0.128698] SMP: Total of 8 processors activated. [ 0.128834] CPU features: detected: Branch Target Identification [ 0.128977] CPU features: detected: 32-bit EL0 Support [ 0.129111] CPU features: detected: ARMv8.4 Translation Table Level [ 0.129256] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.129417] CPU features: detected: Common not Private translations [ 0.129563] CPU features: detected: CRC32 instructions [ 0.130692] CPU features: detected: E0PD [ 0.130822] CPU features: detected: Enhanced Counter Virtualization [ 0.130967] CPU features: detected: Enhanced Privileged Access Never [ 0.131122] CPU features: detected: Generic authentication (IMP DEF algorithm) [ 0.131274] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.131415] CPU features: detected: LSE atomic instructions [ 0.131556] CPU features: detected: Privileged Access Never [ 0.131697] CPU features: detected: RAS Extension Support [ 0.131836] CPU features: detected: Random Number Generator [ 0.131976] CPU features: detected: Speculation barrier (SB) [ 0.132118] CPU features: detected: Stage-2 Force Write-Back [ 0.132259] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality [ 0.132413] CPU features: detected: TLB range maintenance instructions [ 0.132559] CPU features: detected: WFx with timeout [ 0.132696] CPU features: detected: Scalable Matrix Extension [ 0.132842] CPU features: detected: Scalable Vector Extension [ 0.133479] CPU features: detected CPU1: Activity Monitors Unit (AMU) [ 0.133479] CPU features: detected CPU5: Activity Monitors Unit (AMU) [ 0.133479] CPU features: detected CPU6: Activity Monitors Unit (AMU) [ 0.133480] CPU features: detected CPU4: Activity Monitors Unit (AMU) [ 0.133480] CPU features: detected CPU3: Activity Monitors Unit (AMU) [ 0.133480] CPU features: detected CPU2: Activity Monitors Unit (AMU) [ 0.133480] CPU features: detected CPU0: Activity Monitors Unit (AMU) [ 0.133480] CPU features: detected CPU7: Activity Monitors Unit (AMU) [ 0.134375] SVE: maximum available vector length 64 bytes per vector [ 0.134524] SVE: default vector length 64 bytes per vector [ 0.134732] SME: minimum available vector length 16 bytes per vector [ 0.134874] SME: maximum available vector length 64 bytes per vector [ 0.135019] SME: default vector length 32 bytes per vector [ 0.135160] CPU: All CPU(s) started at EL2 [ 0.135285] alternatives: applying system-wide alternatives [ 0.178581] devtmpfs: initialized [ 0.213281] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.213546] futex hash table entries: 2048 (order: 1, 131072 bytes, linear) [ 0.221349] pinctrl core: initialized pinctrl subsystem [ 0.237878] DMI not present or invalid. [ 0.243351] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.493546] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.496267] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.497765] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.498419] audit: initializing netlink subsys (disabled) [ 0.500423] audit: type=2000 audit(0.460:1): state=initialized audit_enabled=0 res=1 [ 0.508870] thermal_sys: Registered thermal governor 'step_wise' [ 0.508939] thermal_sys: Registered thermal governor 'power_allocator' [ 0.509801] cpuidle: using governor menu [ 0.511968] hw-breakpoint: found 16 breakpoint and 16 watchpoint registers. [ 0.514125] ASID allocator initialised with 65536 entries [ 0.534035] Serial: AMBA PL011 UART driver [ 0.736844] 1c090000.serial: ttyAMA0 at MMIO 0x1c090000 (irq = 16, base_baud = 0) is a PL011 rev2 [ 0.737154] printk: console [ttyAMA0] enabled [ 0.737154] printk: console [ttyAMA0] enabled [ 0.737359] printk: bootconsole [pl11] disabled [ 0.737359] printk: bootconsole [pl11] disabled [ 0.752537] 1c0a0000.serial: ttyAMA1 at MMIO 0x1c0a0000 (irq = 17, base_baud = 0) is a PL011 rev2 [ 0.767418] 1c0b0000.serial: ttyAMA2 at MMIO 0x1c0b0000 (irq = 18, base_baud = 0) is a PL011 rev2 [ 0.782555] 1c0c0000.serial: ttyAMA3 at MMIO 0x1c0c0000 (irq = 19, base_baud = 0) is a PL011 rev2 [ 0.928904] platform panel: Fixing up cyclic dependency with 1c1f0000.clcd [ 0.951529] KASLR enabled [ 1.089824] HugeTLB: registered 16.0 GiB page size, pre-allocated 0 pages [ 1.089987] HugeTLB: 16320 KiB vmemmap can be freed for a 16.0 GiB page [ 1.090158] HugeTLB: registered 512 MiB page size, pre-allocated 0 pages [ 1.090320] HugeTLB: 448 KiB vmemmap can be freed for a 512 MiB page [ 1.090493] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages [ 1.090656] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page [ 1.103721] cryptd: max_cpu_qlen set to 1000 [ 1.122956] ACPI: Interpreter disabled. [ 1.161700] iommu: Default domain type: Translated [ 1.161848] iommu: DMA domain TLB invalidation policy: strict mode [ 1.164436] SCSI subsystem initialized [ 1.168584] usbcore: registered new interface driver usbfs [ 1.169107] usbcore: registered new interface driver hub [ 1.169924] usbcore: registered new device driver usb [ 1.181341] mc: Linux media interface: v0.10 [ 1.181663] videodev: Linux video capture interface: v2.00 [ 1.182031] pps_core: LinuxPPS API ver. 1 registered [ 1.182176] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx> [ 1.182424] PTP clock support registered [ 1.184233] EDAC MC: Ver: 3.0.0 [ 1.196616] Registered efivars operations [ 1.212509] FPGA manager framework [ 1.213343] Advanced Linux Sound Architecture Driver Initialized. [ 1.221704] vgaarb: loaded [ 1.228147] clocksource: Switched to clocksource arch_sys_counter [ 11.493713] VFS: Disk quotas dquot_6.6.0 [ 11.494681] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes) [ 11.497772] pnp: PnP ACPI: disabled [ 11.572548] NET: Registered PF_INET protocol family [ 11.573589] IP idents hash table entries: 65536 (order: 3, 524288 bytes, linear) [ 11.631281] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear) [ 11.632782] Table-perturb hash table entries: 65536 (order: 2, 262144 bytes, linear) [ 11.633031] TCP established hash table entries: 32768 (order: 2, 262144 bytes, linear) [ 11.635895] TCP bind hash table entries: 32768 (order: 4, 1048576 bytes, linear) [ 11.641494] TCP: Hash tables configured (established 32768 bind 32768) [ 11.643141] MPTCP token hash table entries: 4096 (order: 0, 98304 bytes, linear) [ 11.644132] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 11.644888] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 11.646828] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 11.650493] RPC: Registered named UNIX socket transport module. [ 11.650651] RPC: Registered udp transport module. [ 11.650801] RPC: Registered tcp transport module. [ 11.650950] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 11.651158] PCI: CLS 0 bytes, default 64 [ 11.663560] hw perfevents: enabled with armv8_pmuv3 PMU driver, 9 counters available [ 11.665617] kvm [1]: IPA Size Limit: 48 bits [ 11.665854] [Firmware Bug]: CPU interface incapable of MMIO access [ 11.665998] kvm [1]: disabling GICv2 emulation [ 11.666373] kvm [1]: GIC system register CPU interface enabled [ 11.668852] kvm [1]: vgic interrupt IRQ9 [ 11.671600] kvm [1]: VHE mode initialized successfully [ 11.689669] Initialise system trusted keyrings [ 11.691194] workingset: timestamp_bits=42 max_order=16 bucket_order=0 [ 11.799839] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 11.806970] NFS: Registering the id_resolver key type [ 11.807214] Key type id_resolver registered [ 11.807342] Key type id_legacy registered [ 11.808390] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 11.808560] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 11.809821] 9p: Installing v9fs 9p2000 file system support [ 12.172427] NET: Registered PF_ALG protocol family [ 12.172601] Key type asymmetric registered [ 12.172746] Asymmetric key parser 'x509' registered [ 12.173251] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) [ 12.173427] io scheduler mq-deadline registered [ 12.173581] io scheduler kyber registered [ 12.390227] pci-host-generic 40000000.pci: host bridge /pci@40000000 ranges: [ 12.390865] pci-host-generic 40000000.pci: MEM 0x0050000000..0x005fffffff -> 0x0050000000 [ 12.391875] pci-host-generic 40000000.pci: ECAM at [mem 0x40000000-0x4fffffff] for [bus 00-01] [ 12.393278] pci-host-generic 40000000.pci: PCI host bridge to bus 0000:00 [ 12.393470] pci_bus 0000:00: root bus resource [bus 00-01] [ 12.393655] pci_bus 0000:00: root bus resource [mem 0x50000000-0x5fffffff] [ 12.394270] pci 0000:00:00.0: [1af4:1001] type 00 class 0x018000 [ 12.394754] pci 0000:00:00.0: reg 0x10: [mem 0x5000f000-0x5000ffff] [ 12.395202] pci 0000:00:00.0: reg 0x18: [mem 0x5000e000-0x5000efff] [ 12.395667] pci 0000:00:00.0: reg 0x20: [mem 0x5000d000-0x5000dfff] [ 12.396285] pci 0000:00:00.0: enabling Extended Tags [ 12.397843] pci 0000:00:00.0: PME# supported from D3hot [ 12.401186] pci 0000:00:02.0: [1af4:1001] type 00 class 0x018000 [ 12.401669] pci 0000:00:02.0: reg 0x10: [mem 0x5000c000-0x5000cfff] [ 12.402126] pci 0000:00:02.0: reg 0x18: [mem 0x5000b000-0x5000bfff] [ 12.402582] pci 0000:00:02.0: reg 0x20: [mem 0x5000a000-0x5000afff] [ 12.403143] pci 0000:00:02.0: enabling Extended Tags [ 12.404756] pci 0000:00:02.0: PME# supported from D3hot [ 12.407793] pci 0000:00:03.0: [0abc:aced] type 00 class 0x010601 [ 12.408333] pci 0000:00:03.0: reg 0x10: [mem 0x50006000-0x50007fff] [ 12.408661] pci 0000:00:03.0: reg 0x14: [mem 0x50004000-0x50005fff] [ 12.408988] pci 0000:00:03.0: reg 0x18: [mem 0x50009000-0x50009fff] [ 12.409316] pci 0000:00:03.0: reg 0x1c: [mem 0x50002000-0x50003fff] [ 12.409643] pci 0000:00:03.0: reg 0x20: [mem 0x50008000-0x50008fff] [ 12.409971] pci 0000:00:03.0: reg 0x24: [mem 0x50000000-0x50001fff] [ 12.411198] pci 0000:00:03.0: PME# supported from D3hot [ 12.418885] pci 0000:00:03.0: BAR 0: assigned [mem 0x50000000-0x50001fff] [ 12.419153] pci 0000:00:03.0: BAR 1: assigned [mem 0x50002000-0x50003fff] [ 12.419422] pci 0000:00:03.0: BAR 3: assigned [mem 0x50004000-0x50005fff] [ 12.419690] pci 0000:00:03.0: BAR 5: assigned [mem 0x50006000-0x50007fff] [ 12.419959] pci 0000:00:00.0: BAR 0: assigned [mem 0x50008000-0x50008fff] [ 12.420284] pci 0000:00:00.0: BAR 2: assigned [mem 0x50009000-0x50009fff] [ 12.420557] pci 0000:00:00.0: BAR 4: assigned [mem 0x5000a000-0x5000afff] [ 12.420827] pci 0000:00:02.0: BAR 0: assigned [mem 0x5000b000-0x5000bfff] [ 12.421097] pci 0000:00:02.0: BAR 2: assigned [mem 0x5000c000-0x5000cfff] [ 12.421367] pci 0000:00:02.0: BAR 4: assigned [mem 0x5000d000-0x5000dfff] [ 12.421638] pci 0000:00:03.0: BAR 2: assigned [mem 0x5000e000-0x5000efff] [ 12.421908] pci 0000:00:03.0: BAR 4: assigned [mem 0x5000f000-0x5000ffff] [ 12.454452] EINJ: ACPI disabled. [ 12.815079] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 12.860880] SuperH (H)SCI(F) driver initialized [ 12.871460] msm_serial: driver initialized [ 12.892779] arm-smmu-v3 2b400000.iommu: command queue size <= 64 entries not supported [ 12.901211] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 12.989818] loop: module loaded [ 12.990593] virtio_blk virtio0: 1/0/0 default/read/poll queues [ 12.998175] virtio_blk virtio0: [vda] 3351968 512-byte logical blocks (1.72 GB/1.60 GiB) [ 13.023477] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 13.034087] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 13.044828] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 13.300576] megasas: 07.719.03.00-rc1 [ 13.328358] physmap-flash 8000000.flash: physmap platform flash device: [mem 0x08000000-0x0bffffff] [ 13.328595] 8000000.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000089 Chip ID 0x000018 [ 13.328826] Intel/Sharp Extended Query Table at 0x0031 [ 13.328982] Intel/Sharp Extended Query Table at 0x0031 [ 13.329164] Using buffer write method [ 13.329828] physmap-flash 8000000.flash: physmap platform flash device: [mem 0x0c000000-0x0fffffff] [ 13.330056] 8000000.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000089 Chip ID 0x000018 [ 13.330291] Intel/Sharp Extended Query Table at 0x0031 [ 13.330465] Intel/Sharp Extended Query Table at 0x0031 [ 13.330634] Using buffer write method [ 13.330882] Concatenating MTD devices: [ 13.331013] (0): \"8000000.flash\" [ 13.331152] (1): \"8000000.flash\" [ 13.331291] into device \"8000000.flash\" [ 13.478865] virtio_net: probe of virtio2 failed with error -2 [ 13.497593] thunder_xcv, ver 1.0 [ 13.498190] thunder_bgx, ver 1.0 [ 13.498791] nicpf, ver 1.0 [ 13.523859] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version [ 13.524089] hns3: Copyright (c) 2017 Huawei Corporation. [ 13.524838] hclge is initializing [ 13.525033] e1000: Intel(R) PRO/1000 Network Driver [ 13.525179] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 13.525840] e1000e: Intel(R) PRO/1000 Network Driver [ 13.525980] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 13.526656] igb: Intel(R) Gigabit Ethernet Network Driver [ 13.526805] igb: Copyright (c) 2007-2014 Intel Corporation. [ 13.527368] igbvf: Intel(R) Gigabit Virtual Function Network Driver [ 13.527539] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 13.534351] sky2: driver version 1.30 [ 13.534956] QLogic FastLinQ 4xxxx Core Module qed [ 13.535111] qede init: QLogic FastLinQ 4xxxx Ethernet Driver qede [ 13.545770] smc91x 1a000000.ethernet (unnamed net_device) (uninitialized): smc91x: IOADDR 0000000014856b0f doesn't match configuration (300). [ 13.545999] smc91x.c: v1.1, sep 22 2004 by Nicolas Pitre <nico@xxxxxxxxxxx> [ 13.566172] smc91x 1a000000.ethernet eth0: SMC91C11xFD (rev 1) at 0000000014856b0f IRQ 26 [ 13.566381] [ 13.566511] smc91x 1a000000.ethernet eth0: Ethernet addr: 00:02:f7:ef:ab:7c [ 13.579475] usbcore: registered new interface driver asix [ 13.579929] usbcore: registered new interface driver ax88179_178a [ 13.581392] VFIO - User Level meta-driver version: 0.3 [ 13.641655] usbcore: registered new interface driver usb-storage [ 13.705037] rtc-efi rtc-efi.0: registered as rtc0 [ 13.705837] rtc-efi rtc-efi.0: setting system clock to 2023-01-10T22:00:20 UTC (1673388020) [ 13.723309] rtc-pl031 1c170000.rtc: registered as rtc1 [ 13.735370] i2c_dev: i2c /dev entries driver [ 13.831208] sp805-wdt 1c0f0000.watchdog: registration successful [ 13.903654] mmci-pl18x 1c050000.mmc: Got CD GPIO [ 13.904270] mmci-pl18x 1c050000.mmc: Got WP GPIO [ 13.913811] mmci-pl18x 1c050000.mmc: mmc0: PL180 manf 41 rev0 at 0x1c050000 irq 31,32 (pio) [ 13.942723] sdhci: Secure Digital Host Controller Interface driver [ 13.942871] sdhci: Copyright(c) Pierre Ossman [ 13.956703] Synopsys Designware Multimedia Card Interface Driver [ 13.976971] sdhci-pltfm: SDHCI platform and OF driver helper [ 13.995355] input: AT Raw Set 2 keyboard as /devices/platform/bus@8000000/bus@8000000:motherboard-bus@8000000/bus@8000000:motherboard-bus@8000000:iofpga-bus@300000000/1c060000.kmi/serio0/input/input0 [ 14.024311] ledtrig-cpu: registered to indicate activity on CPUs [ 14.054914] pstore: Registered efi as persistent store backend [ 14.060796] SMCCC: SOC_ID: ID = jep106:043b:0000 Revision = 0x00000002 [ 14.110000] usbcore: registered new interface driver usbhid [ 14.110154] usbhid: USB HID core driver [ 14.178244] cs_system_cfg: CoreSight Configuration manager initialised [ 14.267575] NET: Registered PF_INET6 protocol family [ 14.279049] Segment Routing with IPv6 [ 14.279372] In-situ OAM (IOAM) with IPv6 [ 14.280032] NET: Registered PF_PACKET protocol family [ 14.281675] 9pnet: Installing 9P2000 support [ 14.289141] Key type dns_resolver registered [ 14.303554] registered taskstats version 1 [ 14.303829] Loading compiled-in X.509 certificates [ 14.306420] pstore: Using crash dump compression: deflate [ 16.267057] input: PS/2 Generic Mouse as /devices/platform/bus@8000000/bus@8000000:motherboard-bus@8000000/bus@8000000:motherboard-bus@8000000:iofpga-bus@300000000/1c070000.kmi/serio1/input/input2 [ 16.334681] smc91x 1a000000.ethernet eth0: link up, 10Mbps, half-duplex, lpa 0x0000 [ 16.360265] Sending DHCP requests ., OK [ 16.361506] IP-Config: Got DHCP answer from 172.20.51.254, my address is 172.20.51.1 [ 16.361704] IP-Config: Complete: [ 16.361832] device=eth0, hwaddr=00:02:f7:ef:ab:7c, ipaddr=172.20.51.1, mask=255.255.255.0, gw=172.20.51.254 [ 16.362055] host=172.20.51.1, domain=, nis-domain=(none) [ 16.362214] bootserver=172.20.51.254, rootserver=172.20.51.254, rootpath= [ 16.362318] nameserver0=172.20.51.254, nameserver1=172.20.51.252 [ 16.367711] ALSA device list: [ 16.367854] No soundcards found. [ 16.369353] uart-pl011 1c090000.serial: no DMA platform data [ 16.391600] EXT4-fs (vda): mounted filesystem with ordered data mode. Quota mode: none. [ 16.392020] VFS: Mounted root (ext4 filesystem) readonly on device 254:0. [ 16.393747] devtmpfs: mounted [ 16.504426] Freeing unused kernel memory: 12416K [ 16.505038] Run /sbin/init as init process [ 16.796592] systemd[1]: systemd 250.5+ running in system mode (-PAM -AUDIT -SELINUX -APPARMOR +IMA -SMACK +SECCOMP -GCRYPT -GNUTLS -OPENSSL +ACL +BLKID -CURL -ELFUTILS -FIDO2 -IDN2 -IDN -IPTC +KMOD -LIBCRYPTSETUP +LIBFDISK -PCRE2 -PWQUALITY -P11KIT -QRENCODE -BZIP2 -LZ4 -XZ -ZLIB +ZSTD -BPF_FRAMEWORK +XKBCOMMON +UTMP +SYSVINIT default-hierarchy=hybrid) [ 16.813822] systemd[1]: Detected architecture arm64. Welcome to [1mLinux-Kernel-Functional-Testing nodistro.0[0m! [ 16.917029] systemd[1]: Hostname set to <fvp-base>. [ 16.924161] systemd[1]: Initializing machine ID from random generator. [ 16.934559] systemd[1]: Installed transient /etc/machine-id file. [ 19.740921] systemd[1]: Queued start job for default target Multi-User System. [ 20.402256] systemd[1]: Created slice Slice /system/getty. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/getty[0m. [ 20.423469] systemd[1]: Created slice Slice /system/modprobe. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/modprobe[0m. [ 20.443847] systemd[1]: Created slice Slice /system/serial-getty. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/serial-getty[0m. [ 20.462118] systemd[1]: Created slice User and Session Slice. [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. [ 20.475988] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [[0;32m OK [0m] Started [0;1;39mDispatch Password …ts to Console Directory Watch[0m. [ 20.480800] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [[0;32m OK [0m] Started [0;1;39mForward Password R…uests to Wall Directory Watch[0m. [ 20.484380] systemd[1]: Reached target Path Units. [[0;32m OK [0m] Reached target [0;1;39mPath Units[0m. [ 20.486583] systemd[1]: Reached target Remote File Systems. [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. [ 20.489079] systemd[1]: Reached target Slice Units. [[0;32m OK [0m] Reached target [0;1;39mSlice Units[0m. [ 20.491412] systemd[1]: Reached target Swaps. [[0;32m OK [0m] Reached target [0;1;39mSwaps[0m. [ 20.660568] systemd[1]: Listening on RPCbind Server Activation Socket. [[0;32m OK [0m] Listening on [0;1;39mRPCbind Server Activation Socket[0m. [ 20.662964] systemd[1]: Reached target RPC Port Mapper. [[0;32m OK [0m] Reached target [0;1;39mRPC Port Mapper[0m. [ 20.670642] systemd[1]: Listening on Syslog Socket. [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. [ 20.674723] systemd[1]: Listening on initctl Compatibility Named Pipe. [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. [ 20.694306] systemd[1]: Listening on Journal Audit Socket. [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. [ 20.700809] systemd[1]: Listening on Journal Socket (/dev/log). [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. [ 20.708552] systemd[1]: Listening on Journal Socket. [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. [ 20.718282] systemd[1]: Listening on Network Service Netlink Socket. [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. [ 20.726338] systemd[1]: Listening on udev Control Socket. [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. [ 20.732677] systemd[1]: Listening on udev Kernel Socket. [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. [ 20.738963] systemd[1]: Listening on User Database Manager Socket. [[0;32m OK [0m] Listening on [0;1;39mUser Database Manager Socket[0m. [ 20.806523] systemd[1]: Mounting Huge Pages File System... Mounting [0;1;39mHuge Pages File System[0m... [ 20.843551] systemd[1]: Mounting POSIX Message Queue File System... Mounting [0;1;39mPOSIX Message Queue File System[0m... [ 20.882265] systemd[1]: Mounting Kernel Debug File System... Mounting [0;1;39mKernel Debug File System[0m... [ 20.920596] systemd[1]: Mounting Kernel Trace File System... Mounting [0;1;39mKernel Trace File System[0m... [ 20.957583] systemd[1]: Mounting Temporary Directory /tmp... Mounting [0;1;39mTemporary Directory /tmp[0m... [ 20.999822] systemd[1]: Starting Create List of Static Device Nodes... Starting [0;1;39mCreate List of Static Device Nodes[0m... [ 21.038861] systemd[1]: Starting Load Kernel Module configfs... Starting [0;1;39mLoad Kernel Module configfs[0m... [ 21.077326] systemd[1]: Starting Load Kernel Module drm... Starting [0;1;39mLoad Kernel Module drm[0m... [ 21.115618] systemd[1]: Starting Load Kernel Module fuse... Starting [0;1;39mLoad Kernel Module fuse[0m... [ 21.155239] systemd[1]: Starting RPC Bind... Starting [0;1;39mRPC Bind[0m... [ 21.192671] systemd[1]: Starting File System Check on Root Device... Starting [0;1;39mFile System Check on Root Device[0m... [ 21.205865] fuse: init (API version 7.37) [ 21.267751] systemd[1]: Starting Journal Service... Starting [0;1;39mJournal Service[0m... [ 21.279507] systemd[1]: Load Kernel Modules was skipped because all trigger condition checks failed. [ 21.324971] systemd[1]: Starting Generate network units from Kernel command line... Starting [0;1;39mGenerate network …ts from Kernel command line[0m... [ 21.365902] systemd[1]: Starting Apply Kernel Variables... Starting [0;1;39mApply Kernel Variables[0m... [ 21.403173] systemd[1]: Starting Coldplug All udev Devices... Starting [0;1;39mColdplug All udev Devices[0m... [ 21.497201] systemd[1]: Started RPC Bind. [[0;32m OK [0m] Started [0;1;39mRPC Bind[0m. [ 21.504281] systemd[1]: Mounted Huge Pages File System. [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. [ 21.510714] systemd[1]: Mounted POSIX Message Queue File System. [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. [ 21.517433] systemd[1]: Mounted Kernel Debug File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. [ 21.523754] systemd[1]: Mounted Kernel Trace File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. [ 21.530891] systemd[1]: Mounted Temporary Directory /tmp. [[0;32m OK [0m] Mounted [0;1;39mTemporary Directory /tmp[0m. [ 21.550414] systemd[1]: Finished Create List of Static Device Nodes. [[0;32m OK [0m] Finished [0;1;39mCreate List of Static Device Nodes[0m. [ 21.566969] systemd[1]: modprobe@configfs.service: Deactivated successfully. [ 21.583683] systemd[1]: Finished Load Kernel Module configfs. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module configfs[0m. [ 21.597706] systemd[1]: modprobe@drm.service: Deactivated successfully. [ 21.614528] systemd[1]: Finished Load Kernel Module drm. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. [ 21.628526] systemd[1]: modprobe@fuse.service: Deactivated successfully. [ 21.641422] systemd[1]: Finished Load Kernel Module fuse. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module fuse[0m. [ 21.665532] systemd[1]: Finished File System Check on Root Device. [[0;32m OK [0m] Finished [0;1;39mFile System Check on Root Device[0m. [ 21.689064] systemd[1]: Finished Generate network units from Kernel command line. [[0;32m OK [0m] Finished [0;1;39mGenerate network units from Kernel command line[0m. [ 21.709229] systemd[1]: Finished Apply Kernel Variables. [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. [ 21.723460] systemd[1]: Reached target Preparation for Network. [[0;32m OK [0m] Reached target [0;1;39mPreparation for Network[0m. [ 21.796391] systemd[1]: Mounting FUSE Control File System... Mounting [0;1;39mFUSE Control File System[0m... [ 21.838369] systemd[1]: Mounting Kernel Configuration File System... Mounting [0;1;39mKernel Configuration File System[0m... [ 21.875564] systemd[1]: Starting Remount Root and Kernel File Systems... Starting [0;1;39mRemount Root and Kernel File Systems[0m... [ 21.933459] systemd[1]: Mounted FUSE Control File System. [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. [ 21.939761] systemd[1]: Mounted Kernel Configuration File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. [ 22.032319] EXT4-fs (vda): re-mounted. Quota mode: none. [ 22.091688] systemd[1]: Finished Remount Root and Kernel File Systems. [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. [ 22.104363] systemd[1]: Rebuild Hardware Database was skipped because all trigger condition checks failed. [ 22.105726] systemd[1]: Platform Persistent Storage Archival was skipped because of a failed condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [ 22.189828] systemd[1]: Starting Create System Users... Starting [0;1;39mCreate System Users[0m... [ 22.497668] systemd[1]: Finished Create System Users. [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. [ 22.578977] systemd[1]: Starting Create Static Device Nodes in /dev... Starting [0;1;39mCreate Static Device Nodes in /dev[0m... [ 22.848720] systemd[1]: Finished Create Static Device Nodes in /dev. [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. [ 22.854298] systemd[1]: Reached target Preparation for Local File Systems. [[0;32m OK [0m] Reached target [0;1;39mPreparation for Local File Systems[0m. [ 22.932501] systemd[1]: Mounting /var/volatile... Mounting [0;1;39m/var/volatile[0m... [ 22.989849] audit: type=1334 audit(1673388029.780:2): prog-id=5 op=LOAD [ 22.991935] audit: type=1334 audit(1673388029.780:3): prog-id=6 op=LOAD [ 23.021315] systemd[1]: Starting Rule-based Manager for Device Events and Files... Starting [0;1;39mRule-based Manage…for Device Events and Files[0m... [ 23.055005] systemd[1]: Started Journal Service. [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. [[0;32m OK [0m] Mounted [0;1;39m/var/volatile[0m. Starting [0;1;39mFlush Journal to Persistent Storage[0m... Starting [0;1;39mLoad/Save Random Seed[0m... [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. Starting [0;1;39mRebuild Dynamic Linker Cache[0m... [ 23.335200] systemd-journald[239]: Received client request to flush runtime journal. [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. Starting [0;1;39mCreate Volatile Files and Directories[0m... [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. Starting [0;1;39mCommit a transient machine-id on disk[0m... [[0;32m OK [0m] Finished [0;1;39mRebuild Dynamic Linker Cache[0m. [[0;32m OK [0m] Finished [0;1;39mCommit a transient machine-id on disk[0m. [[0;32m OK [0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m. Starting [0;1;39mNetwork Configuration[0m... [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. Starting [0;1;39mRebuild Journal Catalog[0m... Starting [0;1;39mNetwork Time Synchronization[0m... Starting [0;1;39mRecord System Boot/Shutdown in UTMP[0m... [[0;32m OK [0m] Finished [0;1;39mRecord System Boot/Shutdown in UTMP[0m. [[0;32m OK [0m] Finished [0;1;39mRebuild Journal Catalog[0m. Starting [0;1;39mUpdate is Completed[0m... [[0;32m OK [0m] Finished [0;1;39mUpdate is Completed[0m. [[0;32m OK [0m] Listening on [0;1;39mLoad/Save RF …itch Status /dev/rfkill Watch[0m. [ 26.087535] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 26.145593] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 26.146420] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [ 26.146650] cfg80211: failed to load regulatory.db [ 26.385260] virtio-pci 0000:00:00.0: deferred probe timeout, ignoring dependency [ 26.386459] virtio-pci 0000:00:00.0: enabling device (0000 -> 0002) [ 26.386852] virtio-pci 0000:00:00.0: virtio_pci: leaving for legacy driver [[0;32m OK [0m] Started [0;1;39mNetwork Configuration[0m. [ 26.397486] virtio_blk virtio3: 1/0/0 default/read/poll queues [ 26.403419] virtio_blk virtio3: [vdb] 0 512-byte logical blocks (0 B/0 B) [ 26.448423] virtio-pci 0000:00:02.0: deferred probe timeout, ignoring dependency [ 26.449199] virtio-pci 0000:00:02.0: enabling device (0000 -> 0002) [ 26.449592] virtio-pci 0000:00:02.0: virtio_pci: leaving for legacy driver [ 26.462050] virtio_blk virtio4: 1/0/0 default/read/poll queues [ 26.474564] virtio_blk virtio4: [vdc] 0 512-byte logical blocks (0 B/0 B) Starting [0;1;39mNetwork Name Resolution[0m... [ 26.507052] ahci 0000:00:03.0: deferred probe timeout, ignoring dependency [ 26.508463] ahci 0000:00:03.0: enabling device (0000 -> 0002) [ 26.511324] ahci 0000:00:03.0: AHCI 0001.0301 32 slots 1 ports 6 Gbps 0x1 impl SATA mode [ 26.511559] ahci 0000:00:03.0: flags: 64bit ncq only [ 26.527368] scsi host0: ahci [ 26.531812] ata1: SATA max UDMA/133 abar m8192@0x50006000 port 0x50006100 irq 39 [ 26.848773] ata1: SATA link down (SStatus 0 SControl 300) [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. [[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. [[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. [[0;32m OK [0m] Finished [0;1;39mColdplug All udev Devices[0m. [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. [[0;32m OK [0m] Reached target [0;1;39mTimer Units[0m. [[0;32m OK [0m] Listening on [0;1;39mAvahi mDNS/DNS-SD Stack Activation Socket[0m. [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. [[0;32m OK [0m] Reached target [0;1;39mSocket Units[0m. [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. [ 31.241281] panel-simple panel: supply power not found, using dummy regulator [ 31.243540] panel-simple panel: Specify missing connector_type Starting [0;1;39mAvahi mDNS/DNS-SD Stack[0m... [[0;32m OK [0m] Started [0;1;39mKernel Logging Service[0m. [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. [[0;32m OK [0m] Started [0;1;39mPeriodic Command Scheduler[0m. Starting [0;1;39mD-Bus System Message Bus[0m... [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. [[0;32m OK [0m] Started [0;1;39mSerial Getty on ttyAMA0[0m. [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. [ 31.843659] audit: type=1334 audit(1673388038.624:4): prog-id=7 op=LOAD [ 31.844004] audit: type=1334 audit(1673388038.628:5): prog-id=8 op=LOAD Starting [0;1;39mUser Login Management[0m... [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. [ 32.042134] arm_spe_pmu spe-pmu: probed for CPUs 0-7 [max_record_sz 64, align 1, features 0xf] [ 32.262171] drm-clcd-pl111 1c1f0000.clcd: assigned reserved memory node vram@18000000 [ 32.262361] drm-clcd-pl111 1c1f0000.clcd: using device-specific reserved memory [ 32.262567] drm-clcd-pl111 1c1f0000.clcd: no max memory bandwidth specified, assume unlimited [ 32.264765] drm-clcd-pl111 1c1f0000.clcd: DVI muxed to motherboard CLCD [ 32.276275] drm-clcd-pl111 1c1f0000.clcd: initializing Versatile Express PL111 [ 32.278004] drm-clcd-pl111 1c1f0000.clcd: found panel on endpoint 0 [ 32.296973] [drm] Initialized pl111 1.0.0 20170317 for 1c1f0000.clcd on minor 0 [ 32.417023] Console: switching to colour frame buffer device 128x48 [ 32.453287] drm-clcd-pl111 1c1f0000.clcd: [drm] fb0: pl111drmfb frame buffer device [[0;32m OK [0m] Started [0;1;39mAvahi mDNS/DNS-SD Stack[0m. [[0;32m OK [0m] Started [0;1;39mUser Login Management[0m. [[0;32m OK [0m] Reached target [0;1;39mMulti-User System[0m. Starting [0;1;39mRecord Runlevel Change in UTMP[0m... [[0;32m OK [0m] Finished [0;1;39mRecord Runlevel Change in UTMP[0m. Linux-Kernel-Functional-Testing nodistro.0 fvp-base ttyAMA0 fvp-base login: root root 7[r[999;999H[6nroot@fvp-base:~# root@fvp-base:~# # # root@fvp-base:~# export SHELL=/bin/sh export SHELL=/bin/sh root@fvp-base:~# . /lava-1/environment . /lava-1/environment root@fvp-base:~# /lava-1/bin/lava-test-runner /lava-1/0 /lava-1/bin/lava-test-runner /lava-[ 94.993242] systemd-journald[239]: Time jumped backwards, rotating. 1/0 + export TESTRUN_ID=0_ltp-mm + TESTRUN_ID=0_ltp-mm + cd /lava-1/0/tests/0_ltp-mm ++ cat uuid + UUID=1_1.1.3.1 + set +x [ 95.473945] <LAVA_SIGNAL_STARTRUN 0_ltp-mm 1_1.1.3.1> + cd ./automated/linux/ltp/ Broadcast message from systemd-journald@fvp-base (Tue 2023-01-10 22:07:58 UTC): kernel[319]: [ 95.473945] <LAVA_SIGNAL_STARTRUN 0_ltp-mm 1_1.1.3.1> + ./ltp.sh -T mm -s true -v '' -M 5 -R root -b '' -d /scratch -g '' -e production -i /opt/ltp/ -S skipfile-lkft.yaml -p '' -u '' -t false -n 6 -c 4 + . ../../lib/sh-test-lib ++ LANG=C ++ export LANG ++ export PATH=/lava-1/0/../bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin:/sbin:/usr/sbin:/usr/local/sbin ++ PATH=/lava-1/0/../bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin:/sbin:/usr/sbin:/usr/local/sbin ++ kernel_config= ++ pwd + OUTPUT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + RESULT_FILE=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/result.txt ++ readlink -f ./ltp.sh + SCRIPT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp.sh ++ dirname /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp.sh + SCRIPTPATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp + echo 'Script path is: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp' Script path is: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp + TST_CMDFILES= + SKIPFILE= + SKIPFILE_YAML= + BOARD= + BRANCH= + ENVIRONMENT= + LTP_VERSION=20180926 + TEST_PROGRAM=ltp + TEST_GIT_URL= ++ pwd + TEST_DIR=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp + BUILD_FROM_TAR=false + SHARD_NUMBER=1 + SHARD_INDEX=1 + LTP_TMPDIR=/ltp-tmp + LTP_INSTALL_PATH=/opt/ltp + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + TST_CMDFILES=mm ++ echo mm ++ sed 's,\/,_,' + LOG_FILE=mm + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SKIP_INSTALL=true + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + LTP_VERSION= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_TIMEOUT_MUL=5 + LTP_TIMEOUT_MUL=5 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export PASSWD=root + PASSWD=root + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export BOARD= + BOARD= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_TMPDIR=/scratch + LTP_TMPDIR=/scratch + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export BRANCH= + BRANCH= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export ENVIRONMENT=production + ENVIRONMENT=production + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_INSTALL_PATH=/opt/ltp/ + LTP_INSTALL_PATH=/opt/ltp/ + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + '[' -z skipfile-lkft.yaml ']' + '[' yaml = yaml ']' + SKIPFILE_YAML=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + [[ '' != '' ]] + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + [[ '' != '' ]] + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + BUILD_FROM_TAR=false + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SHARD_NUMBER=6 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SHARD_INDEX=4 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + TEST_TARFILE=https://github.com/linux-test-project/ltp/releases/download//ltp-full-.tar.xz + '[' -n /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml ']' + export SKIPFILE_PATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile + SKIPFILE_PATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile + generate_skipfile + info_msg 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' + local 'msg=Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' + '[' -z 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' ']' + printf 'INFO: %s\n' 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' INFO: Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + detect_abi ++ uname -m + abi=aarch64 + case \"${abi}\" in + abi=arm64 + local SKIPGEN_ARGS= + test -n '' + test -n '' + test -n production + SKIPGEN_ARGS=' --environment production' + ../../bin/arm64/skipgen --environment production /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + test 0 -eq 0 + info_msg 'Using the following generated skipfile contents (until EOF):' + local 'msg=Using the following generated skipfile contents (until EOF):' + '[' -z 'Using the following generated skipfile contents (until EOF):' ']' + printf 'INFO: %s\n' 'Using the following generated skipfile contents (until EOF):' INFO: Using the following generated skipfile contents (until EOF): + cat /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile bind06 cve-2018-18559 dio10 dio12 dio13 dio14 dio15 dio16 dio17 dio18 dio19 dio20 dio21 dio22 dio23 dio24 dio25 dio26 dio27 dio28 dio29 dio30 fanotify07 fanotify08 fanotify09 fork13 ftrace_stress_test.sh futex_wake04 gf01 gf14 gf15 gf18 hackbench01 hackbench02 hugemmap06 inotify07 inotify08 ksm01 memcg_stress msgctl10 msgctl11 msgstress03 msgstress04 mtest06 perf_event_open02 ping01 ping602 pth_str01 pth_str02 pth_str03 sendfile09 sendfile09_64 setsockopt06 time-schedule01 + info_msg EOF + local msg=EOF + '[' -z EOF ']' + printf 'INFO: %s\n' EOF INFO: EOF + '[' '!' -f /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile ']' + SKIPFILE='-S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' + check_root ++ id -ru + '[' 0 -eq 0 ']' + return 0 + create_out_dir /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -z /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + local OUTPUT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -d /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + mkdir -p /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -d /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + info_msg 'About to run ltp test...' + local 'msg=About to run ltp test...' + '[' -z 'About to run ltp test...' ']' + printf 'INFO: %s\n' 'About to run ltp test...' INFO: About to run ltp test... + info_msg 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' + local 'msg=Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' + '[' -z 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' ']' + printf 'INFO: %s\n' 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' INFO: Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' true = true ']' + info_msg 'ltp installation skipped altogether' + local 'msg=ltp installation skipped altogether' + '[' -z 'ltp installation skipped altogether' ']' + printf 'INFO: %s\n' 'ltp installation skipped altogether' INFO: ltp installation skipped altogether + '[' '!' -d /opt/ltp/ ']' + info_msg 'Running prep_system' + local 'msg=Running prep_system' + '[' -z 'Running prep_system' ']' + printf 'INFO: %s\n' 'Running prep_system' INFO: Running prep_system + prep_system + systemctl is-active systemd-timesyncd active + info_msg 'Stopping systemd-timesyncd' + local 'msg=Stopping systemd-timesyncd' + '[' -z 'Stopping systemd-timesyncd' ']' + printf 'INFO: %s\n' 'Stopping systemd-timesyncd' INFO: Stopping systemd-timesyncd + systemctl stop systemd-timesyncd <terminal_1> UEFI firmware (version built at 06:55:08 on Oct 13 2022) + '[' -f /proc/sys/kernel/unprivileged_userns_clone ']' + info_msg 'Kernel has no support of unprivileged_userns_clone' + local 'msg=Kernel has no support of unprivileged_userns_clone' + '[' -z 'Kernel has no support of unprivileged_userns_clone' ']' + printf 'INFO: %s\n' 'Kernel has no support of unprivileged_userns_clone' INFO: Kernel has no support of unprivileged_userns_clone + info_msg 'Running run_ltp' + local 'msg=Running run_ltp' + '[' -z 'Running run_ltp' ']' + printf 'INFO: %s\n' 'Running run_ltp' INFO: Running run_ltp + run_ltp + cd /opt/ltp/ + mkdir -m 777 -p /scratch + for file in ${TST_CMDFILES//,/ } + cat runtest/mm + sed -i 's/#.*$//;/^$/d' alltests + split --verbose --numeric-suffixes=1 -n l/4/6 alltests + echo '============== Tests to run ===============' ============== Tests to run =============== + cat runtest/shardfile mmap10_2 mmap10 -s mmap10_3 mmap10 -a -s mmap10_4 mmap10 -a -s -i 60 ksm01 ksm01 ksm01_1 ksm01 -u 128 ksm02 ksm02 ksm02_1 ksm02 -u 128 ksm03 ksm03 ksm03_1 ksm03 -u 128 ksm04 ksm04 ksm04_1 ksm04 -u 128 ksm05 ksm05 -I 10 ksm06 ksm06 ksm06_1 ksm06 -n 10 ksm06_2 ksm06 -n 8000 + echo '===========End Tests to run ===============' ===========End Tests to run =============== + pipe0_status './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' 'tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' + '[' 2 -ne 2 ']' + local 'cmd1=./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' + local 'cmd2=tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' + exec + local ret_val ++ eval './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' +++ ./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile ++ eval 'tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' +++ tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out INFO: creating /opt/ltp/output directory Checking for required user/group ids 'nobody' user id and group found. 'bin' user id and group found. 'daemon' user id and group found. Users group found. Sys group found. Required users/groups exist. no big block device was specified on commandline. Tests which require a big block device are disabled. You can specify it with option -z INFO: Test start time: Tue Jan 10 22:08:04 UTC 2023 COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 385 -n 385 -p -f /scratch/ltp-GhiO6KfR8M/alltests -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -T /opt/ltp/output/LTP_RUN_ON-LTP_mm.log.tconf LOG File: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log FAILED COMMAND File: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-LTP_mm.log.tconf Running tests....... mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use anonymous pages. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use anonymous pages. mmap10 0 TINFO : start tests. ... tst_kconfig.c:82: TINFO: Parsing kernel config '/proc/config.gz' tst_test.c:1524: TINFO: Timeout per run is 0h 02m 30s mem.c:390: TINFO: child 0 stops. mem.c:390: TINFO: child 1 stops. mem.c:424: TINFO: wait for all children to stop. mem.c:390: TINFO: child 2 stops. mem.c:497: TINFO: KSM merging... mem.c:436: TINFO: resume all children. mem.c:424: TINFO: wait for all children to stop. mem.c:346: TINFO: child 0 continues... mem.c:346: TINFO: child 1 continues... mem.c:349: TINFO: child 0 allocates 128 MB filled with 'c' mem.c:349: TINFO: child 1 allocates 128 MB filled with 'a' mem.c:346: TINFO: child 2 continues... mem.c:349: TINFO: child 2 allocates 128 MB filled with 'a' mem.c:402: TINFO: child 1 stops. mem.c:402: TINFO: child 2 stops. mem.c:402: TINFO: child 0 stops. ksm_helper.c:36: TINFO: ksm daemon takes 1s to run two full scans mem.c:266: TINFO: check! mem.c:257: TPASS: run is 1. mem.c:257: TPASS: pages_shared is 2. mem.c:257: TPASS: pages_sharing is 6142. mem.c:257: TPASS: pages_volatile is 0. mem.c:257: TPASS: pages_unshared is 0. mem.c:257: TPASS: sleep_millisecs is 0. mem.c:257: TPASS: pages_to_scan is 6144. mem.c:436: TINFO: resume all children. mem.c:424: TINFO: wait for all children to stop. mem.c:315: TINFO: child 0 verifies memory content. mem.c:315: TINFO: child 1 verifies memory content. mem.c:315: TINFO: child 2 verifies memory content. mem.c:346: TINFO: child 2 continues... mem.c:349: TINFO: child 2 allocates 128 MB filled with 'a' mem.c:346: TINFO: child 1 continues... mem.c:349: TINFO: child 1 allocates 128 MB filled with 'b' mem.c:346: TINFO: child 0 continues... mem.c:349: TINFO: child 0 allocates 128 MB filled with 'c' mem.c:402: TINFO: child 2 stops. mem.c:402: TINFO: child 1 stops. mem.c:402: TINFO: child 0 stops. ksm_helper.c:36: TINFO: ksm daemon takes 1s to run two full scans mem.c:266: TINFO: check! mem.c:257: TPASS: run is 1. mem.c:257: TPASS: pages_shared is 3. mem.c:257: TPASS: pages_sharing is 6141. mem.c:257: TPASS: pages_volatile is 0. mem.c:257: TPASS: pages_unshared is 0. mem.c:257: TPASS: sleep_millisecs is 0. mem.c:257: TPASS: pages_to_scan is 6144. mem.c:436: TINFO: resume all children. mem.c:424: TINFO: wait for all children to stop. mem.c:315: TINFO: child 1 verifies memory content. mem.c:315: TINFO: child 2 verifies memory content. mem.c:315: TINFO: child 0 verifies memory content. mem.c:346: TINFO: child 0 continues... mem.c:349: TINFO: child 0 allocates 128 MB filled with 'd' mem.c:346: TINFO: child 1 continues... mem.c:349: TINFO: child 1 allocates 128 MB filled with 'd' mem.c:346: TINFO: child 2 continues... mem.c:349: TINFO: child 2 allocates 128 MB filled with 'd' mem.c:402: TINFO: child 1 stops. mem.c:402: TINFO: child 0 stops. mem.c:402: TINFO: child 2 stops. ksm_helper.c:36: TINFO: ksm daemon takes 1s to run two full scans mem.c:266: TINFO: check! mem.c:257: TPASS: run is 1. mem.c:257: TPASS: pages_shared is 1. mem.c:257: TPASS: pages_sharing is 6143. mem.c:257: TPASS: pages_volatile is 0. mem.c:257: TPASS: pages_unshared is 0. mem.c:257: TPASS: sleep_millisecs is 0. mem.c:257: TPASS: pages_to_scan is 6144. mem.c:436: TINFO: resume all children. mem.c:424: TINFO: wait for all children to stop. mem.c:315: TINFO: child 0 verifies memory content. mem.c:315: TINFO: child 1 verifies memory content. mem.c:315: TINFO: child 2 verifies memory content. mem.c:346: TINFO: child 0 continues... mem.c:349: TINFO: child 0 allocates 128 MB filled with 'd' mem.c:346: TINFO: child 2 continues... mem.c:349: TINFO: child 2 allocates 128 MB filled with 'd' mem.c:346: TINFO: child 1 continues... mem.c:353: TINFO: child 1 allocates 128 MB filled with 'd' except one page with 'e' [ 257.654082] SError Interrupt on CPU3, code 0x00000000be000000 -- SError [ 257.654122] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.654181] Hardware name: FVP Base RevC (DT) [ 257.654205] pstate: 80000000 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--) [ 257.654276] pc : 000000000041f758 [ 257.654298] lr : 000000000041f8c0 [ 257.654319] sp : 0000ffffc9e14cb0 [ 257.654341] x29: 0000ffffc9e14cc0 x28: 0000000008000000 x27: 00000000004296c0 [ 257.654437] x26: 00000000194fa4b0 x25: 0000000000000064 x24: 0000000008000000 [ 257.654530] x23: 0000000008000000 x22: 0000000000429550 x21: 0000000000000000 [ 257.654626] x20: 0000ffffc9e14de8 x19: 0000000000000001 x18: 0000000000000000 [ 257.654719] x17: 0000ffff93c6a290 x16: 0000000000441340 x15: 0000000000008000 [ 257.654815] x14: 0000000000040000 x13: 2e746e65746e6f63 x12: 0000ffff93cd7160 [ 257.654913] x11: 0000ffffc9e146b0 x10: 00000000ffffffd8 x9 : 00000000ffffff80 [ 257.655009] x8 : 0000000000000040 x7 : 00000000ffffffff x6 : 0000000000000000 [ 257.655100] x5 : 0000000000000063 x4 : 0000000000000020 x3 : 0000ffff93dbed60 [ 257.655191] x2 : 0000000000000000 x1 : 0000ffff8bb90000 x0 : 00000000068af001 [ 257.655293] Kernel panic - not syncing: Asynchronous SError Interrupt [ 257.655319] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.655379] Hardware name: FVP Base RevC (DT) [ 257.655403] Call trace: [ 257.655419] dump_backtrace+0xe4/0x140 [ 257.655475] show_stack+0x20/0x30 [ 257.655528] dump_stack_lvl+0x88/0xb4 [ 257.655598] dump_stack+0x18/0x34 [ 257.655667] panic+0x1a0/0x37c [ 257.655729] add_taint+0x0/0xc0 [ 257.655787] arm64_serror_panic+0x78/0x84 [ 257.655853] do_serror+0x0/0x60 [ 257.655911] do_serror+0x3c/0x60 [ 257.655970] __el0_error_handler_common+0x48/0xc0 [ 257.656050] el0t_64_error_handler+0x10/0x20 [ 257.656131] el0t_64_error+0x18c/0x190 [ 257.656191] SMP: stopping secondary CPUs [ 257.656326] Kernel Offset: 0x57c5cb540000 from 0xffff800008000000 [ 257.656361] PHYS_OFFSET: 0x80000000 [ 257.656383] CPU features: 0x00000,000a1cff,e69e772f [ 257.656414] Memory Limit: none [ 257.945661] ---[ end Kernel panic - not syncing: Asynchronous SError Interrupt ]--- [ 257.945856] ------------[ cut here ]------------ [ 257.945873] WARNING: CPU: 3 PID: 685 at kernel/sched/core.c:3113 set_task_cpu+0x170/0x254 [ 257.945960] Modules linked in: pl111_drm drm_dma_helper crct10dif_ce arm_spe_pmu drm_kms_helper panel_simple cfg80211 rfkill fuse drm [ 257.946182] CPU: 3 PID: 685 Comm: ksm03 Not tainted 6.1.5-rc1 #1 [ 257.946243] Hardware name: FVP Base RevC (DT) [ 257.946267] pstate: 424020c9 (nZcv daIF +PAN -UAO +TCO -DIT -SSBS BTYPE=--) [ 257.946338] pc : set_task_cpu+0x170/0x254 [ 257.946393] lr : try_to_wake_up+0x1a0/0x63c [ 257.946451] sp : ffff80000806fbe0 [ 257.946474] x29: ffff80000806fbe0 x28: ffff00087f7c5680 x27: 0000000000000000 [ 257.946572] x26: 0000000000000000 x25: ffffd7c5d609d410 x24: 0000000000000005 [ 257.946666] x23: ffff000805633d04 x22: 0000000000000005 x21: ffffd7c5d6098a78 [ 257.946762] x20: 0000000000000005 x19: ffff0008056334c0 x18: 0000000000000006 [ 257.946858] x17: 75727265746e4920 x16: 726f727245532073 x15: 756f6e6f7268636e [ 257.946960] x14: 797341203a676e69 x13: 2d2d2d5d20747075 x12: 727265746e492072 [ 257.947061] x11: 6f72724553207375 x10: ffffd7c5d6114d18 x9 : ffffd7c5d3617154 [ 257.947161] x8 : ffffd7c5d574b000 x7 : ffff2842aa100000 x6 : 0000000000000003 [ 257.947257] x5 : ffffd7c5d609d000 x4 : 0000000000000005 x3 : 00000000000000ff [ 257.947350] x2 : 0000000000000000 x1 : 0000000000000005 x0 : 0000000000000000 [ 257.947440] Call trace: [ 257.947452] set_task_cpu+0x170/0x254 [ 257.947514] try_to_wake_up+0x1a0/0x63c [ 257.947575] default_wake_function+0x24/0x50 [ 257.947639] autoremove_wake_function+0x20/0x50 [ 257.947734] __wake_up_common+0x90/0x190 [ 257.947815] __wake_up_common_lock+0x80/0xd0 [ 257.947903] __wake_up+0x20/0x30 [ 257.947981] wake_up_klogd_work_func+0xac/0xc0 [ 257.948059] irq_work_single+0x7c/0xbc [ 257.948139] irq_work_run_list+0x4c/0x70 [ 257.948221] irq_work_tick+0x28/0x6c [ 257.948299] update_process_times+0xa4/0xc0 [ 257.948394] tick_sched_handle+0x3c/0x60 [ 257.948465] tick_sched_timer+0x54/0xac [ 257.948535] __hrtimer_run_queues+0x2e4/0x380 [ 257.948632] hrtimer_interrupt+0xf0/0x250 [ 257.948729] arch_timer_handler_phys+0x34/0x50 [ 257.948807] handle_percpu_devid_irq+0x90/0x230 [ 257.948873] generic_handle_domain_irq+0x34/0x50 [ 257.948962] gic_handle_irq+0x58/0x140 [ 257.949015] call_on_irq_stack+0x2c/0x54 [ 257.949088] do_interrupt_handler+0x88/0x94 [ 257.949172] el1_interrupt+0x34/0x70 [ 257.949245] el1h_64_irq_handler+0x18/0x2c [ 257.949324] el1h_64_irq+0x64/0x68 [ 257.949380] panic+0x324/0x37c [ 257.949444] add_taint+0x0/0xc0 [ 257.949505] arm64_serror_panic+0x78/0x84 [ 257.949566] do_serror+0x0/0x60 [ 257.949625] do_serror+0x3c/0x60 [ 257.949684] __el0_error_handler_common+0x48/0xc0 [ 257.949764] el0t_64_error_handler+0x10/0x20 [ 257.949845] el0t_64_error+0x18c/0x190 [ 257.949904] ---[ end trace 0000000000000000 ]---
[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd0f0] [ 0.000000] Linux version 6.0.19-rc1 (tuxmake@tuxmake) (aarch64-linux-gnu-gcc (Debian 12.2.0-9) 12.2.0, GNU ld (GNU Binutils for Debian) 2.39) #1 SMP PREEMPT @1673381547 [ 0.000000] Machine model: FVP Base RevC [ 0.000000] earlycon: pl11 at MMIO 0x000000001c090000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: EFI v2.70 by EDK II [ 0.000000] efi: ACPI 2.0=0xf5e30018 MEMATTR=0xfadaf018 MEMRESERVE=0xf5f8bf18 [ 0.000000] Reserved memory: created DMA memory pool at 0x0000000018000000, size 8 MiB [ 0.000000] OF: reserved mem: initialized node vram@18000000, compatible id shared-dma-pool [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000080000000-0x00000008ffffffff] [ 0.000000] NUMA: NODE_DATA [mem 0x8fff22200-0x8fff24abf] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000080000000-0x00000000ffffffff] [ 0.000000] DMA32 empty [ 0.000000] Normal [mem 0x0000000100000000-0x00000008ffffffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000080000000-0x00000000f59effff] [ 0.000000] node 0: [mem 0x00000000f59f0000-0x00000000f5a5ffff] [ 0.000000] node 0: [mem 0x00000000f5a60000-0x00000000f5b4ffff] [ 0.000000] node 0: [mem 0x00000000f5b50000-0x00000000f5e2ffff] [ 0.000000] node 0: [mem 0x00000000f5e30000-0x00000000f5e3ffff] [ 0.000000] node 0: [mem 0x00000000f5e40000-0x00000000f5f7ffff] [ 0.000000] node 0: [mem 0x00000000f5f80000-0x00000000faf4ffff] [ 0.000000] node 0: [mem 0x00000000faf50000-0x00000000faf8ffff] [ 0.000000] node 0: [mem 0x00000000faf90000-0x00000000faf9ffff] [ 0.000000] node 0: [mem 0x00000000fafa0000-0x00000000fafeffff] [ 0.000000] node 0: [mem 0x00000000faff0000-0x00000000feffffff] [ 0.000000] node 0: [mem 0x0000000880000000-0x00000008ffffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x00000008ffffffff] [ 0.000000] On node 0, zone Normal: 256 pages in unavailable ranges [ 0.000000] cma: Reserved 512 MiB at 0x00000000c0000000 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.1 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: MIGRATE_INFO_TYPE not supported. [ 0.000000] psci: SMC Calling Convention v1.2 [ 0.000000] percpu: Embedded 10 pages/cpu s574312 r8192 d72856 u655360 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: detected: Address authentication (IMP DEF algorithm) [ 0.000000] CPU features: detected: GIC system register CPU interface [ 0.000000] CPU features: detected: Virtualization Host Extensions [ 0.000000] CPU features: detected: Hardware dirty bit management [ 0.000000] CPU features: detected: Memory Tagging Extension [ 0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault [ 0.000000] CPU features: detected: Spectre-BHB [ 0.000000] alternatives: patching kernel code [ 0.000000] Fallback order for Node 0: 0 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 65216 [ 0.000000] Policy zone: Normal [ 0.000000] Kernel command line: Image dtb=fvp-base-revc.dtb console=ttyAMA0 earlycon=pl011,0x1c090000 root=/dev/vda ip=dhcp [ 0.000000] Unknown kernel command line parameters \"Image dtb=fvp-base-revc.dtb\", will be passed to user space. [ 0.000000] Dentry cache hash table entries: 524288 (order: 6, 4194304 bytes, linear) [ 0.000000] Inode-cache hash table entries: 262144 (order: 5, 2097152 bytes, linear) [ 0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off [ 0.000000] software IO TLB: area num 8. [ 0.000000] software IO TLB: mapped [mem 0x00000000fb000000-0x00000000ff000000] (64MB) [ 0.000000] Memory: 3481728K/4177920K available (19968K kernel code, 5270K rwdata, 11456K rodata, 12032K init, 1603K bss, 171904K reserved, 524288K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1 [ 0.000000] ftrace: allocating 65338 entries in 16 pages [ 0.000000] ftrace: allocated 16 pages with 1 groups [ 0.000000] trace event string verifier disabled [ 0.000000] rcu: Preemptible hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=8. [ 0.000000] Trampoline variant of Tasks RCU enabled. [ 0.000000] Rude variant of Tasks RCU enabled. [ 0.000000] Tracing variant of Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv3: GIC: Using split EOI/Deactivate mode [ 0.000000] GICv3: 224 SPIs implemented [ 0.000000] GICv3: 0 Extended SPIs implemented [ 0.000000] Root IRQ handler: gic_handle_irq [ 0.000000] GICv3: GICv3 features: 16 PPIs [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x000000002f100000 [ 0.000000] ITS [mem 0x2f020000-0x2f03ffff] [ 0.000000] ITS@0x000000002f020000: allocated 8192 Devices @880370000 (indirect, esz 8, psz 64K, shr 1) [ 0.000000] ITS@0x000000002f020000: allocated 8192 Virtual CPUs @880380000 (indirect, esz 8, psz 64K, shr 1) [ 0.000000] ITS@0x000000002f020000: allocated 8192 Interrupt Collections @880390000 (flat, esz 8, psz 64K, shr 1) [ 0.000000] GICv3: using LPI property table @0x00000008803a0000 [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000008803c0000 [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. [ 0.000000] kfence: initialized - using 33554432 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) [ 0.000000] timer_sp804: timer clock not found: -517 [ 0.000000] timer_sp804: arm,sp804 clock not found: -2 [ 0.000000] Failed to initialize '/bus@8000000/motherboard-bus@8000000/iofpga-bus@300000000/timer@110000': -22 [ 0.000000] timer_sp804: timer clock not found: -517 [ 0.000000] timer_sp804: arm,sp804 clock not found: -2 [ 0.000000] Failed to initialize '/bus@8000000/motherboard-bus@8000000/iofpga-bus@300000000/timer@120000': -22 [ 0.000000] arch_timer: cp15 timer(s) running at 100.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x171024e7e0, max_idle_ns: 440795205315 ns [ 0.000002] sched_clock: 57 bits at 100MHz, resolution 10ns, wraps every 4398046511100ns [ 0.000929] random: crng init done [ 0.002127] Console: colour dummy device 80x25 [ 0.003034] Calibrating delay loop (skipped), value calculated using timer frequency.. 200.00 BogoMIPS (lpj=400000) [ 0.003280] pid_max: default: 32768 minimum: 301 [ 0.004169] LSM: Security Framework initializing [ 0.004883] Mount-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.005078] Mountpoint-cache hash table entries: 8192 (order: 0, 65536 bytes, linear) [ 0.013307] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 0.027394] cblist_init_generic: Setting adjustable number of callback queues. [ 0.027512] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.028798] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.030051] cblist_init_generic: Setting shift to 3 and lim to 1. [ 0.032657] rcu: Hierarchical SRCU implementation. [ 0.032816] rcu: Max phase no-delay instances is 1000. [ 0.044270] Platform MSI: msi-controller@2f020000 domain created [ 0.045228] PCI/MSI: /interrupt-controller@2f000000/msi-controller@2f020000 domain created [ 0.046342] fsl-mc MSI: msi-controller@2f020000 domain created [ 0.053632] Remapping and enabling EFI services. [ 0.059729] smp: Bringing up secondary CPUs ... [ 0.066301] Detected PIPT I-cache on CPU1 [ 0.066615] cacheinfo: Unable to detect cache hierarchy for CPU 1 [ 0.066655] GICv3: CPU1: found redistributor 100 region 0:0x000000002f120000 [ 0.066710] GICv3: CPU1: using allocated LPI pending table @0x00000008803d0000 [ 0.066820] CPU1: Booted secondary processor 0x0000000100 [0x410fd0f0] [ 0.075041] Detected PIPT I-cache on CPU2 [ 0.075374] cacheinfo: Unable to detect cache hierarchy for CPU 2 [ 0.075416] GICv3: CPU2: found redistributor 200 region 0:0x000000002f140000 [ 0.075474] GICv3: CPU2: using allocated LPI pending table @0x00000008803e0000 [ 0.075580] CPU2: Booted secondary processor 0x0000000200 [0x410fd0f0] [ 0.083698] Detected PIPT I-cache on CPU3 [ 0.084049] cacheinfo: Unable to detect cache hierarchy for CPU 3 [ 0.084093] GICv3: CPU3: found redistributor 300 region 0:0x000000002f160000 [ 0.084152] GICv3: CPU3: using allocated LPI pending table @0x00000008803f0000 [ 0.084258] CPU3: Booted secondary processor 0x0000000300 [0x410fd0f0] [ 0.092605] Detected PIPT I-cache on CPU4 [ 0.092975] cacheinfo: Unable to detect cache hierarchy for CPU 4 [ 0.093021] GICv3: CPU4: found redistributor 10000 region 0:0x000000002f180000 [ 0.093081] GICv3: CPU4: using allocated LPI pending table @0x0000000880400000 [ 0.093188] CPU4: Booted secondary processor 0x0000010000 [0x410fd0f0] [ 0.101490] Detected PIPT I-cache on CPU5 [ 0.101860] cacheinfo: Unable to detect cache hierarchy for CPU 5 [ 0.101927] GICv3: CPU5: found redistributor 10100 region 0:0x000000002f1a0000 [ 0.101987] GICv3: CPU5: using allocated LPI pending table @0x0000000880410000 [ 0.102095] CPU5: Booted secondary processor 0x0000010100 [0x410fd0f0] [ 0.110225] Detected PIPT I-cache on CPU6 [ 0.110619] cacheinfo: Unable to detect cache hierarchy for CPU 6 [ 0.110682] GICv3: CPU6: found redistributor 10200 region 0:0x000000002f1c0000 [ 0.110743] GICv3: CPU6: using allocated LPI pending table @0x0000000880420000 [ 0.110850] CPU6: Booted secondary processor 0x0000010200 [0x410fd0f0] [ 0.119176] Detected PIPT I-cache on CPU7 [ 0.119603] cacheinfo: Unable to detect cache hierarchy for CPU 7 [ 0.119654] GICv3: CPU7: found redistributor 10300 region 0:0x000000002f1e0000 [ 0.119715] GICv3: CPU7: using allocated LPI pending table @0x0000000880430000 [ 0.119823] CPU7: Booted secondary processor 0x0000010300 [0x410fd0f0] [ 0.121520] smp: Brought up 1 node, 8 CPUs [ 0.124437] SMP: Total of 8 processors activated. [ 0.124571] CPU features: detected: Branch Target Identification [ 0.124713] CPU features: detected: 32-bit EL0 Support [ 0.124846] CPU features: detected: ARMv8.4 Translation Table Level [ 0.125513] CPU features: detected: Data cache clean to the PoU not required for I/D coherence [ 0.125671] CPU features: detected: Common not Private translations [ 0.125815] CPU features: detected: CRC32 instructions [ 0.125951] CPU features: detected: E0PD [ 0.126079] CPU features: detected: Enhanced Counter Virtualization [ 0.126223] CPU features: detected: Enhanced Privileged Access Never [ 0.126373] CPU features: detected: Generic authentication (IMP DEF algorithm) [ 0.126525] CPU features: detected: RCpc load-acquire (LDAPR) [ 0.126665] CPU features: detected: LSE atomic instructions [ 0.126804] CPU features: detected: Privileged Access Never [ 0.126944] CPU features: detected: RAS Extension Support [ 0.127081] CPU features: detected: Random Number Generator [ 0.127220] CPU features: detected: Speculation barrier (SB) [ 0.127359] CPU features: detected: Stage-2 Force Write-Back [ 0.127499] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality [ 0.127651] CPU features: detected: TLB range maintenance instructions [ 0.127795] CPU features: detected: WFx with timeout [ 0.127930] CPU features: detected: Scalable Matrix Extension [ 0.128069] CPU features: detected: Scalable Vector Extension [ 0.440805] CPU features: detected CPU5: Activity Monitors Unit (AMU) [ 0.440896] CPU features: detected CPU1: Activity Monitors Unit (AMU) [ 0.440897] CPU features: detected CPU3: Activity Monitors Unit (AMU) [ 0.440897] CPU features: detected CPU2: Activity Monitors Unit (AMU) [ 0.440896] CPU features: detected CPU6: Activity Monitors Unit (AMU) [ 0.440896] CPU features: detected CPU7: Activity Monitors Unit (AMU) [ 0.440896] CPU features: detected CPU0: Activity Monitors Unit (AMU) [ 0.440897] CPU features: detected CPU4: Activity Monitors Unit (AMU) [ 0.441653] SVE: maximum available vector length 64 bytes per vector [ 0.441799] SVE: default vector length 64 bytes per vector [ 0.442012] SME: minimum available vector length 16 bytes per vector [ 0.442153] SME: maximum available vector length 64 bytes per vector [ 0.442295] SME: default vector length 32 bytes per vector [ 0.459258] CPU: All CPU(s) started at EL2 [ 0.485269] devtmpfs: initialized [ 0.509174] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.509456] futex hash table entries: 2048 (order: 1, 131072 bytes, linear) [ 0.516993] pinctrl core: initialized pinctrl subsystem [ 0.531919] DMI not present or invalid. [ 0.537269] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.779534] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations [ 0.782122] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.783587] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.784226] audit: initializing netlink subsys (disabled) [ 0.786230] audit: type=2000 audit(0.768:1): state=initialized audit_enabled=0 res=1 [ 0.793842] thermal_sys: Registered thermal governor 'step_wise' [ 0.793922] thermal_sys: Registered thermal governor 'power_allocator' [ 0.794818] cpuidle: using governor menu [ 0.796655] hw-breakpoint: found 16 breakpoint and 16 watchpoint registers. [ 0.798735] ASID allocator initialised with 65536 entries [ 0.816074] Serial: AMBA PL011 UART driver [ 1.014825] 1c090000.serial: ttyAMA0 at MMIO 0x1c090000 (irq = 16, base_baud = 0) is a PL011 rev2 [ 1.015130] printk: console [ttyAMA0] enabled [ 1.015130] printk: console [ttyAMA0] enabled [ 1.015321] printk: bootconsole [pl11] disabled [ 1.015321] printk: bootconsole [pl11] disabled [ 1.029537] 1c0a0000.serial: ttyAMA1 at MMIO 0x1c0a0000 (irq = 17, base_baud = 0) is a PL011 rev2 [ 1.043610] 1c0b0000.serial: ttyAMA2 at MMIO 0x1c0b0000 (irq = 18, base_baud = 0) is a PL011 rev2 [ 1.057699] 1c0c0000.serial: ttyAMA3 at MMIO 0x1c0c0000 (irq = 19, base_baud = 0) is a PL011 rev2 [ 1.190512] platform panel: Fixing up cyclic dependency with 1c1f0000.clcd [ 1.215279] KASLR enabled [ 1.329062] HugeTLB: registered 16.0 GiB page size, pre-allocated 0 pages [ 1.329223] HugeTLB: 16320 KiB vmemmap can be freed for a 16.0 GiB page [ 1.329392] HugeTLB: registered 512 MiB page size, pre-allocated 0 pages [ 1.329552] HugeTLB: 448 KiB vmemmap can be freed for a 512 MiB page [ 1.329724] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages [ 1.329884] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page [ 1.341421] cryptd: max_cpu_qlen set to 1000 [ 1.356706] ACPI: Interpreter disabled. [ 1.393624] iommu: Default domain type: Translated [ 1.393770] iommu: DMA domain TLB invalidation policy: strict mode [ 1.396310] SCSI subsystem initialized [ 1.400110] usbcore: registered new interface driver usbfs [ 1.400570] usbcore: registered new interface driver hub [ 1.401351] usbcore: registered new device driver usb [ 1.415618] mc: Linux media interface: v0.10 [ 1.415909] videodev: Linux video capture interface: v2.00 [ 1.416294] pps_core: LinuxPPS API ver. 1 registered [ 1.416437] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx> [ 1.416674] PTP clock support registered [ 1.418358] EDAC MC: Ver: 3.0.0 [ 1.429874] Registered efivars operations [ 1.444761] FPGA manager framework [ 1.445514] Advanced Linux Sound Architecture Driver Initialized. [ 1.451903] vgaarb: loaded [ 1.454887] clocksource: Switched to clocksource arch_sys_counter [ 1.461184] VFS: Disk quotas dquot_6.6.0 [ 1.462018] VFS: Dquot-cache hash table entries: 8192 (order 0, 65536 bytes) [ 1.464734] pnp: PnP ACPI: disabled [ 1.532589] NET: Registered PF_INET protocol family [ 1.533741] IP idents hash table entries: 65536 (order: 3, 524288 bytes, linear) [ 1.588517] tcp_listen_portaddr_hash hash table entries: 4096 (order: 0, 65536 bytes, linear) [ 1.589273] Table-perturb hash table entries: 65536 (order: 2, 262144 bytes, linear) [ 1.589498] TCP established hash table entries: 32768 (order: 2, 262144 bytes, linear) [ 1.592398] TCP bind hash table entries: 32768 (order: 3, 524288 bytes, linear) [ 1.596237] TCP: Hash tables configured (established 32768 bind 32768) [ 1.597977] MPTCP token hash table entries: 4096 (order: 0, 98304 bytes, linear) [ 1.598967] UDP hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 1.599717] UDP-Lite hash table entries: 2048 (order: 0, 65536 bytes, linear) [ 1.601621] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 1.605152] RPC: Registered named UNIX socket transport module. [ 1.605308] RPC: Registered udp transport module. [ 1.605455] RPC: Registered tcp transport module. [ 1.605590] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.605806] PCI: CLS 0 bytes, default 64 [ 1.620933] hw perfevents: enabled with armv8_pmuv3 PMU driver, 9 counters available [ 1.622844] kvm [1]: IPA Size Limit: 48 bits [ 1.623156] [Firmware Bug]: CPU interface incapable of MMIO access [ 1.623303] kvm [1]: disabling GICv2 emulation [ 1.623664] kvm [1]: GIC system register CPU interface enabled [ 1.625905] kvm [1]: vgic interrupt IRQ9 [ 1.628612] kvm [1]: VHE mode initialized successfully [ 1.644626] Initialise system trusted keyrings [ 1.646150] workingset: timestamp_bits=42 max_order=16 bucket_order=0 [ 1.717887] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 1.723534] NFS: Registering the id_resolver key type [ 1.723841] Key type id_resolver registered [ 1.723979] Key type id_legacy registered [ 1.724718] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 1.724884] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering... [ 1.726039] 9p: Installing v9fs 9p2000 file system support [ 2.092690] NET: Registered PF_ALG protocol family [ 2.092849] Key type asymmetric registered [ 2.092988] Asymmetric key parser 'x509' registered [ 2.093517] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) [ 2.093684] io scheduler mq-deadline registered [ 2.093841] io scheduler kyber registered [ 2.300272] pci-host-generic 40000000.pci: host bridge /pci@40000000 ranges: [ 2.300896] pci-host-generic 40000000.pci: MEM 0x0050000000..0x005fffffff -> 0x0050000000 [ 2.301902] pci-host-generic 40000000.pci: ECAM at [mem 0x40000000-0x4fffffff] for [bus 00-01] [ 2.303113] pci-host-generic 40000000.pci: PCI host bridge to bus 0000:00 [ 2.303290] pci_bus 0000:00: root bus resource [bus 00-01] [ 2.303485] pci_bus 0000:00: root bus resource [mem 0x50000000-0x5fffffff] [ 2.304085] pci 0000:00:00.0: [1af4:1001] type 00 class 0x018000 [ 2.304558] pci 0000:00:00.0: reg 0x10: [mem 0x5000f000-0x5000ffff] [ 2.305006] pci 0000:00:00.0: reg 0x18: [mem 0x5000e000-0x5000efff] [ 2.305453] pci 0000:00:00.0: reg 0x20: [mem 0x5000d000-0x5000dfff] [ 2.306001] pci 0000:00:00.0: enabling Extended Tags [ 2.307530] pci 0000:00:00.0: PME# supported from D3hot [ 2.310123] pci 0000:00:02.0: [1af4:1001] type 00 class 0x018000 [ 2.310597] pci 0000:00:02.0: reg 0x10: [mem 0x5000c000-0x5000cfff] [ 2.311100] pci 0000:00:02.0: reg 0x18: [mem 0x5000b000-0x5000bfff] [ 2.311548] pci 0000:00:02.0: reg 0x20: [mem 0x5000a000-0x5000afff] [ 2.312096] pci 0000:00:02.0: enabling Extended Tags [ 2.313562] pci 0000:00:02.0: PME# supported from D3hot [ 2.315967] pci 0000:00:03.0: [0abc:aced] type 00 class 0x010601 [ 2.316441] pci 0000:00:03.0: reg 0x10: [mem 0x50006000-0x50007fff] [ 2.316762] pci 0000:00:03.0: reg 0x14: [mem 0x50004000-0x50005fff] [ 2.317084] pci 0000:00:03.0: reg 0x18: [mem 0x50009000-0x50009fff] [ 2.317406] pci 0000:00:03.0: reg 0x1c: [mem 0x50002000-0x50003fff] [ 2.317727] pci 0000:00:03.0: reg 0x20: [mem 0x50008000-0x50008fff] [ 2.318049] pci 0000:00:03.0: reg 0x24: [mem 0x50000000-0x50001fff] [ 2.319308] pci 0000:00:03.0: PME# supported from D3hot [ 2.326561] pci 0000:00:03.0: BAR 0: assigned [mem 0x50000000-0x50001fff] [ 2.326881] pci 0000:00:03.0: BAR 1: assigned [mem 0x50002000-0x50003fff] [ 2.327146] pci 0000:00:03.0: BAR 3: assigned [mem 0x50004000-0x50005fff] [ 2.327411] pci 0000:00:03.0: BAR 5: assigned [mem 0x50006000-0x50007fff] [ 2.327676] pci 0000:00:00.0: BAR 0: assigned [mem 0x50008000-0x50008fff] [ 2.327941] pci 0000:00:00.0: BAR 2: assigned [mem 0x50009000-0x50009fff] [ 2.328199] pci 0000:00:00.0: BAR 4: assigned [mem 0x5000a000-0x5000afff] [ 2.328473] pci 0000:00:02.0: BAR 0: assigned [mem 0x5000b000-0x5000bfff] [ 2.328731] pci 0000:00:02.0: BAR 2: assigned [mem 0x5000c000-0x5000cfff] [ 2.329005] pci 0000:00:02.0: BAR 4: assigned [mem 0x5000d000-0x5000dfff] [ 2.329272] pci 0000:00:03.0: BAR 2: assigned [mem 0x5000e000-0x5000efff] [ 2.329539] pci 0000:00:03.0: BAR 4: assigned [mem 0x5000f000-0x5000ffff] [ 2.361084] EINJ: ACPI disabled. [ 2.682878] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.724716] SuperH (H)SCI(F) driver initialized [ 2.731743] msm_serial: driver initialized [ 2.756131] arm-smmu-v3 2b400000.iommu: command queue size <= 64 entries not supported [ 2.763529] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 2.840207] loop: module loaded [ 2.841065] virtio_blk virtio0: 1/0/0 default/read/poll queues [ 2.848449] virtio_blk virtio0: [vda] 3351968 512-byte logical blocks (1.72 GB/1.60 GiB) [ 2.873034] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 2.882920] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 2.892670] basic-mmio-gpio: Failed to locate of_node [id: -2] [ 3.119149] megasas: 07.719.03.00-rc1 [ 3.145571] physmap-flash 8000000.flash: physmap platform flash device: [mem 0x08000000-0x0bffffff] [ 3.145824] 8000000.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000089 Chip ID 0x000018 [ 3.146052] Intel/Sharp Extended Query Table at 0x0031 [ 3.146219] Intel/Sharp Extended Query Table at 0x0031 [ 3.146385] Using buffer write method [ 3.147090] physmap-flash 8000000.flash: physmap platform flash device: [mem 0x0c000000-0x0fffffff] [ 3.147324] 8000000.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000089 Chip ID 0x000018 [ 3.147552] Intel/Sharp Extended Query Table at 0x0031 [ 3.147719] Intel/Sharp Extended Query Table at 0x0031 [ 3.147886] Using buffer write method [ 3.148127] Concatenating MTD devices: [ 3.148256] (0): \"8000000.flash\" [ 3.148393] (1): \"8000000.flash\" [ 3.148530] into device \"8000000.flash\" [ 3.288683] virtio_net: probe of virtio2 failed with error -2 [ 3.303553] thunder_xcv, ver 1.0 [ 3.304083] thunder_bgx, ver 1.0 [ 3.304614] nicpf, ver 1.0 [ 3.328892] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version [ 3.329058] hns3: Copyright (c) 2017 Huawei Corporation. [ 3.329734] hclge is initializing [ 3.329922] e1000: Intel(R) PRO/1000 Network Driver [ 3.330068] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 3.330661] e1000e: Intel(R) PRO/1000 Network Driver [ 3.331113] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 3.331720] igb: Intel(R) Gigabit Ethernet Network Driver [ 3.331868] igb: Copyright (c) 2007-2014 Intel Corporation. [ 3.332395] igbvf: Intel(R) Gigabit Virtual Function Network Driver [ 3.332548] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 3.339140] sky2: driver version 1.30 [ 3.339678] QLogic FastLinQ 4xxxx Core Module qed [ 3.339831] qede init: QLogic FastLinQ 4xxxx Ethernet Driver qede [ 3.349919] smc91x 1a000000.ethernet (unnamed net_device) (uninitialized): smc91x: IOADDR 00000000bd814b1b doesn't match configuration (300). [ 3.350207] smc91x.c: v1.1, sep 22 2004 by Nicolas Pitre <nico@xxxxxxxxxxx> [ 3.369490] smc91x 1a000000.ethernet eth0: SMC91C11xFD (rev 1) at 00000000bd814b1b IRQ 26 [ 3.369698] [ 3.369829] smc91x 1a000000.ethernet eth0: Ethernet addr: 00:02:f7:ef:59:6c [ 3.386244] usbcore: registered new interface driver asix [ 3.386654] usbcore: registered new interface driver ax88179_178a [ 3.388119] VFIO - User Level meta-driver version: 0.3 [ 3.422551] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 3.422849] ehci-pci: EHCI PCI platform driver [ 3.423361] ehci-platform: EHCI generic platform driver [ 3.425555] ehci-orion: EHCI orion driver [ 3.427673] ehci-exynos: EHCI Exynos driver [ 3.429683] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 3.429929] ohci-pci: OHCI PCI platform driver [ 3.430440] ohci-platform: OHCI generic platform driver [ 3.432620] ohci-exynos: OHCI Exynos driver [ 3.441874] usbcore: registered new interface driver usb-storage [ 3.506001] rtc-efi rtc-efi.0: registered as rtc0 [ 3.506881] rtc-efi rtc-efi.0: setting system clock to 2023-01-10T23:11:18 UTC (1673392278) [ 3.523039] rtc-pl031 1c170000.rtc: registered as rtc1 [ 3.534535] i2c_dev: i2c /dev entries driver [ 3.625165] sp805-wdt 1c0f0000.watchdog: registration successful [ 3.696937] mmci-pl18x 1c050000.mmc: Got CD GPIO [ 3.697418] mmci-pl18x 1c050000.mmc: Got WP GPIO [ 3.702896] mmci-pl18x 1c050000.mmc: mmc0: PL180 manf 41 rev0 at 0x1c050000 irq 31,32 (pio) [ 3.731704] sdhci: Secure Digital Host Controller Interface driver [ 3.731850] sdhci: Copyright(c) Pierre Ossman [ 3.744754] Synopsys Designware Multimedia Card Interface Driver [ 3.764159] sdhci-pltfm: SDHCI platform and OF driver helper [ 3.801067] input: AT Raw Set 2 keyboard as /devices/platform/bus@8000000/bus@8000000:motherboard-bus@8000000/bus@8000000:motherboard-bus@8000000:iofpga-bus@300000000/1c060000.kmi/serio0/input/input0 [ 3.804112] ledtrig-cpu: registered to indicate activity on CPUs [ 3.835023] pstore: Registered efi as persistent store backend [ 3.840904] SMCCC: SOC_ID: ID = jep106:043b:0000 Revision = 0x00000002 [ 3.886235] usbcore: registered new interface driver usbhid [ 3.886386] usbhid: USB HID core driver [ 3.948058] cs_system_cfg: CoreSight Configuration manager initialised [ 4.026678] NET: Registered PF_INET6 protocol family [ 4.037478] Segment Routing with IPv6 [ 4.037787] In-situ OAM (IOAM) with IPv6 [ 4.038368] NET: Registered PF_PACKET protocol family [ 4.039817] 9pnet: Installing 9P2000 support [ 4.046909] Key type dns_resolver registered [ 4.060910] registered taskstats version 1 [ 4.061168] Loading compiled-in X.509 certificates [ 4.063705] pstore: Using crash dump compression: deflate [ 6.067319] input: PS/2 Generic Mouse as /devices/platform/bus@8000000/bus@8000000:motherboard-bus@8000000/bus@8000000:motherboard-bus@8000000:iofpga-bus@300000000/1c070000.kmi/serio1/input/input2 [ 6.133361] smc91x 1a000000.ethernet eth0: link up, 10Mbps, half-duplex, lpa 0x0000 [ 6.158998] Sending DHCP requests ., OK [ 6.175623] IP-Config: Got DHCP answer from 172.20.51.254, my address is 172.20.51.1 [ 6.175815] IP-Config: Complete: [ 6.175937] device=eth0, hwaddr=00:02:f7:ef:59:6c, ipaddr=172.20.51.1, mask=255.255.255.0, gw=172.20.51.254 [ 6.176161] host=172.20.51.1, domain=, nis-domain=(none) [ 6.176317] bootserver=172.20.51.254, rootserver=172.20.51.254, rootpath= [ 6.176420] nameserver0=172.20.51.254, nameserver1=172.20.51.252 [ 11.380869] ALSA device list: [ 11.381010] No soundcards found. [ 11.382484] uart-pl011 1c090000.serial: no DMA platform data [ 11.404413] EXT4-fs (vda): mounted filesystem with ordered data mode. Quota mode: none. [ 11.404820] VFS: Mounted root (ext4 filesystem) readonly on device 254:0. [ 11.406031] devtmpfs: mounted [ 11.536992] Freeing unused kernel memory: 12032K [ 11.537600] Run /sbin/init as init process [ 11.803115] systemd[1]: systemd 250.5+ running in system mode (-PAM -AUDIT -SELINUX -APPARMOR +IMA -SMACK +SECCOMP -GCRYPT -GNUTLS -OPENSSL +ACL +BLKID -CURL -ELFUTILS -FIDO2 -IDN2 -IDN -IPTC +KMOD -LIBCRYPTSETUP +LIBFDISK -PCRE2 -PWQUALITY -P11KIT -QRENCODE -BZIP2 -LZ4 -XZ -ZLIB +ZSTD -BPF_FRAMEWORK +XKBCOMMON +UTMP +SYSVINIT default-hierarchy=hybrid) [ 11.829653] systemd[1]: Detected architecture arm64. Welcome to [1mLinux-Kernel-Functional-Testing nodistro.0[0m! [ 11.942180] systemd[1]: Hostname set to <fvp-base>. [ 11.948953] systemd[1]: Initializing machine ID from random generator. [ 11.950246] systemd[1]: Installed transient /etc/machine-id file. [ 14.771490] systemd[1]: Queued start job for default target Multi-User System. [ 15.472103] systemd[1]: Created slice Slice /system/getty. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/getty[0m. [ 15.493603] systemd[1]: Created slice Slice /system/modprobe. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/modprobe[0m. [ 15.514040] systemd[1]: Created slice Slice /system/serial-getty. [[0;32m OK [0m] Created slice [0;1;39mSlice /system/serial-getty[0m. [ 15.531454] systemd[1]: Created slice User and Session Slice. [[0;32m OK [0m] Created slice [0;1;39mUser and Session Slice[0m. [ 15.536311] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [[0;32m OK [0m] Started [0;1;39mDispatch Password …ts to Console Directory Watch[0m. [ 15.540907] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [[0;32m OK [0m] Started [0;1;39mForward Password R…uests to Wall Directory Watch[0m. [ 15.544741] systemd[1]: Reached target Path Units. [[0;32m OK [0m] Reached target [0;1;39mPath Units[0m. [ 15.547143] systemd[1]: Reached target Remote File Systems. [[0;32m OK [0m] Reached target [0;1;39mRemote File Systems[0m. [ 15.549233] systemd[1]: Reached target Slice Units. [[0;32m OK [0m] Reached target [0;1;39mSlice Units[0m. [ 15.551984] systemd[1]: Reached target Swaps. [[0;32m OK [0m] Reached target [0;1;39mSwaps[0m. [ 15.719181] systemd[1]: Listening on RPCbind Server Activation Socket. [[0;32m OK [0m] Listening on [0;1;39mRPCbind Server Activation Socket[0m. [ 15.721517] systemd[1]: Reached target RPC Port Mapper. [[0;32m OK [0m] Reached target [0;1;39mRPC Port Mapper[0m. [ 15.729020] systemd[1]: Listening on Syslog Socket. [[0;32m OK [0m] Listening on [0;1;39mSyslog Socket[0m. [ 15.733015] systemd[1]: Listening on initctl Compatibility Named Pipe. [[0;32m OK [0m] Listening on [0;1;39minitctl Compatibility Named Pipe[0m. [ 15.742725] systemd[1]: Listening on Journal Audit Socket. [[0;32m OK [0m] Listening on [0;1;39mJournal Audit Socket[0m. [ 15.748752] systemd[1]: Listening on Journal Socket (/dev/log). [[0;32m OK [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m. [ 15.756494] systemd[1]: Listening on Journal Socket. [[0;32m OK [0m] Listening on [0;1;39mJournal Socket[0m. [ 15.765743] systemd[1]: Listening on Network Service Netlink Socket. [[0;32m OK [0m] Listening on [0;1;39mNetwork Service Netlink Socket[0m. [ 15.783534] systemd[1]: Listening on udev Control Socket. [[0;32m OK [0m] Listening on [0;1;39mudev Control Socket[0m. [ 15.789563] systemd[1]: Listening on udev Kernel Socket. [[0;32m OK [0m] Listening on [0;1;39mudev Kernel Socket[0m. [ 15.796072] systemd[1]: Listening on User Database Manager Socket. [[0;32m OK [0m] Listening on [0;1;39mUser Database Manager Socket[0m. [ 15.849999] systemd[1]: Mounting Huge Pages File System... Mounting [0;1;39mHuge Pages File System[0m... [ 15.894540] systemd[1]: Mounting POSIX Message Queue File System... Mounting [0;1;39mPOSIX Message Queue File System[0m... [ 15.930638] systemd[1]: Mounting Kernel Debug File System... Mounting [0;1;39mKernel Debug File System[0m... [ 15.968195] systemd[1]: Mounting Kernel Trace File System... Mounting [0;1;39mKernel Trace File System[0m... [ 16.006468] systemd[1]: Mounting Temporary Directory /tmp... Mounting [0;1;39mTemporary Directory /tmp[0m... [ 16.048053] systemd[1]: Starting Create List of Static Device Nodes... Starting [0;1;39mCreate List of Static Device Nodes[0m... [ 16.094070] systemd[1]: Starting Load Kernel Module configfs... Starting [0;1;39mLoad Kernel Module configfs[0m... [ 16.130092] systemd[1]: Starting Load Kernel Module drm... Starting [0;1;39mLoad Kernel Module drm[0m... [ 16.167201] systemd[1]: Starting Load Kernel Module fuse... Starting [0;1;39mLoad Kernel Module fuse[0m... [ 16.205087] systemd[1]: Starting RPC Bind... Starting [0;1;39mRPC Bind[0m... [ 16.240824] systemd[1]: Starting File System Check on Root Device... Starting [0;1;39mFile System Check on Root Device[0m... [ 16.258598] fuse: init (API version 7.36) [ 16.322294] systemd[1]: Starting Journal Service... Starting [0;1;39mJournal Service[0m... [ 16.334004] systemd[1]: Load Kernel Modules was skipped because all trigger condition checks failed. [ 16.368126] systemd[1]: Starting Generate network units from Kernel command line... Starting [0;1;39mGenerate network …ts from Kernel command line[0m... [ 16.404520] systemd[1]: Starting Apply Kernel Variables... Starting [0;1;39mApply Kernel Variables[0m... [ 16.439649] systemd[1]: Starting Coldplug All udev Devices... Starting [0;1;39mColdplug All udev Devices[0m... [ 16.542554] systemd[1]: Started RPC Bind. [[0;32m OK [0m] Started [0;1;39mRPC Bind[0m. [ 16.549321] systemd[1]: Mounted Huge Pages File System. [[0;32m OK [0m] Mounted [0;1;39mHuge Pages File System[0m. [ 16.555537] systemd[1]: Mounted POSIX Message Queue File System. [[0;32m OK [0m] Mounted [0;1;39mPOSIX Message Queue File System[0m. [ 16.562251] systemd[1]: Mounted Kernel Debug File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Debug File System[0m. [ 16.568479] systemd[1]: Mounted Kernel Trace File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Trace File System[0m. [ 16.574661] systemd[1]: Mounted Temporary Directory /tmp. [[0;32m OK [0m] Mounted [0;1;39mTemporary Directory /tmp[0m. [ 16.594070] systemd[1]: Finished Create List of Static Device Nodes. [[0;32m OK [0m] Finished [0;1;39mCreate List of Static Device Nodes[0m. [ 16.608860] systemd[1]: modprobe@configfs.service: Deactivated successfully. [ 16.621851] systemd[1]: Finished Load Kernel Module configfs. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module configfs[0m. [ 16.640429] systemd[1]: modprobe@drm.service: Deactivated successfully. [ 16.656122] systemd[1]: Finished Load Kernel Module drm. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module drm[0m. [ 16.670607] systemd[1]: modprobe@fuse.service: Deactivated successfully. [ 16.682311] systemd[1]: Finished Load Kernel Module fuse. [[0;32m OK [0m] Finished [0;1;39mLoad Kernel Module fuse[0m. [ 16.707660] systemd[1]: Finished File System Check on Root Device. [[0;32m OK [0m] Finished [0;1;39mFile System Check on Root Device[0m. [ 16.730312] systemd[1]: Finished Generate network units from Kernel command line. [[0;32m OK [0m] Finished [0;1;39mGenerate network units from Kernel command line[0m. [ 16.755579] systemd[1]: Finished Apply Kernel Variables. [[0;32m OK [0m] Finished [0;1;39mApply Kernel Variables[0m. [ 16.765180] systemd[1]: Reached target Preparation for Network. [[0;32m OK [0m] Reached target [0;1;39mPreparation for Network[0m. [ 16.830187] systemd[1]: Mounting FUSE Control File System... Mounting [0;1;39mFUSE Control File System[0m... [ 16.867313] systemd[1]: Mounting Kernel Configuration File System... Mounting [0;1;39mKernel Configuration File System[0m... [ 16.902373] systemd[1]: Starting Remount Root and Kernel File Systems... Starting [0;1;39mRemount Root and Kernel File Systems[0m... [ 16.960124] systemd[1]: Mounted FUSE Control File System. [[0;32m OK [0m] Mounted [0;1;39mFUSE Control File System[0m. [ 16.966976] systemd[1]: Mounted Kernel Configuration File System. [[0;32m OK [0m] Mounted [0;1;39mKernel Configuration File System[0m. [ 17.067335] EXT4-fs (vda): re-mounted. Quota mode: none. [ 17.118003] systemd[1]: Finished Remount Root and Kernel File Systems. [[0;32m OK [0m] Finished [0;1;39mRemount Root and Kernel File Systems[0m. [ 17.129995] systemd[1]: Rebuild Hardware Database was skipped because all trigger condition checks failed. [ 17.132131] systemd[1]: Platform Persistent Storage Archival was skipped because of a failed condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [ 17.199577] systemd[1]: Starting Create System Users... Starting [0;1;39mCreate System Users[0m... [ 17.514858] systemd[1]: Finished Create System Users. [[0;32m OK [0m] Finished [0;1;39mCreate System Users[0m. [ 17.579563] systemd[1]: Starting Create Static Device Nodes in /dev... Starting [0;1;39mCreate Static Device Nodes in /dev[0m... [ 17.831729] systemd[1]: Finished Create Static Device Nodes in /dev. [[0;32m OK [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m. [ 17.837220] systemd[1]: Reached target Preparation for Local File Systems. [[0;32m OK [0m] Reached target [0;1;39mPreparation for Local File Systems[0m. [ 17.910118] systemd[1]: Mounting /var/volatile... Mounting [0;1;39m/var/volatile[0m... [ 17.966414] audit: type=1334 audit(1673392292.956:2): prog-id=5 op=LOAD [ 17.968456] audit: type=1334 audit(1673392292.960:3): prog-id=6 op=LOAD [ 17.979729] systemd[1]: Starting Rule-based Manager for Device Events and Files... Starting [0;1;39mRule-based Manage…for Device Events and Files[0m... [ 18.012981] systemd[1]: Started Journal Service. [[0;32m OK [0m] Started [0;1;39mJournal Service[0m. [[0;32m OK [0m] Mounted [0;1;39m/var/volatile[0m. Starting [0;1;39mFlush Journal to Persistent Storage[0m... Starting [0;1;39mLoad/Save Random Seed[0m... [[0;32m OK [0m] Reached target [0;1;39mLocal File Systems[0m. Starting [0;1;39mRebuild Dynamic Linker Cache[0m... [ 18.261258] systemd-journald[241]: Received client request to flush runtime journal. [[0;32m OK [0m] Finished [0;1;39mFlush Journal to Persistent Storage[0m. Starting [0;1;39mCreate Volatile Files and Directories[0m... [[0;32m OK [0m] Finished [0;1;39mLoad/Save Random Seed[0m. Starting [0;1;39mCommit a transient machine-id on disk[0m... [[0;32m OK [0m] Finished [0;1;39mRebuild Dynamic Linker Cache[0m. [[0;32m OK [0m] Finished [0;1;39mCommit a transient machine-id on disk[0m. [[0;32m OK [0m] Finished [0;1;39mCreate Volatile Files and Directories[0m. Starting [0;1;39mRebuild Journal Catalog[0m... Starting [0;1;39mNetwork Time Synchronization[0m... Starting [0;1;39mRecord System Boot/Shutdown in UTMP[0m... [[0;32m OK [0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m. Starting [0;1;39mNetwork Configuration[0m... [[0;32m OK [0m] Finished [0;1;39mRecord System Boot/Shutdown in UTMP[0m. [[0;32m OK [0m] Finished [0;1;39mRebuild Journal Catalog[0m. Starting [0;1;39mUpdate is Completed[0m... [[0;32m OK [0m] Finished [0;1;39mUpdate is Completed[0m. [[0;32m OK [0m] Listening on [0;1;39mLoad/Save RF …itch Status /dev/rfkill Watch[0m. [ 21.184668] cfg80211: Loading compiled-in X.509 certificates for regulatory database [ 21.236623] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [ 21.237435] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [ 21.237662] cfg80211: failed to load regulatory.db [[0;32m OK [0m] Started [0;1;39mNetwork Configuration[0m. [ 21.499904] virtio-pci 0000:00:00.0: deferred probe timeout, ignoring dependency [ 21.503149] virtio-pci 0000:00:00.0: enabling device (0000 -> 0002) [ 21.503536] virtio-pci 0000:00:00.0: virtio_pci: leaving for legacy driver [ 21.506503] virtio_blk virtio3: 1/0/0 default/read/poll queues [ 21.511121] virtio_blk virtio3: [vdb] 0 512-byte logical blocks (0 B/0 B) [ 21.525987] virtio-pci 0000:00:02.0: deferred probe timeout, ignoring dependency [ 21.526903] virtio-pci 0000:00:02.0: enabling device (0000 -> 0002) [ 21.527290] virtio-pci 0000:00:02.0: virtio_pci: leaving for legacy driver [ 21.529157] virtio_blk virtio4: 1/0/0 default/read/poll queues [ 21.533628] virtio_blk virtio4: [vdc] 0 512-byte logical blocks (0 B/0 B) [ 21.554923] ahci 0000:00:03.0: deferred probe timeout, ignoring dependency [ 21.555844] ahci 0000:00:03.0: enabling device (0000 -> 0002) [ 21.563215] ahci 0000:00:03.0: AHCI 0001.0301 32 slots 1 ports 6 Gbps 0x1 impl SATA mode [ 21.563450] ahci 0000:00:03.0: flags: 64bit ncq only [ 21.575627] scsi host0: ahci [ 21.582422] ata1: SATA max UDMA/133 abar m8192@0x50006000 port 0x50006100 irq 39 Starting [0;1;39mNetwork Name Resolution[0m... [ 21.895515] ata1: SATA link down (SStatus 0 SControl 300) [[0;32m OK [0m] Started [0;1;39mNetwork Time Synchronization[0m. [[0;32m OK [0m] Reached target [0;1;39mSystem Time Set[0m. [[0m[0;31m* [0m] (1 of 2) A start job is running for…g All udev Devices (9s / no limit) M[K[[0;32m OK [0m] Started [0;1;39mNetwork Name Resolution[0m. [K[[0;32m OK [0m] Reached target [0;1;39mNetwork[0m. [[0;32m OK [0m] Reached target [0;1;39mHost and Network Name Lookups[0m. [[0;32m OK [0m] Finished [0;1;39mColdplug All udev Devices[0m. [[0;32m OK [0m] Reached target [0;1;39mSystem Initialization[0m. [[0;32m OK [0m] Started [0;1;39mDaily rotation of log files[0m. [[0;32m OK [0m] Started [0;1;39mDaily Cleanup of Temporary Directories[0m. [[0;32m OK [0m] Reached target [0;1;39mTimer Units[0m. [[0;32m OK [0m] Listening on [0;1;39mAvahi mDNS/DNS-SD Stack Activation Socket[0m. [[0;32m OK [0m] Listening on [0;1;39mD-Bus System Message Bus Socket[0m. [[0;32m OK [0m] Reached target [0;1;39mSocket Units[0m. [[0;32m OK [0m] Reached target [0;1;39mBasic System[0m. [ 25.815104] panel-simple panel: supply power not found, using dummy regulator [ 25.833540] panel-simple panel: Specify missing connector_type Starting [0;1;39mAvahi mDNS/DNS-SD Stack[0m... [[0;32m OK [0m] Started [0;1;39mKernel Logging Service[0m. [[0;32m OK [0m] Started [0;1;39mSystem Logging Service[0m. [[0;32m OK [0m] Started [0;1;39mPeriodic Command Scheduler[0m. Starting [0;1;39mD-Bus System Message Bus[0m... [[0;32m OK [0m] Started [0;1;39mGetty on tty1[0m. [[0;32m OK [0m] Started [0;1;39mSerial Getty on ttyAMA0[0m. [[0;32m OK [0m] Reached target [0;1;39mLogin Prompts[0m. [ 26.204981] drm-clcd-pl111 1c1f0000.clcd: assigned reserved memory node vram@18000000 [ 26.205168] drm-clcd-pl111 1c1f0000.clcd: using device-specific reserved memory [ 26.205372] drm-clcd-pl111 1c1f0000.clcd: no max memory bandwidth specified, assume unlimited [ 26.207569] drm-clcd-pl111 1c1f0000.clcd: DVI muxed to motherboard CLCD [ 26.224761] drm-clcd-pl111 1c1f0000.clcd: initializing Versatile Express PL111 [ 26.226439] drm-clcd-pl111 1c1f0000.clcd: found panel on endpoint 0 [ 26.255288] audit: type=1334 audit(1673392301.244:4): prog-id=7 op=LOAD [ 26.255624] audit: type=1334 audit(1673392301.244:5): prog-id=8 op=LOAD [ 26.289947] [drm] Initialized pl111 1.0.0 20170317 for 1c1f0000.clcd on minor 0 Starting [0;1;39mUser Login Management[0m... [[0;32m OK [0m] Started [0;1;39mD-Bus System Message Bus[0m. [ 26.759647] Console: switching to colour frame buffer device 128x48 [ 26.800656] drm-clcd-pl111 1c1f0000.clcd: [drm] fb0: pl111drmfb frame buffer device [[0;32m OK [0m] Started [0;1;39mAvahi mDNS/DNS-SD Stack[0m. [[0;32m OK [0m] Started [0;1;39mUser Login Management[0m. [[0;32m OK [0m] Reached target [0;1;39mMulti-User System[0m. Starting [0;1;39mRecord Runlevel Change in UTMP[0m... [[0;32m OK [0m] Finished [0;1;39mRecord Runlevel Change in UTMP[0m. Linux-Kernel-Functional-Testing nodistro.0 fvp-base ttyAMA0 fvp-base login: root root 7[r[999;999H[6nroot@fvp-base:~# root@fvp-base:~# # # root@fvp-base:~# export SHELL=/bin/sh export SHELL=/bin/sh root@fvp-base:~# . /lava-1/environment . /lava-1/environment root@fvp-base:~# /lava-1/bin/lava-test-runner /lava-1/0 /lava-1/bin/lava-test-runner /lava-1/[ 89.499755] systemd-journald[241]: Time jumped backwards, rotating. 0 + export TESTRUN_ID=0_ltp-mm + TESTRUN_ID=0_ltp-mm + cd /lava-1/0/tests/0_ltp-mm ++ cat uuid + UUID=1_1.1.3.1 + set +x [ 89.933008] <LAVA_SIGNAL_STARTRUN 0_ltp-mm 1_1.1.3.1> + cd ./automated/linux/ltp/ Broadcast message from systemd-journald@fvp-base (Tue 2023-01-10 23:19:02 UTC): kernel[327]: [ 89.933008] <LAVA_SIGNAL_STARTRUN 0_ltp-mm 1_1.1.3.1> + ./ltp.sh -T mm -s true -v '' -M 5 -R root -b '' -d /scratch -g '' -e production -i /opt/ltp/ -S skipfile-lkft.yaml -p '' -u '' -t false -n 6 -c 4 + . ../../lib/sh-test-lib ++ LANG=C ++ export LANG ++ export PATH=/lava-1/0/../bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin:/sbin:/usr/sbin:/usr/local/sbin ++ PATH=/lava-1/0/../bin:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/sbin:/sbin:/usr/sbin:/usr/local/sbin ++ kernel_config= ++ pwd + OUTPUT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + RESULT_FILE=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/result.txt ++ readlink -f ./ltp.sh + SCRIPT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp.sh ++ dirname /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp.sh + SCRIPTPATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp + echo 'Script path is: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp' Script path is: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp + TST_CMDFILES= + SKIPFILE= + SKIPFILE_YAML= + BOARD= + BRANCH= + ENVIRONMENT= + LTP_VERSION=20180926 + TEST_PROGRAM=ltp + TEST_GIT_URL= ++ pwd + TEST_DIR=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/ltp + BUILD_FROM_TAR=false + SHARD_NUMBER=1 + SHARD_INDEX=1 + LTP_TMPDIR=/ltp-tmp + LTP_INSTALL_PATH=/opt/ltp + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + TST_CMDFILES=mm ++ echo mm ++ sed 's,\/,_,' + LOG_FILE=mm + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SKIP_INSTALL=true + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + LTP_VERSION= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_TIMEOUT_MUL=5 + LTP_TIMEOUT_MUL=5 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export PASSWD=root + PASSWD=root + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export BOARD= + BOARD= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_TMPDIR=/scratch + LTP_TMPDIR=/scratch + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export BRANCH= + BRANCH= + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export ENVIRONMENT=production + ENVIRONMENT=production + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + export LTP_INSTALL_PATH=/opt/ltp/ + LTP_INSTALL_PATH=/opt/ltp/ + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + '[' -z skipfile-lkft.yaml ']' + '[' yaml = yaml ']' + SKIPFILE_YAML=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + [[ '' != '' ]] + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + [[ '' != '' ]] + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + BUILD_FROM_TAR=false + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SHARD_NUMBER=6 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + case \"$arg\" in + SHARD_INDEX=4 + getopts M:T:S:b:d:g:e:i:s:v:R:u:p:t:c:n: arg + TEST_TARFILE=https://github.com/linux-test-project/ltp/releases/download//ltp-full-.tar.xz + '[' -n /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml ']' + export SKIPFILE_PATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile + SKIPFILE_PATH=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile + generate_skipfile + info_msg 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' + local 'msg=Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' + '[' -z 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' ']' + printf 'INFO: %s\n' 'Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml' INFO: Generating a skipfile based on /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + detect_abi ++ uname -m + abi=aarch64 + case \"${abi}\" in + abi=arm64 + local SKIPGEN_ARGS= + test -n '' + test -n '' + test -n production + SKIPGEN_ARGS=' --environment production' + ../../bin/arm64/skipgen --environment production /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/skipfile-lkft.yaml + test 0 -eq 0 + info_msg 'Using the following generated skipfile contents (until EOF):' + local 'msg=Using the following generated skipfile contents (until EOF):' + '[' -z 'Using the following generated skipfile contents (until EOF):' ']' + printf 'INFO: %s\n' 'Using the following generated skipfile contents (until EOF):' INFO: Using the following generated skipfile contents (until EOF): + cat /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile bind06 cve-2018-18559 dio10 dio12 dio13 dio14 dio15 dio16 dio17 dio18 dio19 dio20 dio21 dio22 dio23 dio24 dio25 dio26 dio27 dio28 dio29 dio30 fanotify07 fanotify08 fanotify09 fork13 ftrace_stress_test.sh futex_wake04 gf01 gf14 gf15 gf18 hackbench01 hackbench02 hugemmap06 inotify07 inotify08 ksm01 memcg_stress msgctl10 msgctl11 msgstress03 msgstress04 mtest06 perf_event_open02 ping01 ping602 pth_str01 pth_str02 pth_str03 sendfile09 sendfile09_64 setsockopt06 time-schedule01 + info_msg EOF + local msg=EOF + '[' -z EOF ']' + printf 'INFO: %s\n' EOF INFO: EOF + '[' '!' -f /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile ']' + SKIPFILE='-S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' + check_root ++ id -ru + '[' 0 -eq 0 ']' + return 0 + create_out_dir /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -z /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + local OUTPUT=/lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -d /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + mkdir -p /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' -d /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output ']' + info_msg 'About to run ltp test...' + local 'msg=About to run ltp test...' + '[' -z 'About to run ltp test...' ']' + printf 'INFO: %s\n' 'About to run ltp test...' INFO: About to run ltp test... + info_msg 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' + local 'msg=Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' + '[' -z 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' ']' + printf 'INFO: %s\n' 'Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output' INFO: Output directory: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output + '[' true = true ']' + info_msg 'ltp installation skipped altogether' + local 'msg=ltp installation skipped altogether' + '[' -z 'ltp installation skipped altogether' ']' + printf 'INFO: %s\n' 'ltp installation skipped altogether' INFO: ltp installation skipped altogether + '[' '!' -d /opt/ltp/ ']' + info_msg 'Running prep_system' + local 'msg=Running prep_system' + '[' -z 'Running prep_system' ']' + printf 'INFO: %s\n' 'Running prep_system' INFO: Running prep_system + prep_system + systemctl is-active systemd-timesyncd active + info_msg 'Stopping systemd-timesyncd' + local 'msg=Stopping systemd-timesyncd' + '[' -z 'Stopping systemd-timesyncd' ']' + printf 'INFO: %s\n' 'Stopping systemd-timesyncd' INFO: Stopping systemd-timesyncd + systemctl stop systemd-timesyncd <terminal_1> UEFI firmware (version built at 06:55:08 on Oct 13 2022) + '[' -f /proc/sys/kernel/unprivileged_userns_clone ']' + info_msg 'Kernel has no support of unprivileged_userns_clone' + local 'msg=Kernel has no support of unprivileged_userns_clone' + '[' -z 'Kernel has no support of unprivileged_userns_clone' ']' + printf 'INFO: %s\n' 'Kernel has no support of unprivileged_userns_clone' INFO: Kernel has no support of unprivileged_userns_clone + info_msg 'Running run_ltp' + local 'msg=Running run_ltp' + '[' -z 'Running run_ltp' ']' + printf 'INFO: %s\n' 'Running run_ltp' INFO: Running run_ltp + run_ltp + cd /opt/ltp/ + mkdir -m 777 -p /scratch + for file in ${TST_CMDFILES//,/ } + cat runtest/mm + sed -i 's/#.*$//;/^$/d' alltests + split --verbose --numeric-suffixes=1 -n l/4/6 alltests + echo '============== Tests to run ===============' ============== Tests to run =============== + cat runtest/shardfile mmap10_2 mmap10 -s mmap10_3 mmap10 -a -s mmap10_4 mmap10 -a -s -i 60 ksm01 ksm01 ksm01_1 ksm01 -u 128 ksm02 ksm02 ksm02_1 ksm02 -u 128 ksm03 ksm03 ksm03_1 ksm03 -u 128 ksm04 ksm04 ksm04_1 ksm04 -u 128 ksm05 ksm05 -I 10 ksm06 ksm06 ksm06_1 ksm06 -n 10 ksm06_2 ksm06 -n 8000 + echo '===========End Tests to run ===============' ===========End Tests to run =============== + pipe0_status './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' 'tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' + '[' 2 -ne 2 ']' + local 'cmd1=./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' + local 'cmd2=tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' + exec + local ret_val ++ eval './runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile' +++ ./runltp -p -q -f shardfile -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -d /scratch -S /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/generated_skipfile ++ eval 'tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out' +++ tee /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.out INFO: creating /opt/ltp/output directory Checking for required user/group ids 'nobody' user id and group found. 'bin' user id and group found. 'daemon' user id and group found. Users group found. Sys group found. Required users/groups exist. no big block device was specified on commandline. Tests which require a big block device are disabled. You can specify it with option -z INFO: Test start time: Tue Jan 10 23:19:07 UTC 2023 COMMAND: /opt/ltp/bin/ltp-pan -q -e -S -a 394 -n 394 -p -f /scratch/ltp-MKuTy2QtEl/alltests -l /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log -C /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed -T /opt/ltp/output/LTP_RUN_ON-LTP_mm.log.tconf LOG File: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.log FAILED COMMAND File: /lava-1/0/tests/0_ltp-mm/automated/linux/ltp/output/LTP_mm.failed TCONF COMMAND File: /opt/ltp/output/LTP_RUN_ON-LTP_mm.log.tconf Running tests....... mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. mmap10 0 TINFO : add to KSM regions. mmap10 0 TINFO : use /dev/zero. mmap10 0 TINFO : start tests. ... mem.c:346: TINFO: child 1 continues... mem.c:349: TINFO: child 1 allocates 128 MB filled with 'b' mem.c:346: TINFO: child 2 continues... mem.c:349: TINFO: child 2 allocates 128 MB filled with 'a' [ 132.629958] SError Interrupt on CPU0, code 0x00000000be000000 -- SError [ 132.629998] CPU: 0 PID: 688 Comm: ksm03 Not tainted 6.0.19-rc1 #1 [ 132.630057] Hardware name: FVP Base RevC (DT) [ 132.630082] pstate: 80000000 (Nzcv daif -PAN -UAO -TCO -DIT -SSBS BTYPE=--) [ 132.630153] pc : 000000000041f758 [ 132.630174] lr : 000000000041f8c0 [ 132.630195] sp : 0000fffffb4463a0 [ 132.630218] x29: 0000fffffb4463b0 x28: 0000000000100000 x27: 00000000004296c0 [ 132.630314] x26: 000000000fe39d40 x25: 0000000000000063 x24: 0000000008000000 [ 132.630408] x23: 0000000008000000 x22: 0000000000429550 x21: 0000000000000000 [ 132.630500] x20: 0000fffffb4464c8 x19: 0000000000000080 x18: 0000000000000000 [ 132.630596] x17: 0000ffff9b29a290 x16: 0000000000441340 x15: 0000000000008000 [ 132.630692] x14: 0000000000040000 x13: 0000000000000000 x12: 0000ffff9b307160 [ 132.630787] x11: 0000fffffb445da0 x10: 00000000ffffffd8 x9 : 00000000ffffff80 [ 132.630883] x8 : 0000000000000040 x7 : 00000000ffffffff x6 : 0000000000000000 [ 132.630975] x5 : 0000000000000063 x4 : 0000000000000020 x3 : 0000ffff9b3eed60 [ 132.631067] x2 : 0000000000000073 x1 : 0000ffff93dc0000 x0 : 000000000009c001 [ 132.631167] Kernel panic - not syncing: Asynchronous SError Interrupt [ 132.631194] CPU: 0 PID: 688 Comm: ksm03 Not tainted 6.0.19-rc1 #1 [ 132.631251] Hardware name: FVP Base RevC (DT) [ 132.631277] Call trace: [ 132.631293] dump_backtrace+0xe4/0x124 [ 132.631348] show_stack+0x20/0x5c [ 132.631400] dump_stack_lvl+0x88/0xb4 [ 132.631456] dump_stack+0x18/0x34 [ 132.631510] panic+0x188/0x384 [ 132.631576] nmi_panic+0x98/0xa0 [ 132.631633] arm64_serror_panic+0x78/0x84 [ 132.631693] do_serror+0x0/0x60 [ 132.631748] do_serror+0x3c/0x60 [ 132.631804] __el0_error_handler_common+0x48/0xc0 [ 132.631885] el0t_64_error_handler+0x10/0x20 [ 132.631965] el0t_64_error+0x18c/0x190 [ 132.632024] SMP: stopping secondary CPUs [ 132.632105] Kernel Offset: 0x57c5cb5c0000 from 0xffff800008000000 [ 132.632140] PHYS_OFFSET: 0x80000000 [ 132.632162] CPU features: 0x0000,0002873f,f9a79dcb [ 132.632193] Memory Limit: none [ 132.923555] ---[ end Kernel panic - not syncing: Asynchronous SError Interrupt ]--- [ 132.923752] ------------[ cut here ]------------ [ 132.923768] WARNING: CPU: 0 PID: 688 at kernel/sched/core.c:3119 set_task_cpu+0x154/0x22c [ 132.923848] Modules linked in: crct10dif_ce pl111_drm drm_cma_helper drm_kms_helper panel_simple cfg80211 rfkill fuse drm [ 132.924055] CPU: 0 PID: 688 Comm: ksm03 Not tainted 6.0.19-rc1 #1 [ 132.924114] Hardware name: FVP Base RevC (DT) [ 132.924139] pstate: 424020c9 (nZcv daIF +PAN -UAO +TCO -DIT -SSBS BTYPE=--) [ 132.924210] pc : set_task_cpu+0x154/0x22c [ 132.924260] lr : try_to_wake_up+0x1a0/0x62c [ 132.924313] sp : ffff80000800fbe0 [ 132.924337] x29: ffff80000800fbe0 x28: ffff00087f5e5680 x27: 0000000000000000 [ 132.924435] x26: 0000000000000000 x25: ffffd7c5d60fd2f8 x24: 0000000000000001 [ 132.924529] x23: ffff00080113736c x22: 0000000000000001 x21: ffffd7c5d60f8a78 [ 132.924627] x20: 0000000000000001 x19: ffff000801136b00 x18: 0000000000000006 [ 132.924721] x17: 75727265746e4920 x16: 726f727245532073 x15: 756f6e6f7268636e [ 132.924823] x14: 797341203a676e69 x13: 2d2d2d5d20747075 x12: 727265746e492072 [ 132.924924] x11: 6f72724553207375 x10: ffffd7c5d6174a20 x9 : ffffd7c5d3697624 [ 132.925025] x8 : 0000000000000020 x7 : fffffffffffffffe x6 : 0000000000000001 [ 132.925118] x5 : 0000000000000001 x4 : ffffd7c5d57eaf00 x3 : 00000000000000ff [ 132.925210] x2 : 0000000000000000 x1 : 0000000000000001 x0 : 0000000000000000 [ 132.925300] Call trace: [ 132.925316] set_task_cpu+0x154/0x22c [ 132.925367] try_to_wake_up+0x1a0/0x62c [ 132.925427] default_wake_function+0x24/0x50 [ 132.925486] autoremove_wake_function+0x20/0x50 [ 132.925568] __wake_up_common+0x90/0x190 [ 132.925641] __wake_up_common_lock+0x80/0xd0 [ 132.925715] __wake_up+0x20/0x30 [ 132.925785] wake_up_klogd_work_func+0xac/0xc0 [ 132.925853] irq_work_single+0x7c/0xa0 [ 132.925930] irq_work_run_list+0x50/0x6c [ 132.926009] irq_work_tick+0x28/0xac [ 132.926085] update_process_times+0xa4/0xc0 [ 132.926164] tick_sched_handle+0x3c/0x60 [ 132.926225] tick_sched_timer+0x54/0xac [ 132.926287] __hrtimer_run_queues+0x2e4/0x380 [ 132.926369] hrtimer_interrupt+0xf0/0x250 [ 132.926450] arch_timer_handler_phys+0x34/0x50 [ 132.926521] handle_percpu_devid_irq+0x90/0x230 [ 132.926583] generic_handle_domain_irq+0x34/0x50 [ 132.926660] gic_handle_irq+0x58/0x140 [ 132.926715] call_on_irq_stack+0x2c/0x60 [ 132.926781] do_interrupt_handler+0x88/0x94 [ 132.926857] el1_interrupt+0x34/0x70 [ 132.926930] el1h_64_irq_handler+0x18/0x24 [ 132.927009] el1h_64_irq+0x64/0x68 [ 132.927064] panic+0x30c/0x384 [ 132.927130] nmi_panic+0x98/0xa0 [ 132.927187] arm64_serror_panic+0x78/0x84 [ 132.927247] do_serror+0x0/0x60 [ 132.927302] do_serror+0x3c/0x60 [ 132.927358] __el0_error_handler_common+0x48/0xc0 [ 132.927439] el0t_64_error_handler+0x10/0x20 [ 132.927519] el0t_64_error+0x18c/0x190 [ 132.927577] ---[ end trace 0000000000000000 ]---