2024-07-01T16:07:01.208692 [    0.000000] Booting Linux on physical CPU 0x0000000000 [0x000f0510]
2024-07-01T16:07:01.209229 [    0.000000] Linux version 6.10.0-rc6 (tuxmake@tuxmake) (Debian clang version 18.1.8 (++20240615103650+3b5b5c1ec4a3-1~exp1~20240615223815.136), Debian LLD 18.1.8) #1 SMP PREEMPT @1719821472
2024-07-01T16:07:01.209374 [    0.000000] KASLR enabled
2024-07-01T16:07:01.209496 [    0.000000] random: crng init done
2024-07-01T16:07:01.209633 [    0.000000] Machine model: linux,dummy-virt
2024-07-01T16:07:01.209743 [    0.000000] efi: UEFI not found.
2024-07-01T16:07:01.209875 [    0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '')
2024-07-01T16:07:01.210049 [    0.000000] printk: legacy bootconsole [pl11] enabled
2024-07-01T16:07:01.213135 [    0.000000] NUMA: No NUMA configuration found
2024-07-01T16:07:01.213421 [    0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]
2024-07-01T16:07:01.213947 [    0.000000] NUMA: NODE_DATA [mem 0x13f5fb9c0-0x13f5fdfff]
2024-07-01T16:07:01.216326 [    0.000000] Zone ranges:
2024-07-01T16:07:01.216827 [    0.000000]   DMA      [mem 0x0000000040000000-0x00000000ffffffff]
2024-07-01T16:07:01.216958 [    0.000000]   DMA32    empty
2024-07-01T16:07:01.217192 [    0.000000]   Normal   [mem 0x0000000100000000-0x000000013fffffff]
2024-07-01T16:07:01.217365 [    0.000000] Movable zone start for each node
2024-07-01T16:07:01.217541 [    0.000000] Early memory node ranges
2024-07-01T16:07:01.217771 [    0.000000]   node   0: [mem 0x0000000040000000-0x000000013fffffff]
2024-07-01T16:07:01.218192 [    0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]
2024-07-01T16:07:01.252313 [    0.000000] cma: Reserved 32 MiB at 0x00000000fe000000 on node -1
2024-07-01T16:07:01.253199 [    0.000000] psci: probing for conduit method from DT.
2024-07-01T16:07:01.253359 [    0.000000] psci: PSCIv1.1 detected in firmware.
2024-07-01T16:07:01.253482 [    0.000000] psci: Using standard PSCI v0.2 function IDs
2024-07-01T16:07:01.253732 [    0.000000] psci: Trusted OS migration not required
2024-07-01T16:07:01.253892 [    0.000000] psci: SMC Calling Convention v1.0
2024-07-01T16:07:01.256010 [    0.000000] percpu: Embedded 34 pages/cpu s98472 r8192 d32600 u139264
2024-07-01T16:07:01.256451 [    0.000000] pcpu-alloc: s98472 r8192 d32600 u139264 alloc=34*4096
2024-07-01T16:07:01.256770 [    0.000000] pcpu-alloc: [0] 0 [0] 1 
2024-07-01T16:07:01.257859 [    0.000000] Detected PIPT I-cache on CPU0
2024-07-01T16:07:01.259570 [    0.000000] CPU features: detected: Branch Target Identification
2024-07-01T16:07:01.259765 [    0.000000] CPU features: detected: Address authentication (IMP DEF algorithm)
2024-07-01T16:07:01.259992 [    0.000000] CPU features: detected: GIC system register CPU interface
2024-07-01T16:07:01.260169 [    0.000000] CPU features: detected: HCRX_EL2 register
2024-07-01T16:07:01.260361 [    0.000000] CPU features: detected: 52-bit Virtual Addressing (LPA2)
2024-07-01T16:07:01.260532 [    0.000000] CPU features: detected: Virtualization Host Extensions
2024-07-01T16:07:01.260723 [    0.000000] CPU features: detected: Memory Tagging Extension
2024-07-01T16:07:01.260904 [    0.000000] CPU features: detected: Asymmetric MTE Tag Check Fault
2024-07-01T16:07:01.261168 [    0.000000] CPU features: detected: Spectre-v4
2024-07-01T16:07:01.264270 [    0.000000] alternatives: applying boot alternatives
2024-07-01T16:07:01.267998 [    0.000000] Kernel command line: console=ttyAMA0,115200 rootwait root=/dev/vda debug verbose console_msg_format=syslog systemd.log_level=warning rw earlycon
2024-07-01T16:07:01.270037 <5>[    0.000000] Unknown kernel command line parameters "verbose", will be passed to user space.
2024-07-01T16:07:01.274360 <6>[    0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
2024-07-01T16:07:01.275534 <6>[    0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
2024-07-01T16:07:01.277217 <6>[    0.000000] Fallback order for Node 0: 0 
2024-07-01T16:07:01.277361 <6>[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1048576
2024-07-01T16:07:01.277531 <6>[    0.000000] Policy zone: Normal
2024-07-01T16:07:01.278368 <6>[    0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
2024-07-01T16:07:01.278716 <6>[    0.000000] software IO TLB: area num 2.
2024-07-01T16:07:01.330338 <6>[    0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)
2024-07-01T16:07:01.348922 <6>[    0.000000] Memory: 3964136K/4194304K available (22272K kernel code, 6524K rwdata, 13552K rodata, 3200K init, 812K bss, 197400K reserved, 32768K cma-reserved)
2024-07-01T16:07:01.353431 <6>[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
2024-07-01T16:07:01.355225 <6>[    0.000000] ftrace: allocating 70178 entries in 275 pages
2024-07-01T16:07:01.775061 <6>[    0.000000] ftrace: allocated 275 pages with 4 groups
2024-07-01T16:07:01.777635 <6>[    0.000000] trace event string verifier disabled
2024-07-01T16:07:01.783324 <6>[    0.000000] rcu: Preemptible hierarchical RCU implementation.
2024-07-01T16:07:01.783477 <6>[    0.000000] rcu: 	RCU event tracing is enabled.
2024-07-01T16:07:01.783692 <6>[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2.
2024-07-01T16:07:01.784062 <6>[    0.000000] 	Trampoline variant of Tasks RCU enabled.
2024-07-01T16:07:01.784218 <6>[    0.000000] 	Rude variant of Tasks RCU enabled.
2024-07-01T16:07:01.784415 <6>[    0.000000] 	Tracing variant of Tasks RCU enabled.
2024-07-01T16:07:01.784829 <6>[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
2024-07-01T16:07:01.785104 <6>[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
2024-07-01T16:07:01.786501 <6>[    0.000000] RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1.
2024-07-01T16:07:01.786702 <6>[    0.000000] RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1.
2024-07-01T16:07:01.787002 <6>[    0.000000] RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1.
2024-07-01T16:07:01.797268 <6>[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
2024-07-01T16:07:01.802520 <6>[    0.000000] GICv3: GIC: Using split EOI/Deactivate mode
2024-07-01T16:07:01.802648 <6>[    0.000000] GICv3: 256 SPIs implemented
2024-07-01T16:07:01.802787 <6>[    0.000000] GICv3: 0 Extended SPIs implemented
2024-07-01T16:07:01.804437 <6>[    0.000000] Root IRQ handler: gic_handle_irq
2024-07-01T16:07:01.804635 <6>[    0.000000] GICv3: GICv3 features: 16 PPIs
2024-07-01T16:07:01.805362 <6>[    0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
2024-07-01T16:07:01.809959 <6>[    0.000000] ITS [mem 0x08080000-0x0809ffff]
2024-07-01T16:07:01.810868 <6>[    0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100200000 (indirect, esz 8, psz 64K, shr 1)
2024-07-01T16:07:01.811275 <6>[    0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100210000 (flat, esz 8, psz 64K, shr 1)
2024-07-01T16:07:01.812027 <6>[    0.000000] GICv3: using LPI property table @0x0000000100220000
2024-07-01T16:07:01.812705 <6>[    0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100230000
2024-07-01T16:07:01.814505 <6>[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
2024-07-01T16:07:01.820169 <6>[    0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (phys).
2024-07-01T16:07:01.820595 <6>[    0.000000] clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns
2024-07-01T16:07:01.821131 <6>[    0.000052] sched_clock: 57 bits at 63MHz, resolution 16ns, wraps every 4398046511096ns
2024-07-01T16:07:01.823916 <6>[    0.002581] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
2024-07-01T16:07:01.836892 <6>[    0.014074] Console: colour dummy device 80x25
2024-07-01T16:07:01.840186 <6>[    0.018416] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000)
2024-07-01T16:07:01.840443 <6>[    0.019481] pid_max: default: 32768 minimum: 301
2024-07-01T16:07:01.842167 <6>[    0.020992] LSM: initializing lsm=capability
2024-07-01T16:07:01.845409 <6>[    0.024311] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2024-07-01T16:07:01.845876 <6>[    0.024623] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
2024-07-01T16:07:01.872021 <4>[    0.050882] cacheinfo: Unable to detect cache hierarchy for CPU 0
2024-07-01T16:07:01.885817 <6>[    0.064662] rcu: Hierarchical SRCU implementation.
2024-07-01T16:07:01.885982 <6>[    0.064858] rcu: 	Max phase no-delay instances is 1000.
2024-07-01T16:07:01.895137 <6>[    0.073992] Platform MSI: its@8080000 domain created
2024-07-01T16:07:01.896045 <6>[    0.074769] PCI/MSI: /intc@8000000/its@8080000 domain created
2024-07-01T16:07:01.896501 <6>[    0.075536] fsl-mc MSI: its@8080000 domain created
2024-07-01T16:07:01.899317 <6>[    0.078217] EFI services will not be available.
2024-07-01T16:07:01.900967 <6>[    0.079871] smp: Bringing up secondary CPUs ...
2024-07-01T16:07:01.925257 <6>[    0.088262] Detected PIPT I-cache on CPU1
2024-07-01T16:07:01.925699 <6>[    0.092131] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
2024-07-01T16:07:01.926028 <6>[    0.093666] GICv3: CPU1: using allocated LPI pending table @0x0000000100240000
2024-07-01T16:07:01.926138 <6>[    0.097078] CPU1: Booted secondary processor 0x0000000001 [0x000f0510]
2024-07-01T16:07:01.926253 <6>[    0.104135] smp: Brought up 1 node, 2 CPUs
2024-07-01T16:07:01.926504 <6>[    0.105517] SMP: Total of 2 processors activated.
2024-07-01T16:07:01.926645 <6>[    0.105730] CPU: All CPU(s) started at EL2
2024-07-01T16:07:01.926955 <6>[    0.105996] CPU features: detected: 32-bit EL0 Support
2024-07-01T16:07:01.927249 <6>[    0.106208] CPU features: detected: 32-bit EL1 Support
2024-07-01T16:07:01.927745 <6>[    0.106702] CPU features: detected: ARMv8.4 Translation Table Level
2024-07-01T16:07:01.928117 <6>[    0.106996] CPU features: detected: Data cache clean to the PoU not required for I/D coherence
2024-07-01T16:07:01.928399 <6>[    0.107371] CPU features: detected: Common not Private translations
2024-07-01T16:07:01.928618 <6>[    0.107628] CPU features: detected: CRC32 instructions
2024-07-01T16:07:01.929018 <6>[    0.107847] CPU features: detected: Data independent timing control (DIT)
2024-07-01T16:07:01.929070 <6>[    0.108105] CPU features: detected: E0PD
2024-07-01T16:07:01.929317 <6>[    0.108287] CPU features: detected: Enhanced Privileged Access Never
2024-07-01T16:07:01.929553 <6>[    0.108542] CPU features: detected: Enhanced Virtualization Traps
2024-07-01T16:07:01.929843 <6>[    0.108784] CPU features: detected: Fine Grained Traps
2024-07-01T16:07:01.930188 <6>[    0.109112] CPU features: detected: Generic authentication (IMP DEF algorithm)
2024-07-01T16:07:01.930528 <6>[    0.109494] CPU features: detected: RCpc load-acquire (LDAPR)
2024-07-01T16:07:01.930851 <6>[    0.109793] CPU features: detected: 52-bit Virtual Addressing for KVM (LPA2)
2024-07-01T16:07:01.931181 <6>[    0.110084] CPU features: detected: LSE atomic instructions
2024-07-01T16:07:01.931526 <6>[    0.110337] CPU features: detected: Memory Copy and Memory Set instructions
2024-07-01T16:07:01.931749 <6>[    0.110744] CPU features: detected: Privileged Access Never
2024-07-01T16:07:01.932008 <6>[    0.110984] CPU features: detected: RAS Extension Support
2024-07-01T16:07:01.932226 <6>[    0.111235] CPU features: detected: Random Number Generator
2024-07-01T16:07:01.932444 <6>[    0.111451] CPU features: detected: Speculation barrier (SB)
2024-07-01T16:07:01.932646 <6>[    0.111673] CPU features: detected: Stage-2 Force Write-Back
2024-07-01T16:07:01.932892 <6>[    0.111877] CPU features: detected: Trap EL0 IMPLEMENTATION DEFINED functionality
2024-07-01T16:07:01.933109 <6>[    0.112113] CPU features: detected: TLB range maintenance instructions
2024-07-01T16:07:01.933362 <6>[    0.112367] CPU features: detected: Scalable Matrix Extension
2024-07-01T16:07:01.933662 <6>[    0.112583] CPU features: detected: FA64
2024-07-01T16:07:01.933738 <6>[    0.112750] CPU features: detected: Speculative Store Bypassing Safe (SSBS)
2024-07-01T16:07:01.934063 <6>[    0.112960] CPU features: detected: Scalable Vector Extension
2024-07-01T16:07:01.948099 <6>[    0.125211] alternatives: applying system-wide alternatives
2024-07-01T16:07:01.959043 <6>[    0.137506] CPU features: detected: Hardware dirty bit management on CPU0-1
2024-07-01T16:07:01.959566 <6>[    0.138470] SVE: maximum available vector length 256 bytes per vector
2024-07-01T16:07:01.959798 <6>[    0.138798] SVE: default vector length 64 bytes per vector
2024-07-01T16:07:01.961441 <6>[    0.140401] SME: minimum available vector length 16 bytes per vector
2024-07-01T16:07:01.961843 <6>[    0.140677] SME: maximum available vector length 256 bytes per vector
2024-07-01T16:07:01.961988 <6>[    0.140965] SME: default vector length 32 bytes per vector
2024-07-01T16:07:02.008814 <6>[    0.187676] devtmpfs: initialized
2024-07-01T16:07:02.042596 <6>[    0.221371] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
2024-07-01T16:07:02.043193 <6>[    0.222125] futex hash table entries: 512 (order: 3, 32768 bytes, linear)
2024-07-01T16:07:02.050419 <6>[    0.229316] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
2024-07-01T16:07:02.050813 <6>[    0.229654] 0 pages in range for non-PLT usage
2024-07-01T16:07:02.053625 <6>[    0.229735] 512640 pages in range for PLT usage
2024-07-01T16:07:02.053740 <6>[    0.232519] pinctrl core: initialized pinctrl subsystem
2024-07-01T16:07:02.064075 <6>[    0.242972] DMI not present or invalid.
2024-07-01T16:07:02.082986 <6>[    0.261832] NET: Registered PF_NETLINK/PF_ROUTE protocol family
2024-07-01T16:07:02.095926 <6>[    0.274681] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
2024-07-01T16:07:02.097011 <6>[    0.275885] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
2024-07-01T16:07:02.098876 <6>[    0.277754] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
2024-07-01T16:07:02.099539 <6>[    0.278448] audit: initializing netlink subsys (disabled)
2024-07-01T16:07:02.102929 <5>[    0.281794] audit: type=2000 audit(0.256:1): state=initialized audit_enabled=0 res=1
2024-07-01T16:07:02.118627 <6>[    0.297303] thermal_sys: Registered thermal governor 'step_wise'
2024-07-01T16:07:02.120354 <6>[    0.297429] thermal_sys: Registered thermal governor 'power_allocator'
2024-07-01T16:07:02.120834 <6>[    0.299086] cpuidle: using governor menu
2024-07-01T16:07:02.124535 <6>[    0.303297] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
2024-07-01T16:07:02.125991 <6>[    0.304804] ASID allocator initialised with 65536 entries
2024-07-01T16:07:02.151477 <6>[    0.330354] Serial: AMBA PL011 UART driver
2024-07-01T16:07:02.317215 <6>[    0.496045] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 14, base_baud = 0) is a PL011 rev1
2024-07-01T16:07:02.318878 <6>[    0.497634] printk: legacy console [ttyAMA0] enabled
2024-07-01T16:07:02.319063 <6>[    0.497634] printk: legacy console [ttyAMA0] enabled
2024-07-01T16:07:02.319185 <6>[    0.498150] printk: legacy bootconsole [pl11] disabled
2024-07-01T16:07:02.319302 <6>[    0.498150] printk: legacy bootconsole [pl11] disabled
2024-07-01T16:07:02.347303 <6>[    0.526149] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
2024-07-01T16:07:02.347454 <6>[    0.526383] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
2024-07-01T16:07:02.347575 <6>[    0.526589] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
2024-07-01T16:07:02.347755 <6>[    0.526784] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
2024-07-01T16:07:02.347950 <6>[    0.526971] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
2024-07-01T16:07:02.348130 <6>[    0.527171] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
2024-07-01T16:07:02.348349 <6>[    0.527361] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
2024-07-01T16:07:02.348525 <6>[    0.527562] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
2024-07-01T16:07:02.354905 <6>[    0.533746] Demotion targets for Node 0: null
2024-07-01T16:07:02.361035 <6>[    0.539886] cryptd: max_cpu_qlen set to 1000
2024-07-01T16:07:02.368925 <6>[    0.547779] ACPI: Interpreter disabled.
2024-07-01T16:07:02.390844 <6>[    0.569754] iommu: Default domain type: Translated
2024-07-01T16:07:02.391044 <6>[    0.570072] iommu: DMA domain TLB invalidation policy: strict mode
2024-07-01T16:07:02.392948 <5>[    0.571885] SCSI subsystem initialized
2024-07-01T16:07:02.393987 <7>[    0.572953] libata version 3.00 loaded.
2024-07-01T16:07:02.395665 <6>[    0.574606] usbcore: registered new interface driver usbfs
2024-07-01T16:07:02.395965 <6>[    0.575015] usbcore: registered new interface driver hub
2024-07-01T16:07:02.396294 <6>[    0.575360] usbcore: registered new device driver usb
2024-07-01T16:07:02.402716 <6>[    0.581618] mc: Linux media interface: v0.10
2024-07-01T16:07:02.403095 <6>[    0.582044] videodev: Linux video capture interface: v2.00
2024-07-01T16:07:02.403697 <6>[    0.582657] pps_core: LinuxPPS API ver. 1 registered
2024-07-01T16:07:02.403874 <6>[    0.582841] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
2024-07-01T16:07:02.404130 <6>[    0.583177] PTP clock support registered
2024-07-01T16:07:02.405569 <6>[    0.584533] EDAC MC: Ver: 3.0.0
2024-07-01T16:07:02.407670 <6>[    0.586615] scmi_core: SCMI protocol bus registered
2024-07-01T16:07:02.415285 <6>[    0.594211] FPGA manager framework
2024-07-01T16:07:02.416284 <6>[    0.595243] Advanced Linux Sound Architecture Driver Initialized.
2024-07-01T16:07:02.426438 <6>[    0.605370] vgaarb: loaded
2024-07-01T16:07:02.430741 <6>[    0.609662] clocksource: Switched to clocksource arch_sys_counter
2024-07-01T16:07:03.083579 <5>[    1.262371] VFS: Disk quotas dquot_6.6.0
2024-07-01T16:07:03.084070 <6>[    1.262724] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
2024-07-01T16:07:03.086845 <6>[    1.265712] pnp: PnP ACPI: disabled
2024-07-01T16:07:03.151967 <6>[    1.330758] NET: Registered PF_INET protocol family
2024-07-01T16:07:03.154167 <6>[    1.332963] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
2024-07-01T16:07:03.161245 <6>[    1.340086] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
2024-07-01T16:07:03.161400 <6>[    1.340422] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
2024-07-01T16:07:03.161674 <6>[    1.340663] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
2024-07-01T16:07:03.162372 <6>[    1.341265] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
2024-07-01T16:07:03.163212 <6>[    1.342063] TCP: Hash tables configured (established 32768 bind 32768)
2024-07-01T16:07:03.165249 <6>[    1.344135] MPTCP token hash table entries: 4096 (order: 4, 98304 bytes, linear)
2024-07-01T16:07:03.165640 <6>[    1.344605] UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
2024-07-01T16:07:03.166056 <6>[    1.345057] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
2024-07-01T16:07:03.167303 <6>[    1.346178] NET: Registered PF_UNIX/PF_LOCAL protocol family
2024-07-01T16:07:03.170756 <6>[    1.349624] RPC: Registered named UNIX socket transport module.
2024-07-01T16:07:03.170912 <6>[    1.349836] RPC: Registered udp transport module.
2024-07-01T16:07:03.171030 <6>[    1.349992] RPC: Registered tcp transport module.
2024-07-01T16:07:03.171134 <6>[    1.350146] RPC: Registered tcp-with-tls transport module.
2024-07-01T16:07:03.171286 <6>[    1.350318] RPC: Registered tcp NFSv4.1 backchannel transport module.
2024-07-01T16:07:03.171647 <6>[    1.350602] PCI: CLS 0 bytes, default 64
2024-07-01T16:07:03.191130 <6>[    1.369977] kvm [1]: nv: 477 coarse grained trap handlers
2024-07-01T16:07:03.193703 <6>[    1.372559] kvm [1]: nv: 668 fine grained trap handlers
2024-07-01T16:07:03.195501 <6>[    1.374393] kvm [1]: IPA Size Limit: 52 bits
2024-07-01T16:07:03.196260 <6>[    1.375164] kvm [1]: GICv3: no GICV resource entry
2024-07-01T16:07:03.196379 <6>[    1.375424] kvm [1]: disabling GICv2 emulation
2024-07-01T16:07:03.196789 <6>[    1.375809] kvm [1]: GIC system register CPU interface enabled
2024-07-01T16:07:03.197808 <6>[    1.376665] kvm [1]: vgic interrupt IRQ9
2024-07-01T16:07:03.198416 <6>[    1.377347] kvm [1]: VHE mode initialized successfully
2024-07-01T16:07:03.206781 <5>[    1.385589] Initialise system trusted keyrings
2024-07-01T16:07:03.208529 <6>[    1.387415] workingset: timestamp_bits=42 max_order=20 bucket_order=0
2024-07-01T16:07:03.210923 <6>[    1.389832] squashfs: version 4.0 (2009/01/31) Phillip Lougher
2024-07-01T16:07:03.212983 <5>[    1.391938] NFS: Registering the id_resolver key type
2024-07-01T16:07:03.213294 <5>[    1.392312] Key type id_resolver registered
2024-07-01T16:07:03.213397 <5>[    1.392468] Key type id_legacy registered
2024-07-01T16:07:03.213809 <6>[    1.392836] nfs4filelayout_init: NFSv4 File Layout Driver Registering...
2024-07-01T16:07:03.214118 <6>[    1.393100] nfs4flexfilelayout_init: NFSv4 Flexfile Layout Driver Registering...
2024-07-01T16:07:03.215306 <6>[    1.394281] 9p: Installing v9fs 9p2000 file system support
2024-07-01T16:07:03.253625 <6>[    1.432487] NET: Registered PF_ALG protocol family
2024-07-01T16:07:03.253797 <5>[    1.432889] Key type asymmetric registered
2024-07-01T16:07:03.254114 <5>[    1.433087] Asymmetric key parser 'x509' registered
2024-07-01T16:07:03.254674 <6>[    1.433644] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244)
2024-07-01T16:07:03.254936 <6>[    1.433944] io scheduler mq-deadline registered
2024-07-01T16:07:03.255046 <6>[    1.434143] io scheduler kyber registered
2024-07-01T16:07:03.346162 <6>[    1.524939] pl061_gpio 9030000.pl061: PL061 GPIO chip registered
2024-07-01T16:07:03.365644 <6>[    1.544383] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:
2024-07-01T16:07:03.366606 <6>[    1.545243] pci-host-generic 4010000000.pcie:       IO 0x003eff0000..0x003effffff -> 0x0000000000
2024-07-01T16:07:03.367334 <6>[    1.546295] pci-host-generic 4010000000.pcie:      MEM 0x0010000000..0x003efeffff -> 0x0010000000
2024-07-01T16:07:03.367668 <6>[    1.546650] pci-host-generic 4010000000.pcie:      MEM 0x8000000000..0xffffffffff -> 0x8000000000
2024-07-01T16:07:03.368354 <4>[    1.547329] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits
2024-07-01T16:07:03.369249 <6>[    1.548034] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
2024-07-01T16:07:03.370809 <6>[    1.549778] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00
2024-07-01T16:07:03.371098 <6>[    1.550141] pci_bus 0000:00: root bus resource [bus 00-ff]
2024-07-01T16:07:03.371350 <6>[    1.550371] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
2024-07-01T16:07:03.371542 <6>[    1.550576] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
2024-07-01T16:07:03.371748 <6>[    1.550776] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
2024-07-01T16:07:03.373078 <6>[    1.552045] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
2024-07-01T16:07:03.376802 <6>[    1.555739] pci 0000:00:01.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
2024-07-01T16:07:03.377161 <6>[    1.556220] pci 0000:00:01.0: BAR 0 [io  0x0000-0x001f]
2024-07-01T16:07:03.377449 <6>[    1.556460] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]
2024-07-01T16:07:03.377846 <6>[    1.556806] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]
2024-07-01T16:07:03.381470 <6>[    1.560395] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned
2024-07-01T16:07:03.381855 <6>[    1.560872] pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned
2024-07-01T16:07:03.382077 <6>[    1.561120] pci 0000:00:01.0: BAR 0 [io  0x1000-0x101f]: assigned
2024-07-01T16:07:03.607093 <6>[    1.785900] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
2024-07-01T16:07:03.651877 <6>[    1.830709] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
2024-07-01T16:07:03.677733 <6>[    1.856570] msm_serial: driver initialized
2024-07-01T16:07:03.680823 <6>[    1.859662] SuperH (H)SCI(F) driver initialized
2024-07-01T16:07:03.681958 <6>[    1.860808] STM32 USART driver initialized
2024-07-01T16:07:03.732271 <6>[    1.911103] loop: module loaded
2024-07-01T16:07:03.733091 <6>[    1.911944] virtio_blk virtio0: 1/0/0 default/read/poll queues
2024-07-01T16:07:03.736638 <5>[    1.915484] virtio_blk virtio0: [vda] 6293440 512-byte logical blocks (3.22 GB/3.00 GiB)
2024-07-01T16:07:03.756903 <6>[    1.935748] megasas: 07.727.03.00-rc1
2024-07-01T16:07:03.768865 <5>[    1.947708] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]
2024-07-01T16:07:03.770413 <6>[    1.949219] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2024-07-01T16:07:03.771161 <6>[    1.950016] Intel/Sharp Extended Query Table at 0x0031
2024-07-01T16:07:03.772047 <6>[    1.950937] Using buffer write method
2024-07-01T16:07:03.772426 <7>[    1.951363] erase region 0: offset=0x0,size=0x40000,blocks=256
2024-07-01T16:07:03.772920 <5>[    1.951821] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]
2024-07-01T16:07:03.773786 <6>[    1.952637] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000
2024-07-01T16:07:03.774025 <6>[    1.953026] Intel/Sharp Extended Query Table at 0x0031
2024-07-01T16:07:03.774999 <6>[    1.953892] Using buffer write method
2024-07-01T16:07:03.775117 <7>[    1.954084] erase region 0: offset=0x0,size=0x40000,blocks=256
2024-07-01T16:07:03.775313 <5>[    1.954372] Concatenating MTD devices:
2024-07-01T16:07:03.775470 <5>[    1.954567] (0): "0.flash"
2024-07-01T16:07:03.775628 <5>[    1.954721] (1): "0.flash"
2024-07-01T16:07:03.775787 <5>[    1.954867] into device "0.flash"
2024-07-01T16:07:03.839927 <6>[    2.018784] thunder_xcv, ver 1.0
2024-07-01T16:07:03.840089 <6>[    2.019099] thunder_bgx, ver 1.0
2024-07-01T16:07:03.840458 <6>[    2.019387] nicpf, ver 1.0
2024-07-01T16:07:03.850023 <6>[    2.028935] hns3: Hisilicon Ethernet Network Driver for Hip08 Family - version
2024-07-01T16:07:03.850412 <6>[    2.029261] hns3: Copyright (c) 2017 Huawei Corporation.
2024-07-01T16:07:03.850923 <6>[    2.029886] hclge is initializing
2024-07-01T16:07:03.851187 <6>[    2.030208] e1000: Intel(R) PRO/1000 Network Driver
2024-07-01T16:07:03.851401 <6>[    2.030418] e1000: Copyright (c) 1999-2006 Intel Corporation.
2024-07-01T16:07:03.851790 <6>[    2.030788] e1000e: Intel(R) PRO/1000 Network Driver
2024-07-01T16:07:03.851940 <6>[    2.030966] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
2024-07-01T16:07:03.852323 <6>[    2.031337] igb: Intel(R) Gigabit Ethernet Network Driver
2024-07-01T16:07:03.852505 <6>[    2.031548] igb: Copyright (c) 2007-2014 Intel Corporation.
2024-07-01T16:07:03.852888 <6>[    2.031895] igbvf: Intel(R) Gigabit Virtual Function Network Driver
2024-07-01T16:07:03.853073 <6>[    2.032109] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.
2024-07-01T16:07:03.855975 <6>[    2.034799] sky2: driver version 1.30
2024-07-01T16:07:03.867533 <6>[    2.046298] VFIO - User Level meta-driver version: 0.3
2024-07-01T16:07:03.917745 <6>[    2.096553] usbcore: registered new interface driver usb-storage
2024-07-01T16:07:03.947782 <6>[    2.126613] rtc-pl031 9010000.pl031: registered as rtc0
2024-07-01T16:07:03.948840 <6>[    2.127538] rtc-pl031 9010000.pl031: setting system clock to 2024-07-01T16:07:03 UTC (1719850023)
2024-07-01T16:07:03.954341 <6>[    2.133259] i2c_dev: i2c /dev entries driver
2024-07-01T16:07:04.011305 <6>[    2.190223] sdhci: Secure Digital Host Controller Interface driver
2024-07-01T16:07:04.011460 <6>[    2.190508] sdhci: Copyright(c) Pierre Ossman
2024-07-01T16:07:04.016967 <6>[    2.195903] Synopsys Designware Multimedia Card Interface Driver
2024-07-01T16:07:04.024490 <6>[    2.203422] sdhci-pltfm: SDHCI platform and OF driver helper
2024-07-01T16:07:04.038950 <6>[    2.217905] ledtrig-cpu: registered to indicate activity on CPUs
2024-07-01T16:07:04.066788 <6>[    2.245709] usbcore: registered new interface driver usbhid
2024-07-01T16:07:04.066917 <6>[    2.245971] usbhid: USB HID core driver
2024-07-01T16:07:04.091283 <6>[    2.270180] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available
2024-07-01T16:07:04.099057 <6>[    2.277977]  cs_system_cfg: CoreSight Configuration manager initialised
2024-07-01T16:07:04.135087 <6>[    2.313963] NET: Registered PF_INET6 protocol family
2024-07-01T16:07:04.145020 <6>[    2.323912] Segment Routing with IPv6
2024-07-01T16:07:04.145258 <6>[    2.324298] In-situ OAM (IOAM) with IPv6
2024-07-01T16:07:04.146126 <6>[    2.325026] NET: Registered PF_PACKET protocol family
2024-07-01T16:07:04.147677 <6>[    2.326572] 9pnet: Installing 9P2000 support
2024-07-01T16:07:04.154181 <5>[    2.333040] Key type dns_resolver registered
2024-07-01T16:07:04.222104 <6>[    2.400936] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
2024-07-01T16:07:04.224165 <6>[    2.403005] registered taskstats version 1
2024-07-01T16:07:04.225562 <5>[    2.404411] Loading compiled-in X.509 certificates
2024-07-01T16:07:04.274077 <6>[    2.452924] Demotion targets for Node 0: null
2024-07-01T16:07:04.284488 <6>[    2.463338] input: gpio-keys as /devices/platform/gpio-keys/input/input0
2024-07-01T16:07:04.293858 <6>[    2.472660] clk: Disabling unused clocks
2024-07-01T16:07:04.294839 <6>[    2.473672] PM: genpd: Disabling unused power domains
2024-07-01T16:07:04.295870 <6>[    2.474736] ALSA device list:
2024-07-01T16:07:04.296281 <6>[    2.475163]   No soundcards found.
2024-07-01T16:07:04.346200 <6>[    2.524701] EXT4-fs (vda): mounted filesystem 9330134b-34af-4f47-bfd3-464d81468f98 r/w with ordered data mode. Quota mode: none.
2024-07-01T16:07:04.347189 <6>[    2.526072] VFS: Mounted root (ext4 filesystem) on device 254:0.
2024-07-01T16:07:04.350305 <6>[    2.529159] devtmpfs: mounted
2024-07-01T16:07:04.408541 <6>[    2.587382] Freeing unused kernel memory: 3200K
2024-07-01T16:07:04.409333 <6>[    2.588208] Run /sbin/init as init process
2024-07-01T16:07:04.409488 <7>[    2.588448]   with arguments:
2024-07-01T16:07:04.409618 <7>[    2.588589]     /sbin/init
2024-07-01T16:07:04.409758 <7>[    2.588708]     verbose
2024-07-01T16:07:04.409860 <7>[    2.588838]   with environment:
2024-07-01T16:07:04.409990 <7>[    2.588967]     HOME=/
2024-07-01T16:07:04.410090 <7>[    2.589073]     TERM=linux
2024-07-01T16:07:04.893730 c[!p]104[?7h
2024-07-01T16:07:04.894116 Welcome to [1mDebian GNU/Linux trixie/sid[0m!
2024-07-01T16:07:04.894199 

2024-07-01T16:07:07.468876 [[0;32m  OK  [0m] Created slice [0;1;39msystem-getty.slice[0m - Slice /system/getty.

2024-07-01T16:07:07.477244 [[0;32m  OK  [0m] Created slice [0;1;39msystem-modprobe.slice[0m - Slice /system/modprobe.

2024-07-01T16:07:07.485144 [[0;32m  OK  [0m] Created slice [0;1;39msystem-serial\x2dget…slice[0m - Slice /system/serial-getty.

2024-07-01T16:07:07.491846 [[0;32m  OK  [0m] Created slice [0;1;39muser.slice[0m - User and Session Slice.

2024-07-01T16:07:07.495590 [[0;32m  OK  [0m] Started [0;1;39msystemd-ask-password-conso…[0mequests to Console Directory Watch.

2024-07-01T16:07:07.497863 [[0;32m  OK  [0m] Started [0;1;39msystemd-ask-password-wall.…[0md Requests to Wall Directory Watch.

2024-07-01T16:07:07.500525          Expecting device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0...

2024-07-01T16:07:07.502018 [[0;32m  OK  [0m] Reached target [0;1;39mcryptsetup.target[0m - Local Encrypted Volumes.

2024-07-01T16:07:07.503530 [[0;32m  OK  [0m] Reached target [0;1;39mintegritysetup.targ…[0m Local Integrity Protected Volumes.

2024-07-01T16:07:07.504551 [[0;32m  OK  [0m] Reached target [0;1;39mpaths.target[0m - Path Units.

2024-07-01T16:07:07.505767 [[0;32m  OK  [0m] Reached target [0;1;39mremote-fs.target[0m - Remote File Systems.

2024-07-01T16:07:07.507111 [[0;32m  OK  [0m] Reached target [0;1;39mslices.target[0m - Slice Units.

2024-07-01T16:07:07.508358 [[0;32m  OK  [0m] Reached target [0;1;39mswap.target[0m - Swaps.

2024-07-01T16:07:07.509836 [[0;32m  OK  [0m] Reached target [0;1;39mveritysetup.target[0m - Local Verity Protected Volumes.

2024-07-01T16:07:07.524367 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-creds.socket[0m - Credential Encryption/Decryption.

2024-07-01T16:07:07.527605 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-initctl.socke…[0m- initctl Compatibility Named Pipe.

2024-07-01T16:07:07.531350 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-journald-dev-…socket[0m - Journal Socket (/dev/log).

2024-07-01T16:07:07.534521 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-journald.socket[0m - Journal Sockets.

2024-07-01T16:07:07.538196 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-udevd-control.socket[0m - udev Control Socket.

2024-07-01T16:07:07.540970 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-udevd-kernel.socket[0m - udev Kernel Socket.

2024-07-01T16:07:07.581011          Mounting [0;1;39mdev-hugepages.mount[0m - Huge Pages File System...

2024-07-01T16:07:07.620645          Mounting [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System...

2024-07-01T16:07:07.660274          Mounting [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock...

2024-07-01T16:07:07.715874          Mounting [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System...

2024-07-01T16:07:07.788009          Mounting [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System...

2024-07-01T16:07:07.860236          Mounting [0;1;39mtmp.mount[0m - Temporary Directory /tmp...

2024-07-01T16:07:07.946335          Starting [0;1;39mkmod-static-nodes.service[0m…eate List of Static Device Nodes...

2024-07-01T16:07:08.033510          Starting [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs...

2024-07-01T16:07:08.148899          Starting [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod...

2024-07-01T16:07:08.253167          Starting [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm...

2024-07-01T16:07:08.336960          Starting [0;1;39mmodprobe@efi_pstore.servi…[0m - Load Kernel Module efi_pstore...

2024-07-01T16:07:08.481498          Starting [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse...

2024-07-01T16:07:08.626297          Starting [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop...

2024-07-01T16:07:08.713290 <6>[    6.892111] fuse: init (API version 7.40)
2024-07-01T16:07:08.765067 <6>[    6.943847] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
2024-07-01T16:07:08.797322          Starting [0;1;39msystemd-journald.service[0m - Journal Service...

2024-07-01T16:07:08.901192          Starting [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules...

2024-07-01T16:07:09.013097          Starting [0;1;39msystemd-remount-fs.servic…[0munt Root and Kernel File Systems...

2024-07-01T16:07:09.076994          Starting [0;1;39msystemd-udev-load-credent…[0mLoad udev Rules from Credentials...

2024-07-01T16:07:09.165434          Starting [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices...

2024-07-01T16:07:09.376176 [[0;32m  OK  [0m] Mounted [0;1;39mdev-hugepages.mount[0m - Huge Pages File System.

2024-07-01T16:07:09.386285 [[0;32m  OK  [0m] Mounted [0;1;39mdev-mqueue.mount[0m - POSIX Message Queue File System.

2024-07-01T16:07:09.424532 [[0;32m  OK  [0m] Mounted [0;1;39mrun-lock.mount[0m - Legacy Locks Directory /run/lock.

2024-07-01T16:07:09.437350 [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-debug.mount[0m - Kernel Debug File System.

2024-07-01T16:07:09.445013 [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-tracing.mount[0m - Kernel Trace File System.

2024-07-01T16:07:09.452813 [[0;32m  OK  [0m] Mounted [0;1;39mtmp.mount[0m - Temporary Directory /tmp.

2024-07-01T16:07:09.503247 [[0;32m  OK  [0m] Finished [0;1;39mkmod-static-nodes.service[0m…Create List of Static Device Nodes.

2024-07-01T16:07:09.583711 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@configfs.service[0m - Load Kernel Module configfs.

2024-07-01T16:07:09.616404 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@dm_mod.service[0m - Load Kernel Module dm_mod.

2024-07-01T16:07:09.648416 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@drm.service[0m - Load Kernel Module drm.

2024-07-01T16:07:09.692043 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@efi_pstore.service[0m - Load Kernel Module efi_pstore.

2024-07-01T16:07:09.724122 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@fuse.service[0m - Load Kernel Module fuse.

2024-07-01T16:07:09.752676 [[0;32m  OK  [0m] Finished [0;1;39mmodprobe@loop.service[0m - Load Kernel Module loop.

2024-07-01T16:07:09.772829 [[0;32m  OK  [0m] Finished [0;1;39msystemd-modules-load.service[0m - Load Kernel Modules.

2024-07-01T16:07:09.791712 [[0;32m  OK  [0m] Finished [0;1;39msystemd-remount-fs.servic…[0mmount Root and Kernel File Systems.

2024-07-01T16:07:09.860328          Mounting [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System...

2024-07-01T16:07:09.912281          Mounting [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System...

2024-07-01T16:07:09.992807          Starting [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed...

2024-07-01T16:07:10.121217          Starting [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables...

2024-07-01T16:07:10.245159          Starting [0;1;39msystemd-tmpfiles-setup-de…[0m Device Nodes in /dev gracefully...

2024-07-01T16:07:10.296443 [[0;32m  OK  [0m] Started [0;1;39msystemd-journald.service[0m - Journal Service.

2024-07-01T16:07:10.486010 [[0;32m  OK  [0m] Finished [0;1;39msystemd-udev-load-credent…[0m- Load udev Rules from Credentials.

2024-07-01T16:07:10.562215 [[0;32m  OK  [0m] Mounted [0;1;39msys-fs-fuse-connections.mount[0m - FUSE Control File System.

2024-07-01T16:07:10.777318 [[0;32m  OK  [0m] Mounted [0;1;39msys-kernel-config.mount[0m - Kernel Configuration File System.

2024-07-01T16:07:10.819492 [[0;32m  OK  [0m] Finished [0;1;39msystemd-random-seed.service[0m - Load/Save OS Random Seed.

2024-07-01T16:07:11.091810 [[0;32m  OK  [0m] Finished [0;1;39msystemd-sysctl.service[0m - Apply Kernel Variables.

2024-07-01T16:07:11.315553 [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mic Device Nodes in /dev gracefully.

2024-07-01T16:07:11.385508          Starting [0;1;39msystemd-journal-flush.ser…[0msh Journal to Persistent Storage...

2024-07-01T16:07:11.445272          Starting [0;1;39msystemd-sysusers.service[0m - Create System Users...

2024-07-01T16:07:11.979534 [[0;32m  OK  [0m] Finished [0;1;39msystemd-sysusers.service[0m - Create System Users.

2024-07-01T16:07:11.989867 [[0;32m  OK  [0m] Finished [0;1;39msystemd-journal-flush.ser…[0mlush Journal to Persistent Storage.

2024-07-01T16:07:12.044728          Starting [0;1;39msystemd-tmpfiles-setup-de…[0meate Static Device Nodes in /dev...

2024-07-01T16:07:12.383402 [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup-de…[0mCreate Static Device Nodes in /dev.

2024-07-01T16:07:12.390895 [[0;32m  OK  [0m] Reached target [0;1;39mlocal-fs-pre.target[0m…Preparation for Local File Systems.

2024-07-01T16:07:12.392400 [[0;32m  OK  [0m] Reached target [0;1;39mlocal-fs.target[0m - Local File Systems.

2024-07-01T16:07:12.411084 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-sysext.socket[0m… System Extension Image Management.

2024-07-01T16:07:12.444831          Starting [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache...

2024-07-01T16:07:12.521295          Starting [0;1;39msystemd-tmpfiles-setup.se…[0me Volatile Files and Directories...

2024-07-01T16:07:12.593151          Starting [0;1;39msystemd-udevd.service[0m - R…ager for Device Events and Files...

2024-07-01T16:07:13.806845 [[0;32m  OK  [0m] Finished [0;1;39msystemd-tmpfiles-setup.se…[0mate Volatile Files and Directories.

2024-07-01T16:07:13.888870          Starting [0;1;39msystemd-journal-catalog-u…ervice[0m - Rebuild Journal Catalog...

2024-07-01T16:07:13.996472          Starting [0;1;39msystemd-update-utmp.servi…[0mord System Boot/Shutdown in UTMP...

2024-07-01T16:07:14.021182 [[0;32m  OK  [0m] Started [0;1;39msystemd-udevd.service[0m - Ru…anager for Device Events and Files.

2024-07-01T16:07:14.151403 [[0;32m  OK  [0m] Finished [0;1;39mldconfig.service[0m - Rebuild Dynamic Linker Cache.

2024-07-01T16:07:14.543646 [[0;32m  OK  [0m] Finished [0;1;39msystemd-update-utmp.servi…[0mecord System Boot/Shutdown in UTMP.

2024-07-01T16:07:14.743685 [[0;32m  OK  [0m] Finished [0;1;39msystemd-journal-catalog-u….service[0m - Rebuild Journal Catalog.

2024-07-01T16:07:14.785144          Starting [0;1;39msystemd-update-done.service[0m - Update is Completed...

2024-07-01T16:07:15.003579 [[0;32m  OK  [0m] Finished [0;1;39msystemd-update-done.service[0m - Update is Completed.

2024-07-01T16:07:16.862567 [[0;32m  OK  [0m] Finished [0;1;39msystemd-udev-trigger.service[0m - Coldplug All udev Devices.

2024-07-01T16:07:16.871560 [[0;32m  OK  [0m] Reached target [0;1;39msysinit.target[0m - System Initialization.

2024-07-01T16:07:16.877059 [[0;32m  OK  [0m] Started [0;1;39mapt-daily.timer[0m - Daily apt download activities.

2024-07-01T16:07:16.879720 [[0;32m  OK  [0m] Started [0;1;39mapt-daily-upgrade.timer[0m - …y apt upgrade and clean activities.

2024-07-01T16:07:16.882087 [[0;32m  OK  [0m] Started [0;1;39mdpkg-db-backup.timer[0m - Daily dpkg database backup timer.

2024-07-01T16:07:16.885363 [[0;32m  OK  [0m] Started [0;1;39me2scrub_all.timer[0m - Period…Metadata Check for All Filesystems.

2024-07-01T16:07:16.891609 [[0;32m  OK  [0m] Started [0;1;39mfstrim.timer[0m - Discard unused filesystem blocks once a week.

2024-07-01T16:07:16.893166 [[0;32m  OK  [0m] Started [0;1;39msystemd-tmpfiles-clean.tim…[0my Cleanup of Temporary Directories.

2024-07-01T16:07:16.894878 [[0;32m  OK  [0m] Reached target [0;1;39mtimers.target[0m - Timer Units.

2024-07-01T16:07:16.897062 [[0;32m  OK  [0m] Listening on [0;1;39mdbus.socket[0m - D-Bus System Message Bus Socket.

2024-07-01T16:07:16.900534 [[0;32m  OK  [0m] Listening on [0;1;39msystemd-hostnamed.socket[0m - Hostname Service Socket.

2024-07-01T16:07:16.907340 [[0;32m  OK  [0m] Reached target [0;1;39msockets.target[0m - Socket Units.

2024-07-01T16:07:16.909078 [[0;32m  OK  [0m] Reached target [0;1;39mbasic.target[0m - Basic System.

2024-07-01T16:07:16.944981          Starting [0;1;39mdbus.service[0m - D-Bus System Message Bus...

2024-07-01T16:07:17.094533          Starting [0;1;39me2scrub_reap.service[0m - Re…ne ext4 Metadata Check Snapshots...

2024-07-01T16:07:17.269311          Starting [0;1;39msystemd-logind.service[0m - User Login Management...

2024-07-01T16:07:17.589130          Starting [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions...

2024-07-01T16:07:17.644336 [[0;32m  OK  [0m] Started [0;1;39mdbus.service[0m - D-Bus System Message Bus.

2024-07-01T16:07:18.232032 [[0;32m  OK  [0m] Finished [0;1;39msystemd-user-sessions.service[0m - Permit User Sessions.

2024-07-01T16:07:18.887874 [[0;32m  OK  [0m] Found device [0;1;39mdev-ttyAMA0.device[0m - /dev/ttyAMA0.

2024-07-01T16:07:19.052742 [[0;32m  OK  [0m] Started [0;1;39mgetty@tty1.service[0m - Getty on tty1.

2024-07-01T16:07:19.097203 [[0;32m  OK  [0m] Started [0;1;39mserial-getty@ttyAMA0.service[0m - Serial Getty on ttyAMA0.

2024-07-01T16:07:19.115174 [[0;32m  OK  [0m] Reached target [0;1;39mgetty.target[0m - Login Prompts.

2024-07-01T16:07:19.125458 [[0;32m  OK  [0m] Started [0;1;39msystemd-logind.service[0m - User Login Management.

2024-07-01T16:07:19.151483 [[0;32m  OK  [0m] Finished [0;1;39me2scrub_reap.service[0m - Re…line ext4 Metadata Check Snapshots.

2024-07-01T16:07:19.298172 [[0;32m  OK  [0m] Reached target [0;1;39mmulti-user.target[0m - Multi-User System.

2024-07-01T16:07:19.305530 [[0;32m  OK  [0m] Reached target [0;1;39mgraphical.target[0m - Graphical Interface.

2024-07-01T16:07:19.358317          Starting [0;1;39msystemd-update-utmp-runle…[0m- Record Runlevel Change in UTMP...

2024-07-01T16:07:19.728249 [[0;32m  OK  [0m] Finished [0;1;39msystemd-update-utmp-runle…e[0m - Record Runlevel Change in UTMP.

2024-07-01T16:07:20.994574 

2024-07-01T16:07:20.995069 Debian GNU/Linux trixie/sid runner-vwmj3eza-project-40964107-concurrent-3 ttyAMA0
2024-07-01T16:07:20.995182 
2024-07-01T16:07:21.098083 runner-vwmj3eza-project-40964107-concurrent-3 login: root

2024-07-01T16:07:21.465335 Linux runner-vwmj3eza-project-40964107-concurrent-3 6.10.0-rc6 #1 SMP PREEMPT @1719821472 aarch64
2024-07-01T16:07:21.470054 
2024-07-01T16:07:21.470889 The programs included with the Debian GNU/Linux system are free software;
2024-07-01T16:07:21.471225 the exact distribution terms for each program are described in the
2024-07-01T16:07:21.471389 individual files in /usr/share/doc/*/copyright.
2024-07-01T16:07:21.471508 
2024-07-01T16:07:21.471866 Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
2024-07-01T16:07:21.471980 permitted by applicable law.
2024-07-01T16:07:25.130099 [?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# mkdir -p /mnt/tuxrun
2024-07-01T16:07:25.287209 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# mount -t 9p -o trans=virtio tuxrun /mnt/tuxrun
2024-07-01T16:07:25.459657 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# 
2024-07-01T16:07:25.563939 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# #
2024-07-01T16:07:25.668127 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# export SHELL=/bin/sh
2024-07-01T16:07:25.774930 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# . /lava-1/environment
2024-07-01T16:07:25.889755 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# /lava-1/bin/lava-test-runner /lava-1/0
2024-07-01T16:07:26.417283 [?2004l
+ export TESTRUN_ID=0_kvm-unit-tests
2024-07-01T16:07:26.418549 + cd /lava-1/0/tests/0_kvm-unit-tests
2024-07-01T16:07:26.427744 + cat uuid
2024-07-01T16:07:26.476211 + UUID=1_1.1.3.1
2024-07-01T16:07:26.477038 + set +x
2024-07-01T16:07:26.480685 <8>[   24.659468] <LAVA_SIGNAL_STARTRUN 0_kvm-unit-tests 1_1.1.3.1>
2024-07-01T16:07:26.484970 + cd ./automated/linux/kvm-unit-tests/
2024-07-01T16:07:26.492083 + ./kvm-unit-tests.sh -s True -m True -g master
2024-07-01T16:07:26.519498 + . ../../lib/sh-test-lib
2024-07-01T16:07:26.521764 + LANG=C
2024-07-01T16:07:26.522256 + export LANG
2024-07-01T16:07:26.533305 + export PATH=/lava-1/0/../bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/sbin:/usr/sbin:/usr/local/sbin
2024-07-01T16:07:26.536852 + kernel_config=
2024-07-01T16:07:26.545523 + pwd
2024-07-01T16:07:26.552392 + OUTPUT=/lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.552954 + RESULT_FILE=/lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output/result.txt
2024-07-01T16:07:26.553466 + RESULT_LOG=/lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output/result_log.txt
2024-07-01T16:07:26.553779 + SKIP_INSTALL=false
2024-07-01T16:07:26.554074 + SMP=true
2024-07-01T16:07:26.554376 + GIT_REF=master
2024-07-01T16:07:26.555141 + getopts s:m:g:h o
2024-07-01T16:07:26.555905 + SKIP_INSTALL=True
2024-07-01T16:07:26.556375 + getopts s:m:g:h o
2024-07-01T16:07:26.556664 + SMP=True
2024-07-01T16:07:26.557128 + getopts s:m:g:h o
2024-07-01T16:07:26.557418 + GIT_REF=master
2024-07-01T16:07:26.557892 + getopts s:m:g:h o
2024-07-01T16:07:26.558908 + check_root
2024-07-01T16:07:26.565205 + id -ru
2024-07-01T16:07:26.625873 + [ 0 -eq 0 ]
2024-07-01T16:07:26.627243 + return 0
2024-07-01T16:07:26.628731 + create_out_dir /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.630951 + [ -z /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output ]
2024-07-01T16:07:26.632359 + local OUTPUT=/lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.634328 + [ -d /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output ]
2024-07-01T16:07:26.636024 + mkdir -p /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.684233 + [ -d /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output ]
2024-07-01T16:07:26.685697 + info_msg About to run kvm unit tests ...
2024-07-01T16:07:26.687232 + local msg=About to run kvm unit tests ...
2024-07-01T16:07:26.688790 + [ -z About to run kvm unit tests ... ]
2024-07-01T16:07:26.690414 + printf INFO: %s\n About to run kvm unit tests ...
2024-07-01T16:07:26.692210 INFO: About to run kvm unit tests ...
2024-07-01T16:07:26.693551 + info_msg Output directory: /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.695212 + local msg=Output directory: /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.696993 + [ -z Output directory: /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output ]
2024-07-01T16:07:26.698201 + printf INFO: %s\n Output directory: /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.699168 INFO: Output directory: /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output
2024-07-01T16:07:26.700606 + [ True = True ]
2024-07-01T16:07:26.701680 + info_msg Dependency installation for kvm-unit-tests skipped
2024-07-01T16:07:26.702774 + local msg=Dependency installation for kvm-unit-tests skipped
2024-07-01T16:07:26.704048 + [ -z Dependency installation for kvm-unit-tests skipped ]
2024-07-01T16:07:26.705199 + printf INFO: %s\n Dependency installation for kvm-unit-tests skipped
2024-07-01T16:07:26.705750 INFO: Dependency installation for kvm-unit-tests skipped
2024-07-01T16:07:26.707432 + [ -f /opt/kvm-unit-tests/run_tests.sh ]
2024-07-01T16:07:26.716989 + cd /opt/kvm-unit-tests
2024-07-01T16:07:26.719073 + kvm_unit_tests_run_test
2024-07-01T16:07:26.720019 + info_msg running kvm unit tests ...
2024-07-01T16:07:26.720824 + local msg=running kvm unit tests ...
2024-07-01T16:07:26.722018 + [ -z running kvm unit tests ... ]
2024-07-01T16:07:26.723271 + printf INFO: %s\n running kvm unit tests ...
2024-07-01T16:07:26.723580 INFO: running kvm unit tests ...
2024-07-01T16:07:26.724449 + [ True = false ]
2024-07-01T16:07:26.734787 + ./run_tests.sh -a -t -v
2024-07-01T16:07:26.739854 + tee -a /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output/result_log.txt
2024-07-01T16:07:27.201159 TAP version 13
2024-07-01T16:07:41.548017 ok 1 - selftest-setup: selftest: setup: smp: number of CPUs matches expectation
2024-07-01T16:07:41.582941 ok 2 - selftest-setup: selftest: setup: mem: memory size matches expectation
2024-07-01T16:07:55.951827 ok 3 - selftest-vectors-kernel: selftest: vectors-kernel: und
2024-07-01T16:07:55.959929 ok 4 - selftest-vectors-kernel: selftest: vectors-kernel: svc
2024-07-01T16:07:55.969787 ok 5 - selftest-vectors-kernel: selftest: vectors-kernel: pabt
2024-07-01T16:08:09.838142 ok 6 - selftest-vectors-user: selftest: vectors-user: und
2024-07-01T16:08:09.854254 ok 7 - selftest-vectors-user: selftest: vectors-user: svc
2024-07-01T16:08:24.662697 ok 8 - selftest-smp: selftest: smp: MPIDR test on all CPUs
2024-07-01T16:08:39.072545 ok 9 - pci-test: pci: PCI test device passed 6/6 tests
2024-07-01T16:08:52.999569 ok 10 - pmu-cycle-counter: pmu: cycle-counter: Monotonically increasing cycle count
2024-07-01T16:08:53.351216 ok 11 - pmu-cycle-counter: pmu: cycle-counter: Cycle/instruction ratio
2024-07-01T16:09:07.079813 not ok 12 - pmu-event-introspection: pmu: pmu-event-introspection: Check required events are implemented
2024-07-01T16:09:21.277423 ok 13 - pmu-event-counter-config: pmu: pmu-event-counter-config: PMESELR/PMXEVTYPER/PMEVTYPERn
2024-07-01T16:09:21.290375 ok 14 - pmu-event-counter-config: pmu: pmu-event-counter-config: PMESELR/PMXEVCNTR/PMEVCNTRn
2024-07-01T16:09:21.320886 ok 15 - pmu-event-counter-config: pmu: pmu-event-counter-config: read of a counter programmed with unsupported event
2024-07-01T16:09:35.476174 ok 16 - pmu-basic-event-count: pmu: pmu-basic-event-count: 32-bit overflows: Skip test as event 0x8 is not supported # skip
2024-07-01T16:09:35.513872 ok 17 - pmu-basic-event-count: pmu: pmu-basic-event-count: 64-bit overflows: Skip test as event 0x8 is not supported # skip
2024-07-01T16:09:49.702917 ok 18 - pmu-mem-access: pmu: pmu-mem-access: 32-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:09:49.730694 ok 19 - pmu-mem-access: pmu: pmu-mem-access: 64-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:10:03.623671 ok 20 - pmu-mem-access-reliability: pmu: pmu-mem-access-reliability: 32-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:10:03.654607 ok 21 - pmu-mem-access-reliability: pmu: pmu-mem-access-reliability: 64-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:10:17.618606 ok 22 - pmu-sw-incr: pmu: pmu-sw-incr: 32-bit overflows: PWSYNC does not increment if PMCR.E is unset
2024-07-01T16:10:17.651248 ok 23 - pmu-sw-incr: pmu: pmu-sw-incr: 32-bit overflows: counter #0 after + 100 SW_INCR
2024-07-01T16:10:17.673404 ok 24 - pmu-sw-incr: pmu: pmu-sw-incr: 32-bit overflows: counter #1 after + 100 SW_INCR
2024-07-01T16:10:17.756288 ok 25 - pmu-sw-incr: pmu: pmu-sw-incr: 32-bit overflows: overflow on counter #0 after 100 SW_INCR
2024-07-01T16:10:17.855427 ok 26 - pmu-sw-incr: pmu: pmu-sw-incr: 64-bit overflows: PWSYNC does not increment if PMCR.E is unset
2024-07-01T16:10:17.900579 ok 27 - pmu-sw-incr: pmu: pmu-sw-incr: 64-bit overflows: counter #0 after + 100 SW_INCR
2024-07-01T16:10:17.935088 ok 28 - pmu-sw-incr: pmu: pmu-sw-incr: 64-bit overflows: counter #1 after + 100 SW_INCR
2024-07-01T16:10:18.023324 ok 29 - pmu-sw-incr: pmu: pmu-sw-incr: 64-bit overflows: overflow on counter #0 after 100 SW_INCR
2024-07-01T16:10:32.150654 <6>[  210.328198] perf: interrupt took too long (4266 > 2500), lowering kernel.perf_event_max_sample_rate to 46750
2024-07-01T16:10:32.204689 ok 30 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: CHAIN counter #1 incremented
2024-07-01T16:10:32.225328 ok 31 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: overflow recorded for chained incr #1
2024-07-01T16:10:32.275648 ok 32 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: CHAIN counter #1 set to 2
2024-07-01T16:10:32.321422 ok 33 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: overflow recorded for chained incr #2
2024-07-01T16:10:32.397065 ok 34 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: CHAIN counter #1 wrapped
2024-07-01T16:10:32.439010 ok 35 - pmu-chained-counters: pmu: pmu-chained-counters: 32-bit overflows: overflow on even and odd counters
2024-07-01T16:10:45.950886 ok 36 - pmu-chained-sw-incr: pmu: pmu-chained-sw-incr: 32-bit overflows: overflow and chain counter incremented after 100 SW_INCR/CHAIN
2024-07-01T16:10:46.018846 ok 37 - pmu-chained-sw-incr: pmu: pmu-chained-sw-incr: 32-bit overflows: expected overflows and values after 100 SW_INCR/CHAIN
2024-07-01T16:11:00.541286 ok 38 - pmu-chain-promotion: pmu: pmu-chain-promotion: 32-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:11:13.933963 ok 39 - pmu-overflow-interrupt: pmu: pmu-overflow-interrupt: 32-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:11:13.968381 ok 40 - pmu-overflow-interrupt: pmu: pmu-overflow-interrupt: 64-bit overflows: Skip test as event 0x13 is not supported # skip
2024-07-01T16:11:54.869173 ok 41 - gicv3-ipi: gicv3: ipi: self: Interrupts received
2024-07-01T16:11:54.869597 ok 42 - gicv3-ipi: gicv3: ipi: target-list: Interrupts received
2024-07-01T16:11:55.095277 ok 43 - gicv3-ipi: gicv3: ipi: broadcast: Interrupts received
2024-07-01T16:12:15.845805 ok 44 - gicv3-active: gicv3: active: self: Interrupts received
2024-07-01T16:12:29.766978 ok 45 - its-introspection: gicv3: its-introspection: GITS_IIDR is read-only
2024-07-01T16:12:29.791150 ok 46 - its-introspection: gicv3: its-introspection: GITS_TYPER is read-only
2024-07-01T16:12:29.816759 ok 47 - its-introspection: gicv3: its-introspection: ITS supports physical LPIs
2024-07-01T16:12:29.890763 ok 48 - its-introspection: gicv3: its-introspection: ID spaces
2024-07-01T16:12:29.933734 ok 49 - its-introspection: gicv3: its-introspection: detect device and collection BASER
2024-07-01T16:12:43.476921 ok 50 - its-trigger: gicv3: its-trigger: Test requires at least 4 vcpus # skip
2024-07-01T16:13:00.284077 ok 51 - its-migration: gicv3: its-migration: Test requires at least 4 vcpus # skip
2024-07-01T16:13:16.699352 ok 52 - its-pending-migration: gicv3: its-pending-migration: Test requires at least 4 vcpus # skip
2024-07-01T16:13:32.948932 ok 53 - its-migrate-unmapped-collection: gicv3: its-migrate-unmapped-collection: Test requires at least 4 vcpus # skip
2024-07-01T16:13:46.807537 ok 54 - psci: psci: invalid-function
2024-07-01T16:13:46.821430 ok 55 - psci: psci: affinity-info-on
2024-07-01T16:13:46.831198 ok 56 - psci: psci: affinity-info-off
2024-07-01T16:13:46.878198 ok 57 - psci: psci: cpu-on
2024-07-01T16:13:47.027453 ok 58 - psci: psci: cpu-off
2024-07-01T16:14:01.508732 ok 59 - timer: vtimer-busy-loop: latency within 10 ms
2024-07-01T16:14:01.513433 ok 60 - timer: vtimer-busy-loop: interrupt received
2024-07-01T16:14:01.739367 ok 61 - timer: vtimer-busy-loop: not pending before
2024-07-01T16:14:01.965545 ok 62 - timer: vtimer-busy-loop: interrupt signal pending
2024-07-01T16:14:01.984710 ok 63 - timer: vtimer-busy-loop: no interrupt when timer is disabled
2024-07-01T16:14:02.214709 ok 64 - timer: vtimer-busy-loop: interrupt signal no longer pending
2024-07-01T16:14:02.435804 ok 65 - timer: vtimer-busy-loop: interrupt signal not pending
2024-07-01T16:14:02.491553 ok 66 - timer: vtimer-busy-loop: interrupt received after TVAL/WFI
2024-07-01T16:14:02.513192 ok 67 - timer: vtimer-busy-loop: timer has expired
2024-07-01T16:14:02.652488 ok 68 - timer: ptimer-busy-loop: latency within 10 ms
2024-07-01T16:14:02.670601 ok 69 - timer: ptimer-busy-loop: interrupt received
2024-07-01T16:14:02.898035 ok 70 - timer: ptimer-busy-loop: not pending before
2024-07-01T16:14:03.128050 ok 71 - timer: ptimer-busy-loop: interrupt signal pending
2024-07-01T16:14:03.146035 ok 72 - timer: ptimer-busy-loop: no interrupt when timer is disabled
2024-07-01T16:14:03.372391 ok 73 - timer: ptimer-busy-loop: interrupt signal no longer pending
2024-07-01T16:14:03.588832 ok 74 - timer: ptimer-busy-loop: interrupt signal not pending
2024-07-01T16:14:03.626692 ok 75 - timer: ptimer-busy-loop: interrupt received after TVAL/WFI
2024-07-01T16:14:03.635122 ok 76 - timer: ptimer-busy-loop: timer has expired
2024-07-01T16:15:14.117607 ok 77 - cache: IDC-DIC: code generation
2024-07-01T16:15:28.411511 ok 78 - debug-bp: bp: hw breakpoint: 0
2024-07-01T16:15:28.420095 ok 79 - debug-bp: bp: hw breakpoint: 1
2024-07-01T16:15:28.420301 ok 80 - debug-bp: bp: hw breakpoint: 2
2024-07-01T16:15:28.426525 ok 81 - debug-bp: bp: hw breakpoint: 3
2024-07-01T16:15:28.438186 ok 82 - debug-bp: bp: hw breakpoint: 4
2024-07-01T16:15:28.452364 ok 83 - debug-bp: bp: hw breakpoint: 5
2024-07-01T16:15:46.663592 ok 84 - debug-bp-migration: bp-migration: brps match after migrate
2024-07-01T16:15:46.665820 ok 85 - debug-bp-migration: bp-migration: hw breakpoint: 0
2024-07-01T16:15:46.667924 ok 86 - debug-bp-migration: bp-migration: hw breakpoint: 1
2024-07-01T16:15:46.669897 ok 87 - debug-bp-migration: bp-migration: hw breakpoint: 2
2024-07-01T16:15:46.672661 ok 88 - debug-bp-migration: bp-migration: hw breakpoint: 3
2024-07-01T16:15:46.676664 ok 89 - debug-bp-migration: bp-migration: hw breakpoint: 4
2024-07-01T16:15:46.677003 ok 90 - debug-bp-migration: bp-migration: hw breakpoint: 5
2024-07-01T16:16:01.324956 ok 91 - debug-wp: wp: watchpoint received: 0
2024-07-01T16:16:01.327872 ok 92 - debug-wp: wp: watchpoint data: 0
2024-07-01T16:16:01.329567 ok 93 - debug-wp: wp: watchpoint received: 1
2024-07-01T16:16:01.338663 ok 94 - debug-wp: wp: watchpoint data: 1
2024-07-01T16:16:01.353669 ok 95 - debug-wp: wp: watchpoint received: 2
2024-07-01T16:16:01.362592 ok 96 - debug-wp: wp: watchpoint data: 2
2024-07-01T16:16:01.374608 ok 97 - debug-wp: wp: watchpoint received: 3
2024-07-01T16:16:01.384126 ok 98 - debug-wp: wp: watchpoint data: 3
2024-07-01T16:16:19.195038 ok 99 - debug-wp-migration: wp-migration: wrps match after migrate
2024-07-01T16:16:19.197010 ok 100 - debug-wp-migration: wp-migration: watchpoint received: 0
2024-07-01T16:16:19.210863 ok 101 - debug-wp-migration: wp-migration: watchpoint data: 0
2024-07-01T16:16:19.211180 ok 102 - debug-wp-migration: wp-migration: watchpoint received: 1
2024-07-01T16:16:19.214160 ok 103 - debug-wp-migration: wp-migration: watchpoint data: 1
2024-07-01T16:16:19.217554 ok 104 - debug-wp-migration: wp-migration: watchpoint received: 2
2024-07-01T16:16:19.219986 ok 105 - debug-wp-migration: wp-migration: watchpoint data: 2
2024-07-01T16:16:19.222811 ok 106 - debug-wp-migration: wp-migration: watchpoint received: 3
2024-07-01T16:16:19.227259 ok 107 - debug-wp-migration: wp-migration: watchpoint data: 3
2024-07-01T16:16:33.323158 ok 108 - debug-sstep: ss: single step
2024-07-01T16:16:51.546672 ok 109 - debug-sstep-migration: ss-migration: single step
2024-07-01T16:16:52.469060 1..109
2024-07-01T16:16:52.497539 + cd -
2024-07-01T16:16:52.499072 /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests
2024-07-01T16:16:52.499763 + parse_output
2024-07-01T16:16:52.507761 + tee -a /lava-1/0/tests/0_kvm-unit-tests/automated/linux/kvm-unit-tests/output/result.txt
2024-07-01T16:16:52.509773 + ./parse-output.py
2024-07-01T16:16:52.859620 selftest-setup-selftest-setup-smp-number-of-CPUs-matches-expectation pass
2024-07-01T16:16:52.860114 selftest-setup-selftest-setup-mem-memory-size-matches-expectation pass
2024-07-01T16:16:52.860425 selftest-vectors-kernel-selftest-vectors-kernel-und pass
2024-07-01T16:16:52.860764 selftest-vectors-kernel-selftest-vectors-kernel-svc pass
2024-07-01T16:16:52.861208 selftest-vectors-kernel-selftest-vectors-kernel-pabt pass
2024-07-01T16:16:52.861539 selftest-vectors-user-selftest-vectors-user-und pass
2024-07-01T16:16:52.861802 selftest-vectors-user-selftest-vectors-user-svc pass
2024-07-01T16:16:52.862291 selftest-smp-selftest-smp-MPIDR-test-on-all-CPUs pass
2024-07-01T16:16:52.862773 pci-test-pci-PCI-test-device-passed-66-tests pass
2024-07-01T16:16:52.863206 pmu-cycle-counter-pmu-cycle-counter-Monotonically-increasing-cycle-count pass
2024-07-01T16:16:52.863589 pmu-cycle-counter-pmu-cycle-counter-Cycleinstruction-ratio pass
2024-07-01T16:16:52.864171 pmu-event-introspection-pmu-pmu-event-introspection-Check-required-events-are-implemented fail
2024-07-01T16:16:52.864676 pmu-event-counter-config-pmu-pmu-event-counter-config-PMESELRPMXEVTYPERPMEVTYPERn pass
2024-07-01T16:16:52.865199 pmu-event-counter-config-pmu-pmu-event-counter-config-PMESELRPMXEVCNTRPMEVCNTRn pass
2024-07-01T16:16:52.865812 pmu-event-counter-config-pmu-pmu-event-counter-config-read-of-a-counter-programmed-with-unsupported-event pass
2024-07-01T16:16:52.866433 pmu-basic-event-count-pmu-pmu-basic-event-count-32-bit-overflows-Skip-test-as-event-0x8-is-not-supported skip
2024-07-01T16:16:52.866995 pmu-basic-event-count-pmu-pmu-basic-event-count-64-bit-overflows-Skip-test-as-event-0x8-is-not-supported skip
2024-07-01T16:16:52.867462 pmu-mem-access-pmu-pmu-mem-access-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.868005 pmu-mem-access-pmu-pmu-mem-access-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.868722 pmu-mem-access-reliability-pmu-pmu-mem-access-reliability-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.869445 pmu-mem-access-reliability-pmu-pmu-mem-access-reliability-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.870047 pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-PWSYNC-does-not-increment-if-PMCRE-is-unset pass
2024-07-01T16:16:52.870628 pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-counter-0-after-100-SW_INCR pass
2024-07-01T16:16:52.871202 pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-counter-1-after-100-SW_INCR pass
2024-07-01T16:16:52.871709 pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-overflow-on-counter-0-after-100-SW_INCR pass
2024-07-01T16:16:52.872339 pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-PWSYNC-does-not-increment-if-PMCRE-is-unset pass
2024-07-01T16:16:52.873019 pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-counter-0-after-100-SW_INCR pass
2024-07-01T16:16:52.873546 pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-counter-1-after-100-SW_INCR pass
2024-07-01T16:16:52.874053 pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-overflow-on-counter-0-after-100-SW_INCR pass
2024-07-01T16:16:52.874797 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-incremented pass
2024-07-01T16:16:52.875563 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-recorded-for-chained-incr-1 pass
2024-07-01T16:16:52.876074 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-set-to-2 pass
2024-07-01T16:16:52.876832 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-recorded-for-chained-incr-2 pass
2024-07-01T16:16:52.877426 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-wrapped pass
2024-07-01T16:16:52.878086 pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-on-even-and-odd-counters pass
2024-07-01T16:16:52.879079 pmu-chained-sw-incr-pmu-pmu-chained-sw-incr-32-bit-overflows-overflow-and-chain-counter-incremented-after-100-SW_INCRCHAIN pass
2024-07-01T16:16:52.879898 pmu-chained-sw-incr-pmu-pmu-chained-sw-incr-32-bit-overflows-expected-overflows-and-values-after-100-SW_INCRCHAIN pass
2024-07-01T16:16:52.880565 pmu-chain-promotion-pmu-pmu-chain-promotion-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.881333 pmu-overflow-interrupt-pmu-pmu-overflow-interrupt-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.882046 pmu-overflow-interrupt-pmu-pmu-overflow-interrupt-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported skip
2024-07-01T16:16:52.882405 gicv3-ipi-gicv3-ipi-self-Interrupts-received pass
2024-07-01T16:16:52.882903 gicv3-ipi-gicv3-ipi-target-list-Interrupts-received pass
2024-07-01T16:16:52.883254 gicv3-ipi-gicv3-ipi-broadcast-Interrupts-received pass
2024-07-01T16:16:52.883408 gicv3-active-gicv3-active-self-Interrupts-received pass
2024-07-01T16:16:52.884096 its-introspection-gicv3-its-introspection-GITS_IIDR-is-read-only pass
2024-07-01T16:16:52.884592 its-introspection-gicv3-its-introspection-GITS_TYPER-is-read-only pass
2024-07-01T16:16:52.885037 its-introspection-gicv3-its-introspection-ITS-supports-physical-LPIs pass
2024-07-01T16:16:52.885360 its-introspection-gicv3-its-introspection-ID-spaces pass
2024-07-01T16:16:52.885938 its-introspection-gicv3-its-introspection-detect-device-and-collection-BASER pass
2024-07-01T16:16:52.886724 its-trigger-gicv3-its-trigger-Test-requires-at-least-4-vcpus skip
2024-07-01T16:16:52.887176 its-migration-gicv3-its-migration-Test-requires-at-least-4-vcpus skip
2024-07-01T16:16:52.887810 its-pending-migration-gicv3-its-pending-migration-Test-requires-at-least-4-vcpus skip
2024-07-01T16:16:52.888237 its-migrate-unmapped-collection-gicv3-its-migrate-unmapped-collection-Test-requires-at-least-4-vcpus skip
2024-07-01T16:16:52.888569 psci-psci-invalid-function pass
2024-07-01T16:16:52.888652 psci-psci-affinity-info-on pass
2024-07-01T16:16:52.889006 psci-psci-affinity-info-off pass
2024-07-01T16:16:52.889088 psci-psci-cpu-on pass
2024-07-01T16:16:52.889352 psci-psci-cpu-off pass
2024-07-01T16:16:52.889636 timer-vtimer-busy-loop-latency-within-10-ms pass
2024-07-01T16:16:52.889934 timer-vtimer-busy-loop-interrupt-received pass
2024-07-01T16:16:52.890202 timer-vtimer-busy-loop-not-pending-before pass
2024-07-01T16:16:52.890737 timer-vtimer-busy-loop-interrupt-signal-pending pass
2024-07-01T16:16:52.891216 timer-vtimer-busy-loop-no-interrupt-when-timer-is-disabled pass
2024-07-01T16:16:52.891726 timer-vtimer-busy-loop-interrupt-signal-no-longer-pending pass
2024-07-01T16:16:52.892033 timer-vtimer-busy-loop-interrupt-signal-not-pending pass
2024-07-01T16:16:52.892374 timer-vtimer-busy-loop-interrupt-received-after-TVALWFI pass
2024-07-01T16:16:52.892651 timer-vtimer-busy-loop-timer-has-expired pass
2024-07-01T16:16:52.892937 timer-ptimer-busy-loop-latency-within-10-ms pass
2024-07-01T16:16:52.893207 timer-ptimer-busy-loop-interrupt-received pass
2024-07-01T16:16:52.893481 timer-ptimer-busy-loop-not-pending-before pass
2024-07-01T16:16:52.893800 timer-ptimer-busy-loop-interrupt-signal-pending pass
2024-07-01T16:16:52.894097 timer-ptimer-busy-loop-no-interrupt-when-timer-is-disabled pass
2024-07-01T16:16:52.894690 timer-ptimer-busy-loop-interrupt-signal-no-longer-pending pass
2024-07-01T16:16:52.895137 timer-ptimer-busy-loop-interrupt-signal-not-pending pass
2024-07-01T16:16:52.895544 timer-ptimer-busy-loop-interrupt-received-after-TVALWFI pass
2024-07-01T16:16:52.895835 timer-ptimer-busy-loop-timer-has-expired pass
2024-07-01T16:16:52.896099 cache-IDC-DIC-code-generation pass
2024-07-01T16:16:52.896361 debug-bp-bp-hw-breakpoint-0 pass
2024-07-01T16:16:52.896622 debug-bp-bp-hw-breakpoint-1 pass
2024-07-01T16:16:52.896883 debug-bp-bp-hw-breakpoint-2 pass
2024-07-01T16:16:52.896964 debug-bp-bp-hw-breakpoint-3 pass
2024-07-01T16:16:52.897293 debug-bp-bp-hw-breakpoint-4 pass
2024-07-01T16:16:52.897568 debug-bp-bp-hw-breakpoint-5 pass
2024-07-01T16:16:52.897892 debug-bp-migration-bp-migration-brps-match-after-migrate pass
2024-07-01T16:16:52.898187 debug-bp-migration-bp-migration-hw-breakpoint-0 pass
2024-07-01T16:16:52.898609 debug-bp-migration-bp-migration-hw-breakpoint-1 pass
2024-07-01T16:16:52.899141 debug-bp-migration-bp-migration-hw-breakpoint-2 pass
2024-07-01T16:16:52.899503 debug-bp-migration-bp-migration-hw-breakpoint-3 pass
2024-07-01T16:16:52.899888 debug-bp-migration-bp-migration-hw-breakpoint-4 pass
2024-07-01T16:16:52.900325 debug-bp-migration-bp-migration-hw-breakpoint-5 pass
2024-07-01T16:16:52.900695 debug-wp-wp-watchpoint-received-0 pass
2024-07-01T16:16:52.900985 debug-wp-wp-watchpoint-data-0 pass
2024-07-01T16:16:52.901315 debug-wp-wp-watchpoint-received-1 pass
2024-07-01T16:16:52.901610 debug-wp-wp-watchpoint-data-1 pass
2024-07-01T16:16:52.901933 debug-wp-wp-watchpoint-received-2 pass
2024-07-01T16:16:52.902274 debug-wp-wp-watchpoint-data-2 pass
2024-07-01T16:16:52.902659 debug-wp-wp-watchpoint-received-3 pass
2024-07-01T16:16:52.903159 debug-wp-wp-watchpoint-data-3 pass
2024-07-01T16:16:52.903506 debug-wp-migration-wp-migration-wrps-match-after-migrate pass
2024-07-01T16:16:52.903833 debug-wp-migration-wp-migration-watchpoint-received-0 pass
2024-07-01T16:16:52.904185 debug-wp-migration-wp-migration-watchpoint-data-0 pass
2024-07-01T16:16:52.904566 debug-wp-migration-wp-migration-watchpoint-received-1 pass
2024-07-01T16:16:52.904872 debug-wp-migration-wp-migration-watchpoint-data-1 pass
2024-07-01T16:16:52.905177 debug-wp-migration-wp-migration-watchpoint-received-2 pass
2024-07-01T16:16:52.905475 debug-wp-migration-wp-migration-watchpoint-data-2 pass
2024-07-01T16:16:52.905788 debug-wp-migration-wp-migration-watchpoint-received-3 pass
2024-07-01T16:16:52.906092 debug-wp-migration-wp-migration-watchpoint-data-3 pass
2024-07-01T16:16:52.906193 debug-sstep-ss-single-step pass
2024-07-01T16:16:52.906699 debug-sstep-migration-ss-migration-single-step pass
2024-07-01T16:16:52.922348 + ../../utils/send-to-lava.sh ./output/result.txt
2024-07-01T16:16:53.126167 <8>[  591.302709] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-setup-selftest-setup-smp-number-of-CPUs-matches-expectation RESULT=pass>
2024-07-01T16:16:53.301505 <8>[  591.480025] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-setup-selftest-setup-mem-memory-size-matches-expectation RESULT=pass>
2024-07-01T16:16:53.470746 <8>[  591.649388] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-vectors-kernel-selftest-vectors-kernel-und RESULT=pass>
2024-07-01T16:16:53.634015 <8>[  591.812787] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-vectors-kernel-selftest-vectors-kernel-svc RESULT=pass>
2024-07-01T16:16:53.798114 <8>[  591.977003] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-vectors-kernel-selftest-vectors-kernel-pabt RESULT=pass>
2024-07-01T16:16:53.932409 <8>[  592.111172] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-vectors-user-selftest-vectors-user-und RESULT=pass>
2024-07-01T16:16:54.096510 <8>[  592.274939] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-vectors-user-selftest-vectors-user-svc RESULT=pass>
2024-07-01T16:16:54.266655 <8>[  592.445273] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=selftest-smp-selftest-smp-MPIDR-test-on-all-CPUs RESULT=pass>
2024-07-01T16:16:54.397395 <8>[  592.576265] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pci-test-pci-PCI-test-device-passed-66-tests RESULT=pass>
2024-07-01T16:16:54.531904 <8>[  592.710744] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-cycle-counter-pmu-cycle-counter-Monotonically-increasing-cycle-count RESULT=pass>
2024-07-01T16:16:54.706993 <8>[  592.885366] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-cycle-counter-pmu-cycle-counter-Cycleinstruction-ratio RESULT=pass>
2024-07-01T16:16:54.881638 <8>[  593.060421] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-event-introspection-pmu-pmu-event-introspection-Check-required-events-are-implemented RESULT=fail>
2024-07-01T16:16:55.050845 <8>[  593.229083] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-event-counter-config-pmu-pmu-event-counter-config-PMESELRPMXEVTYPERPMEVTYPERn RESULT=pass>
2024-07-01T16:16:55.206915 <8>[  593.385684] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-event-counter-config-pmu-pmu-event-counter-config-PMESELRPMXEVCNTRPMEVCNTRn RESULT=pass>
2024-07-01T16:16:55.377260 <8>[  593.555778] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-event-counter-config-pmu-pmu-event-counter-config-read-of-a-counter-programmed-with-unsupported-event RESULT=pass>
2024-07-01T16:16:55.544228 <8>[  593.723001] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-basic-event-count-pmu-pmu-basic-event-count-32-bit-overflows-Skip-test-as-event-0x8-is-not-supported RESULT=skip>
2024-07-01T16:16:55.708734 <8>[  593.887468] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-basic-event-count-pmu-pmu-basic-event-count-64-bit-overflows-Skip-test-as-event-0x8-is-not-supported RESULT=skip>
2024-07-01T16:16:55.867539 <8>[  594.046196] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-mem-access-pmu-pmu-mem-access-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:56.035784 <8>[  594.214154] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-mem-access-pmu-pmu-mem-access-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:56.213094 <8>[  594.391581] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-mem-access-reliability-pmu-pmu-mem-access-reliability-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:56.381015 <8>[  594.559318] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-mem-access-reliability-pmu-pmu-mem-access-reliability-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:56.558924 <8>[  594.737723] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-PWSYNC-does-not-increment-if-PMCRE-is-unset RESULT=pass>
2024-07-01T16:16:56.695689 <8>[  594.874536] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-counter-0-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:56.860754 <8>[  595.039553] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-counter-1-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:56.990146 <8>[  595.168989] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-32-bit-overflows-overflow-on-counter-0-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:57.155031 <8>[  595.333816] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-PWSYNC-does-not-increment-if-PMCRE-is-unset RESULT=pass>
2024-07-01T16:16:57.306829 <8>[  595.485361] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-counter-0-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:57.462039 <8>[  595.640623] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-counter-1-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:57.596907 <8>[  595.775476] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-sw-incr-pmu-pmu-sw-incr-64-bit-overflows-overflow-on-counter-0-after-100-SW_INCR RESULT=pass>
2024-07-01T16:16:57.772791 <8>[  595.951590] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-incremented RESULT=pass>
2024-07-01T16:16:57.906957 <8>[  596.085764] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-recorded-for-chained-incr-1 RESULT=pass>
2024-07-01T16:16:58.078419 <8>[  596.256672] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-set-to-2 RESULT=pass>
2024-07-01T16:16:58.253965 <8>[  596.432224] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-recorded-for-chained-incr-2 RESULT=pass>
2024-07-01T16:16:58.382027 <8>[  596.560457] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-CHAIN-counter-1-wrapped RESULT=pass>
2024-07-01T16:16:58.564102 <8>[  596.742501] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-counters-pmu-pmu-chained-counters-32-bit-overflows-overflow-on-even-and-odd-counters RESULT=pass>
2024-07-01T16:16:58.740875 <8>[  596.919047] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-sw-incr-pmu-pmu-chained-sw-incr-32-bit-overflows-overflow-and-chain-counter-incremented-after-100-SW_INCRCHAIN RESULT=pass>
2024-07-01T16:16:58.921687 <8>[  597.099986] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chained-sw-incr-pmu-pmu-chained-sw-incr-32-bit-overflows-expected-overflows-and-values-after-100-SW_INCRCHAIN RESULT=pass>
2024-07-01T16:16:59.101213 <8>[  597.279603] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-chain-promotion-pmu-pmu-chain-promotion-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:59.276469 <8>[  597.454663] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-overflow-interrupt-pmu-pmu-overflow-interrupt-32-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:59.413798 <8>[  597.592542] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=pmu-overflow-interrupt-pmu-pmu-overflow-interrupt-64-bit-overflows-Skip-test-as-event-0x13-is-not-supported RESULT=skip>
2024-07-01T16:16:59.574827 <8>[  597.753676] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=gicv3-ipi-gicv3-ipi-self-Interrupts-received RESULT=pass>
2024-07-01T16:16:59.785570 <8>[  597.963983] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=gicv3-ipi-gicv3-ipi-target-list-Interrupts-received RESULT=pass>
2024-07-01T16:16:59.972631 <8>[  598.151050] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=gicv3-ipi-gicv3-ipi-broadcast-Interrupts-received RESULT=pass>
2024-07-01T16:17:00.140219 <8>[  598.318821] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=gicv3-active-gicv3-active-self-Interrupts-received RESULT=pass>
2024-07-01T16:17:00.307821 <8>[  598.486354] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-introspection-gicv3-its-introspection-GITS_IIDR-is-read-only RESULT=pass>
2024-07-01T16:17:00.473405 <8>[  598.651870] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-introspection-gicv3-its-introspection-GITS_TYPER-is-read-only RESULT=pass>
2024-07-01T16:17:00.634127 <8>[  598.812838] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-introspection-gicv3-its-introspection-ITS-supports-physical-LPIs RESULT=pass>
2024-07-01T16:17:00.762727 <8>[  598.941585] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-introspection-gicv3-its-introspection-ID-spaces RESULT=pass>
2024-07-01T16:17:00.897680 <8>[  599.076515] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-introspection-gicv3-its-introspection-detect-device-and-collection-BASER RESULT=pass>
2024-07-01T16:17:01.049921 <8>[  599.228759] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-trigger-gicv3-its-trigger-Test-requires-at-least-4-vcpus RESULT=skip>
2024-07-01T16:17:01.173856 <8>[  599.352605] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-migration-gicv3-its-migration-Test-requires-at-least-4-vcpus RESULT=skip>
2024-07-01T16:17:01.303763 <8>[  599.482338] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-pending-migration-gicv3-its-pending-migration-Test-requires-at-least-4-vcpus RESULT=skip>
2024-07-01T16:17:01.429753 <8>[  599.608392] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=its-migrate-unmapped-collection-gicv3-its-migrate-unmapped-collection-Test-requires-at-least-4-vcpus RESULT=skip>
2024-07-01T16:17:01.588253 <8>[  599.767056] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=psci-psci-invalid-function RESULT=pass>
2024-07-01T16:17:01.720917 <8>[  599.899770] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=psci-psci-affinity-info-on RESULT=pass>
2024-07-01T16:17:01.846258 <8>[  600.025130] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=psci-psci-affinity-info-off RESULT=pass>
2024-07-01T16:17:02.003103 <8>[  600.181957] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=psci-psci-cpu-on RESULT=pass>
2024-07-01T16:17:02.164059 <8>[  600.342899] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=psci-psci-cpu-off RESULT=pass>
2024-07-01T16:17:02.291016 <8>[  600.469896] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-latency-within-10-ms RESULT=pass>
2024-07-01T16:17:02.420172 <8>[  600.599067] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-interrupt-received RESULT=pass>
2024-07-01T16:17:02.551805 <8>[  600.730677] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-not-pending-before RESULT=pass>
2024-07-01T16:17:02.717735 <8>[  600.896620] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-interrupt-signal-pending RESULT=pass>
2024-07-01T16:17:02.842788 <8>[  601.021641] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-no-interrupt-when-timer-is-disabled RESULT=pass>
2024-07-01T16:17:02.971200 <8>[  601.150081] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-interrupt-signal-no-longer-pending RESULT=pass>
2024-07-01T16:17:03.101767 <8>[  601.280641] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-interrupt-signal-not-pending RESULT=pass>
2024-07-01T16:17:03.237776 <8>[  601.416617] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-interrupt-received-after-TVALWFI RESULT=pass>
2024-07-01T16:17:03.395409 <8>[  601.574263] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-vtimer-busy-loop-timer-has-expired RESULT=pass>
2024-07-01T16:17:03.521245 <8>[  601.700104] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-latency-within-10-ms RESULT=pass>
2024-07-01T16:17:03.647374 <8>[  601.826231] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-interrupt-received RESULT=pass>
2024-07-01T16:17:03.807712 <8>[  601.986368] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-not-pending-before RESULT=pass>
2024-07-01T16:17:03.972778 <8>[  602.151386] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-interrupt-signal-pending RESULT=pass>
2024-07-01T16:17:04.142514 <8>[  602.321030] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-no-interrupt-when-timer-is-disabled RESULT=pass>
2024-07-01T16:17:04.310838 <8>[  602.489285] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-interrupt-signal-no-longer-pending RESULT=pass>
2024-07-01T16:17:04.484337 <8>[  602.663006] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-interrupt-signal-not-pending RESULT=pass>
2024-07-01T16:17:04.645671 <8>[  602.824522] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-interrupt-received-after-TVALWFI RESULT=pass>
2024-07-01T16:17:04.800938 <8>[  602.979708] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=timer-ptimer-busy-loop-timer-has-expired RESULT=pass>
2024-07-01T16:17:04.972185 <8>[  603.150756] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=cache-IDC-DIC-code-generation RESULT=pass>
2024-07-01T16:17:05.148506 <8>[  603.327212] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-0 RESULT=pass>
2024-07-01T16:17:05.284891 <8>[  603.463774] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-1 RESULT=pass>
2024-07-01T16:17:05.429246 <8>[  603.608142] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-2 RESULT=pass>
2024-07-01T16:17:05.589283 <8>[  603.768179] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-3 RESULT=pass>
2024-07-01T16:17:05.721037 <8>[  603.899785] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-4 RESULT=pass>
2024-07-01T16:17:05.880118 <8>[  604.058981] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-bp-hw-breakpoint-5 RESULT=pass>
2024-07-01T16:17:06.275826 <8>[  604.451912] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-brps-match-after-migrate RESULT=pass>
2024-07-01T16:17:06.453254 <8>[  604.632129] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-0 RESULT=pass>
2024-07-01T16:17:06.601641 <8>[  604.780232] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-1 RESULT=pass>
2024-07-01T16:17:06.763889 <8>[  604.942632] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-2 RESULT=pass>
2024-07-01T16:17:06.934781 <8>[  605.113681] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-3 RESULT=pass>
2024-07-01T16:17:07.097829 <8>[  605.276211] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-4 RESULT=pass>
2024-07-01T16:17:07.264219 <8>[  605.442779] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-bp-migration-bp-migration-hw-breakpoint-5 RESULT=pass>
2024-07-01T16:17:07.437418 <8>[  605.615938] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-received-0 RESULT=pass>
2024-07-01T16:17:07.604147 <8>[  605.783006] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-data-0 RESULT=pass>
2024-07-01T16:17:07.764497 <8>[  605.943375] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-received-1 RESULT=pass>
2024-07-01T16:17:07.905406 <8>[  606.084180] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-data-1 RESULT=pass>
2024-07-01T16:17:08.057502 <8>[  606.236278] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-received-2 RESULT=pass>
2024-07-01T16:17:08.189792 <8>[  606.368672] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-data-2 RESULT=pass>
2024-07-01T16:17:08.327705 <8>[  606.506575] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-received-3 RESULT=pass>
2024-07-01T16:17:08.469871 <8>[  606.648642] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-wp-watchpoint-data-3 RESULT=pass>
2024-07-01T16:17:08.607081 <8>[  606.785666] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-wrps-match-after-migrate RESULT=pass>
2024-07-01T16:17:08.740356 <8>[  606.919227] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-received-0 RESULT=pass>
2024-07-01T16:17:08.876620 <8>[  607.055488] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-data-0 RESULT=pass>
2024-07-01T16:17:09.013669 <8>[  607.192541] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-received-1 RESULT=pass>
2024-07-01T16:17:09.155161 <8>[  607.334007] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-data-1 RESULT=pass>
2024-07-01T16:17:09.287042 <8>[  607.465889] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-received-2 RESULT=pass>
2024-07-01T16:17:09.424140 <8>[  607.602928] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-data-2 RESULT=pass>
2024-07-01T16:17:09.559338 <8>[  607.738165] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-received-3 RESULT=pass>
2024-07-01T16:17:09.698060 <8>[  607.876840] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-wp-migration-wp-migration-watchpoint-data-3 RESULT=pass>
2024-07-01T16:17:09.829675 <8>[  608.008523] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-sstep-ss-single-step RESULT=pass>
2024-07-01T16:17:09.973206 <8>[  608.152069] <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=debug-sstep-migration-ss-migration-single-step RESULT=pass>
2024-07-01T16:17:09.987060 + set +x
2024-07-01T16:17:09.989042 <8>[  608.167971] <LAVA_SIGNAL_ENDRUN 0_kvm-unit-tests 1_1.1.3.1>
2024-07-01T16:17:10.007261 <LAVA_TEST_RUNNER EXIT>
2024-07-01T16:17:10.211181 [?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# #
2024-07-01T16:17:10.312076 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# export SHELL=/bin/sh
2024-07-01T16:17:10.413236 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# . /lava-1/environment
2024-07-01T16:17:10.414116 [?2004l
[?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# /lava-1/bin/lava-test-runner /lava-1/1
2024-07-01T16:17:10.869114 [?2004l
+ export TESTRUN_ID=1_commands
2024-07-01T16:17:10.870384 + cd /lava-1/1/tests/1_commands
2024-07-01T16:17:10.880954 + cat uuid
2024-07-01T16:17:10.917334 + UUID=1_1.1.3.5
2024-07-01T16:17:10.918193 + set +x
2024-07-01T16:17:10.921037 <LAVA_SIGNAL_STARTRUN 1_commands 1_1.1.3.5>
2024-07-01T16:17:10.922822 + lava-test-case command --shell tar cJf /mnt/tuxrun/kvm-unit-tests-logs.tar.xz /opt/kvm-unit-tests/logs
2024-07-01T16:17:10.950975 <LAVA_SIGNAL_STARTTC command>
2024-07-01T16:17:11.033937 tar: Removing leading `/' from member names
2024-07-01T16:17:11.415537 <LAVA_SIGNAL_ENDTC command>
2024-07-01T16:17:11.459373 <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=command RESULT=pass>
2024-07-01T16:17:11.464821 + set +x
2024-07-01T16:17:11.465776 <LAVA_SIGNAL_ENDRUN 1_commands 1_1.1.3.5>
2024-07-01T16:17:11.479877 <LAVA_TEST_RUNNER EXIT>
2024-07-01T16:17:12.583638 [?2004hroot@runner-vwmj3eza-project-40964107-concurrent-3:~# poweroff