Build failed in Jenkins: ttcn3-ggsn-test-kernel-latest-torvalds #1494

See https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/1494/display/redirect

Changes:

------------------------------------------ [...truncated 278.63 KiB...] [ 0.591185] NET: Registered PF_NETLINK/PF_ROUTE protocol family [ 0.593343] audit: initializing netlink subsys (disabled) [ 0.595246] audit: type=2000 audit(1743078922.472:1): state=initialized audit_enabled=0 res=1 [ 0.598929] thermal_sys: Registered thermal governor 'step_wise' [ 0.599394] cpuidle: using governor menu [ 0.602157] PCI: Using configuration type 1 for base access [ 0.603776] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. [ 0.607108] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages [ 0.607225] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page [ 0.617360] ACPI: Added _OSI(Module Device) [ 0.617438] ACPI: Added _OSI(Processor Device) [ 0.617497] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.617556] ACPI: Added _OSI(Processor Aggregator Device) [ 0.638679] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.666149] ACPI: Interpreter enabled [ 0.668015] ACPI: PM: (supports S0 S3 S4 S5) [ 0.668111] ACPI: Using IOAPIC for interrupt routing [ 0.668448] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.668545] PCI: Using E820 reservations for host bridge windows [ 0.670468] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.716898] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.720456] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.720725] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] [ 0.721379] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge [ 0.729158] PCI host bridge to bus 0000:00 [ 0.729401] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.729612] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.729694] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.729819] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window] [ 0.729852] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] [ 0.730056] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.731326] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint [ 0.740463] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint [ 0.746035] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint [ 0.746539] pci 0000:00:01.1: BAR 4 [io 0xc060-0xc06f] [ 0.746675] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk [ 0.746783] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk [ 0.746877] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk [ 0.746975] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk [ 0.747339] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint [ 0.747712] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.747879] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.748319] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint [ 0.748863] pci 0000:00:02.0: BAR 0 [io 0xc040-0xc05f] [ 0.748953] pci 0000:00:02.0: BAR 1 [mem 0xfebc0000-0xfebc0fff] [ 0.749081] pci 0000:00:02.0: BAR 4 [mem 0xfebf8000-0xfebfbfff 64bit pref] [ 0.749238] pci 0000:00:02.0: ROM [mem 0xfeb80000-0xfebbffff pref] [ 0.756071] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [ 0.756723] pci 0000:00:03.0: BAR 0 [io 0xc000-0xc03f] [ 0.756785] pci 0000:00:03.0: BAR 1 [mem 0xfebc1000-0xfebc1fff] [ 0.756858] pci 0000:00:03.0: BAR 4 [mem 0xfebfc000-0xfebfffff 64bit pref] [ 0.765344] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [ 0.765841] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [ 0.766198] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [ 0.766470] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [ 0.766617] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [ 0.772722] iommu: Default domain type: Translated [ 0.772811] iommu: DMA domain TLB invalidation policy: lazy mode [ 0.773666] SCSI subsystem initialized [ 0.780436] libata version 3.00 loaded. [ 0.781153] pps_core: LinuxPPS API ver. 1 registered [ 0.781234] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti giometti@linux.it [ 0.781392] PTP clock support registered [ 0.782047] EDAC MC: Ver: 3.0.0 [ 0.783688] Advanced Linux Sound Architecture Driver Initialized. [ 0.799865] NetLabel: Initializing [ 0.799917] NetLabel: domain hash size = 128 [ 0.799971] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.803708] NetLabel: unlabeled traffic allowed by default [ 0.810116] PCI: Using ACPI for IRQ routing [ 0.810251] PCI: pci_cache_line_size set to 64 bytes [ 0.810621] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.810827] e820: reserve RAM buffer [mem 0x1ffe0000-0x1fffffff] [ 0.811952] vgaarb: loaded [ 0.812885] hpet: 3 channels of 0 reserved for per-cpu timers [ 0.816095] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.816202] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.823198] clocksource: Switched to clocksource tsc-early [ 0.825337] VFS: Disk quotas dquot_6.6.0 [ 0.825479] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.829914] pnp: PnP ACPI init [ 0.834620] pnp 00:02: [dma 2] [ 0.835487] pnp: PnP ACPI: found 5 devices [ 0.874524] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.882016] NET: Registered PF_INET protocol family [ 0.882874] IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear) [ 0.892398] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes, linear) [ 0.892521] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [ 0.892648] TCP established hash table entries: 4096 (order: 3, 32768 bytes, linear) [ 0.895894] TCP bind hash table entries: 4096 (order: 5, 131072 bytes, linear) [ 0.896109] TCP: Hash tables configured (established 4096 bind 4096) [ 0.896670] UDP hash table entries: 256 (order: 2, 16384 bytes, linear) [ 0.896959] UDP-Lite hash table entries: 256 (order: 2, 16384 bytes, linear) [ 0.900805] NET: Registered PF_UNIX/PF_LOCAL protocol family [ 0.902333] RPC: Registered named UNIX socket transport module. [ 0.902418] RPC: Registered udp transport module. [ 0.902462] RPC: Registered tcp transport module. [ 0.902500] RPC: Registered tcp-with-tls transport module. [ 0.902571] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.907422] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.907491] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.907572] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.907625] pci_bus 0000:00: resource 7 [mem 0x20000000-0xfebfffff window] [ 0.907678] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] [ 0.908205] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.908331] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.908455] PCI: CLS 0 bytes, default 64 [ 0.918770] Unpacking initramfs... [ 1.189358] Initialise system trusted keyrings [ 1.194753] workingset: timestamp_bits=56 max_order=17 bucket_order=0 [ 1.201470] NFS: Registering the id_resolver key type [ 1.201652] Key type id_resolver registered [ 1.201717] Key type id_legacy registered [ 1.202501] 9p: Installing v9fs 9p2000 file system support [ 1.282233] Freeing initrd memory: 7304K [ 1.285961] kworker/u4:4 (52) used greatest stack depth: 15056 bytes left [ 1.287258] kworker/u4:4 (54) used greatest stack depth: 15032 bytes left [ 1.287595] Key type asymmetric registered [ 1.287686] Asymmetric key parser 'x509' registered [ 1.288194] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 1.288808] io scheduler mq-deadline registered [ 1.288905] io scheduler kyber registered [ 1.293297] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 1.296673] ACPI: button: Power Button [PWRF] [ 1.373317] ACPI: _SB_.LNKB: Enabled at IRQ 10 [ 1.436868] ACPI: _SB_.LNKC: Enabled at IRQ 11 [ 1.439157] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.442950] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 1.446157] kworker/u4:1 (108) used greatest stack depth: 15000 bytes left [ 1.449102] kworker/u4:0 (121) used greatest stack depth: 14264 bytes left [ 1.451669] Non-volatile memory driver v1.3 [ 1.451774] Linux agpgart interface v0.103 [ 1.453584] ACPI: bus type drm_connector registered [ 1.469783] loop: module loaded [ 1.472377] ata_piix 0000:00:01.1: version 2.13 [ 1.478655] scsi host0: ata_piix [ 1.480256] scsi host1: ata_piix [ 1.480664] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc060 irq 14 lpm-pol 0 [ 1.480753] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc068 irq 15 lpm-pol 0 [ 1.490942] BUG: kernel NULL pointer dereference, address: 0000000000000000 [ 1.491107] #PF: supervisor read access in kernel mode [ 1.491159] #PF: error_code(0x0000) - not-present page [ 1.491313] PGD 0 P4D 0 [ 1.491342] Oops: Oops: 0000 [#1] SMP NOPTI [ 1.491342] CPU: 0 UID: 0 PID: 1 Comm: swapper/0 Not tainted 6.14.0-gf6e0150b2003 #1 PREEMPT(voluntary) [ 1.491342] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 [ 1.491342] RIP: 0010:msix_prepare_msi_desc+0x33/0x80 [ 1.491342] Code: 00 00 48 89 f0 48 8b 52 20 66 81 4e 54 01 01 c7 46 04 01 00 00 00 8b 8f 9c 03 00 00 89 4e 58 48 8b b7 a8 07 00 00 48 89 70 60 <8b> 0a 31 d2 81 e1 00 00 40 00 75 0c 0f b6 50 55 d0 ea 83 f2 01 83 [ 1.491342] RSP: 0018:ffffc90000013a00 EFLAGS: 00000202 [ 1.491342] RAX: ffffc90000013a18 RBX: ffffc90000013a18 RCX: 000000000000000a [ 1.491342] RDX: 0000000000000000 RSI: ffffc90000075000 RDI: ffff888003aba000 [ 1.491342] RBP: 0000000000000000 R08: 0000000000000002 R09: ffffc900000139d4 [ 1.491342] R10: 0000000000000000 R11: ffffffff821526a0 R12: 0000000000000000 [ 1.491342] R13: ffff888003aba000 R14: 0000000000000004 R15: 0000000000000000 [ 1.491342] FS: 0000000000000000(0000) GS:ffff88809b911000(0000) knlGS:0000000000000000 [ 1.491342] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1.491342] CR2: 0000000000000000 CR3: 0000000002a32000 CR4: 00000000000006f0 [ 1.491342] Call Trace: [ 1.491342] <TASK> [ 1.491342] ? __die+0x1e/0x60 [ 1.491342] ? page_fault_oops+0x17a/0x4a0 [ 1.491342] ? search_extable+0x26/0x30 [ 1.491342] ? msix_prepare_msi_desc+0x33/0x80 [ 1.491342] ? search_module_extables+0x14/0x50 [ 1.491342] ? exc_page_fault+0x67/0x150 [ 1.491342] ? asm_exc_page_fault+0x26/0x30 [ 1.491342] ? __pfx_pci_conf1_read+0x10/0x10 [ 1.491342] ? msix_prepare_msi_desc+0x33/0x80 [ 1.491342] msix_setup_msi_descs+0xc1/0x100 [ 1.491342] __pci_enable_msix_range+0x2fa/0x5b0 [ 1.491342] pci_alloc_irq_vectors_affinity+0xa8/0x110 [ 1.491342] vp_find_vqs_msix+0x196/0x4e0 [ 1.491342] vp_find_vqs+0x3a/0x270 [ 1.491342] vp_modern_find_vqs+0x12/0x60 [ 1.491342] virtnet_find_vqs+0x1b1/0x360 [ 1.491342] virtnet_probe+0x5c2/0xf60 [ 1.491342] virtio_dev_probe+0x1b0/0x270 [ 1.491342] really_probe+0xbf/0x380 [ 1.491342] ? __pfx___driver_attach+0x10/0x10 [ 1.491342] __driver_probe_device+0x73/0x150 [ 1.491342] driver_probe_device+0x1a/0x90 [ 1.491342] __driver_attach+0xcd/0x1c0 [ 1.491342] bus_for_each_dev+0x82/0xd0 [ 1.491342] bus_add_driver+0x10d/0x240 [ 1.491342] driver_register+0x54/0x100 [ 1.491342] ? __pfx_virtio_net_driver_init+0x10/0x10 [ 1.491342] virtio_net_driver_init+0x8b/0xb0 [ 1.491342] ? __pfx_virtio_net_driver_init+0x10/0x10 [ 1.491342] do_one_initcall+0x55/0x220 [ 1.491342] kernel_init_freeable+0x199/0x2d0 [ 1.491342] ? __pfx_kernel_init+0x10/0x10 [ 1.491342] kernel_init+0x15/0x1c0 [ 1.491342] ret_from_fork+0x2f/0x50 [ 1.491342] ? __pfx_kernel_init+0x10/0x10 [ 1.491342] ret_from_fork_asm+0x1a/0x30 [ 1.491342] </TASK> [ 1.491342] Modules linked in: [ 1.491342] CR2: 0000000000000000 [ 1.491342] ---[ end trace 0000000000000000 ]--- [ 1.491342] RIP: 0010:msix_prepare_msi_desc+0x33/0x80 [ 1.491342] Code: 00 00 48 89 f0 48 8b 52 20 66 81 4e 54 01 01 c7 46 04 01 00 00 00 8b 8f 9c 03 00 00 89 4e 58 48 8b b7 a8 07 00 00 48 89 70 60 <8b> 0a 31 d2 81 e1 00 00 40 00 75 0c 0f b6 50 55 d0 ea 83 f2 01 83 [ 1.491342] RSP: 0018:ffffc90000013a00 EFLAGS: 00000202 [ 1.491342] RAX: ffffc90000013a18 RBX: ffffc90000013a18 RCX: 000000000000000a [ 1.491342] RDX: 0000000000000000 RSI: ffffc90000075000 RDI: ffff888003aba000 [ 1.491342] RBP: 0000000000000000 R08: 0000000000000002 R09: ffffc900000139d4 [ 1.491342] R10: 0000000000000000 R11: ffffffff821526a0 R12: 0000000000000000 [ 1.491342] R13: ffff888003aba000 R14: 0000000000000004 R15: 0000000000000000 [ 1.491342] FS: 0000000000000000(0000) GS:ffff88809b911000(0000) knlGS:0000000000000000 [ 1.491342] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1.491342] CR2: 0000000000000000 CR3: 0000000002a32000 CR4: 00000000000006f0 [ 1.491342] note: swapper/0[1] exited with irqs disabled [ 1.496922] Kernel panic - not syncing: Attempted to kill init! exitcode=0x00000009 [ 1.497365] Kernel Offset: disabled + [ -e https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/1494/artifact/logs/osmo_ggsn_v4_only/ggsn/_coredump/coredump ]

ERROR: Timeout while waiting for QEMU to become ready

[testenv][osmo_ggsn_v4_only] Command failed unexpectedly [testenv][osmo_ggsn_v4_only] Command: ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_cache/git', '-e', 'TESTENV_QEMU_KERNEL=https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/.linux', '-e', 'TESTENV_QEMU_SCRIPTS=https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/data/scripts/qemu', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_cache/podman/osmo-ttcn3-hacks/ggsn_tests:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/1494/artifact/logs/osmo_ggsn_v4_only/ggsn', 'testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20250327-1235-2a47032f-0', 'sh', '-c', 'qemu_wait.sh'] [testenv][osmo_ggsn_v4_only] Returncode: 1 [testenv][osmo_ggsn_v4_only] Stopping podman container [testenv][osmo_ggsn_v4_only] + ['podman', 'kill', 'testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20250327-1235-2a47032f-0'] testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20250327-1235-2a47032f-0 Traceback (most recent call last): File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/./testenv.py", line 137, in <module> main() File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/./testenv.py", line 126, in main run() File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/./testenv.py", line 82, in run testenv.daemons.start(cfg) File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/testenv/daemons.py", line 78, in start testenv.cmd.run(setup, cwd=cwd) File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/testenv/cmd.py", line 101, in run return testenv.podman.exec_cmd(cmd, check=check, env=env, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/testenv/podman.py", line 149, in exec_cmd return testenv.cmd.run( ^^^^^^^^^^^^^^^^ File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/testenv/cmd.py", line 118, in run exit_error_cmd(p, "Command failed unexpectedly") File "https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torvalds/ws/_testenv/testenv/cmd.py", line 66, in exit_error_cmd raise RuntimeError("shell command related error, find details right above this python trace") RuntimeError: shell command related error, find details right above this python trace [testenv][osmo_ggsn_v4_only] Skipping clean up scripts, podman container has already stopped [testenv] feed_watchdog_loop: podman container has stopped [testenv][osmo_ggsn_v4_only] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-torval...  Build step 'Execute shell' marked build as failure Recording test results ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?