virtme: waiting for virtiofsd to start
virtme: use 'microvm' QEMU architecture
[ 1.342924][ T1] IPI shorthand broadcast: enabled
[ 1.468305][ T1] sched_clock: Marking stable (1436002257, 32170027)->(1552098653, -83926369)
[ 1.471367][ T1] registered taskstats version 1
[ 1.473449][ T1] Loading compiled-in X.509 certificates
[ 1.575253][ T1] Demotion targets for Node 0: null
[ 1.575653][ T1] kmemleak: Kernel memory leak detector initialized (mem pool available: 11678)
[ 1.575889][ T1] page_owner is disabled
[ 1.577291][ T1] PM: Magic number: 10:595:298
[ 1.577813][ T1] netconsole: network logging started
[ 1.579419][ T1] ALSA device list:
[ 1.579571][ T1] No soundcards found.
[ 1.582000][ T1] md: Skipping autodetection of RAID arrays. (raid=autodetect will force)
[ 1.584525][ T1] VFS: Mounted root (virtiofs filesystem) readonly on device 0:22.
[ 1.585371][ T1] devtmpfs: mounted
[ 1.585720][ T1] VFS: Pivoted into new rootfs
[ 1.615999][ T1] Freeing unused kernel image (initmem) memory: 2504K
[ 1.616242][ T1] Write protecting the kernel read-only data: 57344k
[ 1.617116][ T1] Freeing unused kernel image (text/rodata gap) memory: 1436K
[ 1.617626][ T1] Freeing unused kernel image (rodata/data gap) memory: 796K
[ 1.617973][ T1] Run /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init as init process
[ 1.618251][ T1] with arguments:
[ 1.618372][ T1] /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init
[ 1.618597][ T1] with environment:
[ 1.618715][ T1] HOME=/
[ 1.618836][ T1] TERM=dumb
[ 1.618954][ T1] virtme_hostname=vmksft-forwarding-dbg,debug-threads=on
[ 1.619164][ T1] nr_open=2147483584
[ 1.619857][ T1] virtme_link_mods=/srv/vmksft/testing/wt-4/.virtme_mods/lib/modules/0.0.0
[ 1.620043][ T1] virtme_rw_overlay0=/etc
[ 1.620139][ T1] virtme_rw_overlay1=/lib
[ 1.620244][ T1] virtme_rw_overlay2=/home
[ 1.620351][ T1] virtme_rw_overlay3=/opt
[ 1.620446][ T1] virtme_rw_overlay4=/srv
[ 1.620541][ T1] virtme_rw_overlay5=/usr
[ 1.620636][ T1] virtme_rw_overlay6=/var
[ 1.620730][ T1] virtme_rw_overlay7=/tmp
[ 1.620824][ T1] virtme_console=ttyS0
[ 1.620918][ T1] virtme_chdir=srv/vmksft/testing/wt-4
[ 1.643519][ T1] virtme-ng-init: mount devtmpfs -> /dev: EBUSY: Device or resource busy
[ 1.645413][ T1] virtme-ng-init: Setting hostname to vmksft-forwarding-dbg,debug-threads=on...
[ 1.655893][ T1] overlayfs: failed to set xattr on upper
[ 1.656135][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.656393][ T1] overlayfs: ...falling back to uuid=null.
[ 1.659859][ T1] overlayfs: failed to set xattr on upper
[ 1.660057][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.660563][ T1] overlayfs: ...falling back to uuid=null.
[ 1.663541][ T1] overlayfs: failed to set xattr on upper
[ 1.663764][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.664008][ T1] overlayfs: ...falling back to uuid=null.
[ 1.667362][ T1] overlayfs: failed to set xattr on upper
[ 1.667560][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.667788][ T1] overlayfs: ...falling back to uuid=null.
[ 1.670982][ T1] overlayfs: failed to set xattr on upper
[ 1.671210][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.671434][ T1] overlayfs: ...falling back to uuid=null.
[ 1.674019][ T1] overlayfs: failed to set xattr on upper
[ 1.674223][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.674447][ T1] overlayfs: ...falling back to uuid=null.
[ 1.677822][ T1] overlayfs: failed to set xattr on upper
[ 1.678017][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.678250][ T1] overlayfs: ...falling back to uuid=null.
[ 1.682317][ T1] overlayfs: failed to set xattr on upper
[ 1.682505][ T1] overlayfs: ...falling back to redirect_dir=nofollow.
[ 1.682736][ T1] overlayfs: ...falling back to uuid=null.
[ 1.700032][ T1] virtme-ng-init: running systemd-tmpfiles
[ 1.912950][ T73] kwatchdog (73) used greatest stack depth: 29736 bytes left
[ 3.885960][ T72] systemd-tmpfile (72) used greatest stack depth: 24528 bytes left
[ 3.886228][ T1] virtme-ng-init: Failed to read '/usr/lib/tmpfiles.d/audit.conf': Permission denied
[ 3.886228][ T1] Failed to create directory or subvolume "/var/spool/at/spool": Permission denied
[ 3.886228][ T1] Failed to create file /var/spool/at/.SEQ: Permission denied
[ 3.886228][ T1] Failed to opendir() '/proc/self/fd/3': Permission denied
[ 3.886350][ T1] virtme-ng-init: basic initialization done
[ 3.940832][ T78] ------------[ cut here ]------------
[ 3.941148][ T78] WARNING: net/core/rtnetlink.c:4296 at rtnl_getlink+0x9f8/0xeb0, CPU#2: ip/78
[ 3.941610][ T78] Modules linked in:
[ 3.941876][ T78] CPU: 2 UID: 0 PID: 78 Comm: ip Tainted: G W 7.1.0-rc4-virtme #1 PREEMPT(full)
[ 3.942446][ T78] Tainted: [W]=WARN
[ 3.942653][ T78] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 3.942962][ T78] RIP: 0010:rtnl_getlink+0x9f8/0xeb0
[ 3.943279][ T78] Code: c4 38 e8 1b c7 fa ff 45 85 f6 4c 8b 5c 24 08 4c 8b 54 24 30 0f 84 2e 02 00 00 ba 02 00 00 00 4c 89 de 31 ff e8 d9 27 f1 ff 90 <0f> 0b 90 41 be a6 ff ff ff 48 8b 74 24 20 48 8b 7c 24 28 e8 d0 42
[ 3.944051][ T78] RSP: 0018:ffa00000004e72f8 EFLAGS: 00010296
[ 3.944417][ T78] RAX: 0000000000000001 RBX: 1ff400000009ce68 RCX: ffffffff8e3468de
[ 3.944786][ T78] RDX: ff1100000993a340 RSI: ffffffff9080178e RDI: ffffffff9026f5c0
[ 3.945161][ T78] RBP: ff110000057d4040 R08: 0000000000000000 R09: 0000000000000000
[ 3.945533][ T78] R10: 0000000000000002 R11: 0000000000000001 R12: ff1100000527c000
[ 3.945890][ T78] R13: ffffffff93b2e640 R14: 00000000ffffffa6 R15: ff11000005536dc0
[ 3.946318][ T78] FS: 00007f123ae29600(0000) GS:ff110000a34b0000(0000) knlGS:0000000000000000
[ 3.946723][ T78] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 3.947045][ T78] CR2: 0000563802606760 CR3: 00000000096de005 CR4: 0000000000771ef0
[ 3.947463][ T78] PKRU: 55555554
[ 3.947693][ T78] Call Trace:
[ 3.947902][ T78]
[ 3.948080][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.948365][ T78] ? find_held_lock+0x2b/0x80
[ 3.948627][ T78] ? rtnl_dump_ifinfo+0x1250/0x1250
[ 3.948884][ T78] ? mark_usage+0x61/0x170
[ 3.949149][ T78] ? __lock_release.isra.0+0x6b/0x1a0
[ 3.949429][ T78] ? __lock_acquire+0x508/0xc10
[ 3.949717][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.949972][ T78] ? find_held_lock+0x2b/0x80
[ 3.950255][ T78] ? mark_usage+0x61/0x170
[ 3.950506][ T78] ? __lock_acquire+0x508/0xc10
[ 3.950763][ T78] ? __lock_release.isra.0+0x6b/0x1a0
[ 3.951025][ T78] ? rtnl_dump_ifinfo+0x1250/0x1250
[ 3.951301][ T78] rtnetlink_rcv_msg+0x6fd/0xbd0
[ 3.951555][ T78] ? validate_chain+0x38b/0xc20
[ 3.951810][ T78] ? rtnl_link_fill+0x900/0x900
[ 3.952078][ T78] ? __lock_acquire+0x508/0xc10
[ 3.952357][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.952612][ T78] ? find_held_lock+0x2b/0x80
[ 3.952870][ T78] netlink_rcv_skb+0x14e/0x3a0
[ 3.953138][ T78] ? rtnl_link_fill+0x900/0x900
[ 3.953412][ T78] ? netlink_ack+0xcd0/0xcd0
[ 3.953676][ T78] ? netlink_deliver_tap+0xc5/0x330
[ 3.953934][ T78] ? netlink_deliver_tap+0x13c/0x330
[ 3.954221][ T78] netlink_unicast+0x486/0x750
[ 3.954482][ T78] ? netlink_attachskb+0x810/0x810
[ 3.954738][ T78] ? __lock_acquire+0x508/0xc10
[ 3.955004][ T78] netlink_sendmsg+0x735/0xc60
[ 3.955287][ T78] ? netlink_unicast+0x750/0x750
[ 3.955546][ T78] ? __might_fault+0x97/0x140
[ 3.955808][ T78] ____sys_sendmsg+0x419/0x850
[ 3.955970][ T74] virtme-ng-init: Starting systemd-udevd version 259.5-1.fc44
[ 3.956151][ T78] ? copy_msghdr_from_user+0x2a0/0x460
[ 3.956269][ T78] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 3.956276][ T78] ? move_addr_to_kernel+0x40/0x40
[ 3.956279][ T78] ? rcu_read_lock_any_held+0x3c/0x90
[ 3.956510][ T74] virtme-ng-init: triggering udev coldplug
[ 3.956850][ T78] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 3.957249][ T78] ? rcu_read_lock_any_held+0x3c/0x90
[ 3.957539][ T78] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 3.957874][ T78] ___sys_sendmsg+0x14e/0x1d0
[ 3.958150][ T78] ? copy_msghdr_from_user+0x460/0x460
[ 3.958428][ T78] ? __lock_acquire+0x508/0xc10
[ 3.958702][ T78] ? move_addr_to_user+0x55/0x70
[ 3.958960][ T78] ? do_getsockname+0xfa/0x180
[ 3.959282][ T78] __sys_sendmsg+0x145/0x1f0
[ 3.959552][ T78] ? __sys_sendmsg_sock+0x20/0x20
[ 3.959814][ T78] ? __sys_getsockname+0xa2/0x110
[ 3.960079][ T78] ? rcu_is_watching+0x15/0xd0
[ 3.960349][ T78] do_syscall_64+0x117/0xfc0
[ 3.960619][ T78] ? trace_hardirqs_off+0xd/0x30
[ 3.960872][ T78] ? exc_page_fault+0xee/0x100
[ 3.961188][ T78] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 3.961497][ T78] RIP: 0033:0x7f123b06108e
[ 3.961768][ T78] Code: 4d 89 d8 e8 94 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa
[ 3.962565][ T78] RSP: 002b:00007fffda9465e0 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 3.962931][ T78] RAX: ffffffffffffffda RBX: 00007fffda949e19 RCX: 00007f123b06108e
[ 3.963317][ T78] RDX: 0000000000000000 RSI: 00007fffda946690 RDI: 0000000000000004
[ 3.963677][ T78] RBP: 00007fffda9465f0 R08: 0000000000000000 R09: 0000000000000000
[ 3.964083][ T78] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000000
[ 3.964457][ T78] R13: 000000006a10c778 R14: 00007fffda946730 R15: 00007fffda949e19
[ 3.964828][ T78]
[ 3.965047][ T78] irq event stamp: 23275
[ 3.965287][ T78] hardirqs last enabled at (23287): [] __up_console_sem+0x5a/0x70
[ 3.965702][ T78] hardirqs last disabled at (23296): [] __up_console_sem+0x3f/0x70
[ 3.966119][ T78] softirqs last enabled at (22560): [] handle_softirqs+0x611/0x940
[ 3.966539][ T78] softirqs last disabled at (22551): [] __irq_exit_rcu+0x103/0x1c0
[ 3.967402][ T78] ---[ end trace 0000000000000000 ]---
[ 3.968859][ T78] ------------[ cut here ]------------
[ 3.969208][ T78] WARNING: net/core/rtnetlink.c:4523 at rtmsg_ifinfo_build_skb+0x1a6/0x250, CPU#2: ip/78
[ 3.969687][ T78] Modules linked in:
[ 3.969969][ T78] CPU: 2 UID: 0 PID: 78 Comm: ip Tainted: G W 7.1.0-rc4-virtme #1 PREEMPT(full)
[ 3.970559][ T78] Tainted: [W]=WARN
[ 3.970782][ T78] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 3.971124][ T78] RIP: 0010:rtmsg_ifinfo_build_skb+0x1a6/0x250
[ 3.971539][ T78] Code: 89 fa 48 c1 ea 03 0f b6 14 02 48 89 f8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 79 48 8b 44 24 58 44 8b 48 08 e9 42 ff ff ff 90 <0f> 0b 90 ba 02 00 00 00 48 89 de 31 ff e8 38 e4 f0 ff b9 a6 ff ff
[ 3.972563][ T78] RSP: 0018:ffa00000004e7030 EFLAGS: 00010286
[ 3.972902][ T78] RAX: 00000000ffffffa6 RBX: ff110000057d4740 RCX: 1ff400000009cdcc
[ 3.973317][ T78] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ff110000057d47f8
[ 3.973694][ T78] RBP: ff1100000527c000 R08: 1fe2200000afa900 R09: ff1100000993ae58
[ 3.974085][ T78] R10: 0000000000000002 R11: 0000000000000001 R12: 0000000000000001
[ 3.974486][ T78] R13: 0000000000000000 R14: 0000000000000000 R15: ff1100000527cce1
[ 3.974864][ T78] FS: 00007f123ae29600(0000) GS:ff110000a34b0000(0000) knlGS:0000000000000000
[ 3.975320][ T78] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 3.975649][ T78] CR2: 0000563840702988 CR3: 00000000096de005 CR4: 0000000000771ef0
[ 3.976075][ T78] PKRU: 55555554
[ 3.976316][ T78] Call Trace:
[ 3.976867][ T78]
[ 3.977049][ T78] rtmsg_ifinfo_event.part.0+0x2c/0x130
[ 3.977519][ T78] rtmsg_ifinfo+0x5c/0xb0
[ 3.977744][ T78] ? mark_held_locks+0x40/0x70
[ 3.978029][ T78] __dev_notify_flags+0x1b8/0x280
[ 3.978333][ T78] ? netif_change_name+0x8c0/0x8c0
[ 3.978609][ T78] ? __dev_change_flags+0x4a4/0x660
[ 3.978889][ T78] ? netif_set_allmulti+0x250/0x250
[ 3.979233][ T78] ? rcu_read_lock_any_held+0x3c/0x90
[ 3.979516][ T78] ? validate_chain+0x38b/0xc20
[ 3.979801][ T78] netif_change_flags+0xfe/0x190
[ 3.980099][ T78] do_setlink.isra.0+0x1cc3/0x2750
[ 3.980401][ T78] ? find_held_lock+0x2b/0x80
[ 3.980831][ T78] ? rtnl_link_get_size+0x350/0x350
[ 3.981119][ T78] ? __lock_release.isra.0+0x6b/0x1a0
[ 3.981419][ T78] ? rcu_is_watching+0x15/0xd0
[ 3.981697][ T78] ? rcu_lockdep_current_cpu_online+0x39/0x1b0
[ 3.982041][ T78] ? rcu_read_lock_any_held+0x3c/0x90
[ 3.982352][ T78] ? validate_chain+0x38b/0xc20
[ 3.982623][ T78] ? stack_depot_save_flags+0x531/0x770
[ 3.982896][ T78] ? __lock_acquire+0x508/0xc10
[ 3.983208][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.983491][ T78] ? rtnl_newlink+0x883/0xef0
[ 3.983783][ T78] ? rcu_is_watching+0x15/0xd0
[ 3.984074][ T78] ? lock_acquire+0x134/0x160
[ 3.984388][ T78] ? rcu_is_watching+0x15/0xd0
[ 3.984667][ T78] ? rcu_is_watching+0x15/0xd0
[ 3.984977][ T78] ? trace_contention_end+0xb3/0x1a0
[ 3.985294][ T78] ? __mutex_lock+0x1db/0x2010
[ 3.986062][ T78] ? __mutex_lock+0x9b2/0x2010
[ 3.986356][ T78] ? rtnl_newlink+0x883/0xef0
[ 3.986672][ T78] ? ww_mutex_lock+0x160/0x160
[ 3.986954][ T78] ? __rtnl_newlink+0x3fa/0xa50
[ 3.987273][ T78] rtnl_newlink+0x8d1/0xef0
[ 3.987714][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.987999][ T78] ? find_held_lock+0x2b/0x80
[ 3.988300][ T78] ? __rtnl_newlink+0xa50/0xa50
[ 3.988575][ T78] ? mark_usage+0x61/0x170
[ 3.989197][ T78] ? __lock_release.isra.0+0x6b/0x1a0
[ 3.989493][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 3.989768][ T78] ? find_held_lock+0x2b/0x80
[ 3.997938][ T78] ? __rtnl_newlink+0xa50/0xa50
[ 3.998257][ T78] ? __lock_release.isra.0+0x6b/0x1a0
[ 3.998545][ T78] ? __rtnl_newlink+0xa50/0xa50
[ 3.998818][ T78] rtnetlink_rcv_msg+0x6fd/0xbd0
[ 3.999681][ T78] ? validate_chain+0x38b/0xc20
[ 3.999960][ T78] ? rtnl_link_fill+0x900/0x900
[ 4.000444][ T78] ? __lock_acquire+0x508/0xc10
[ 4.000739][ T78] ? lock_acquire.part.0+0xbc/0x260
[ 4.011218][ T78] ? find_held_lock+0x2b/0x80
[ 4.011509][ T78] netlink_rcv_skb+0x14e/0x3a0
[ 4.011790][ T78] ? rtnl_link_fill+0x900/0x900
[ 4.012082][ T78] ? netlink_ack+0xcd0/0xcd0
[ 4.012382][ T78] ? netlink_deliver_tap+0xc5/0x330
[ 4.012655][ T78] ? netlink_deliver_tap+0x13c/0x330
[ 4.012935][ T78] netlink_unicast+0x486/0x750
[ 4.031479][ T78] ? netlink_attachskb+0x810/0x810
[ 4.031759][ T78] ? __lock_acquire+0x508/0xc10
[ 4.032047][ T78] netlink_sendmsg+0x735/0xc60
[ 4.032498][ T78] ? netlink_unicast+0x750/0x750
[ 4.032771][ T78] ? __might_fault+0x97/0x140
[ 4.033866][ T78] ____sys_sendmsg+0x419/0x850
[ 4.034155][ T78] ? copy_msghdr_from_user+0x2a0/0x460
[ 4.034461][ T78] ? get_timestamp.constprop.0+0x3a0/0x3a0
[ 4.034778][ T78] ? move_addr_to_kernel+0x40/0x40
[ 4.040581][ T78] ? stack_depot_save_flags+0x367/0x770
[ 4.040863][ T78] ? validate_chain+0x38b/0xc20
[ 4.041194][ T78] ___sys_sendmsg+0x14e/0x1d0
[ 4.041474][ T78] ? __call_rcu_common.constprop.0+0xb2/0xa10
[ 4.041805][ T78] ? copy_msghdr_from_user+0x460/0x460
[ 4.042123][ T78] __sys_sendmsg+0x145/0x1f0
[ 4.042425][ T78] ? __sys_sendmsg_sock+0x20/0x20
[ 4.042697][ T78] ? __call_rcu_common.constprop.0+0x3d1/0xa10
[ 4.043031][ T78] ? do_raw_spin_unlock+0x59/0x250
[ 4.043326][ T78] ? rcu_is_watching+0x15/0xd0
[ 4.043602][ T78] do_syscall_64+0x117/0xfc0
[ 4.043885][ T78] ? trace_hardirqs_off+0xd/0x30
[ 4.044190][ T78] ? exc_page_fault+0xee/0x100
[ 4.044475][ T78] entry_SYSCALL_64_after_hwframe+0x4b/0x53
[ 4.044802][ T78] RIP: 0033:0x7f123b06108e
[ 4.045099][ T78] Code: 4d 89 d8 e8 94 bd 00 00 4c 8b 5d f8 41 8b 93 08 03 00 00 59 5e 48 83 f8 fc 74 11 c9 c3 0f 1f 80 00 00 00 00 48 8b 45 10 0f 05 c3 83 e2 39 83 fa 08 75 e7 e8 03 ff ff ff 0f 1f 00 f3 0f 1e fa
[ 4.045972][ T78] RSP: 002b:00007fffda947c40 EFLAGS: 00000202 ORIG_RAX: 000000000000002e
[ 4.046553][ T78] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f123b06108e
[ 4.046936][ T78] RDX: 0000000000000000 RSI: 00007fffda947cf0 RDI: 0000000000000003
[ 4.051978][ T78] RBP: 00007fffda947c50 R08: 0000000000000000 R09: 0000000000000000
[ 4.052397][ T78] R10: 0000000000000000 R11: 0000000000000202 R12: 0000000000000003
[ 4.052779][ T78] R13: 000000006a10c778 R14: 00005638025b9040 R15: 0000000000000000
[ 4.053198][ T78]
[ 4.053419][ T78] irq event stamp: 25067
[ 4.053641][ T78] hardirqs last enabled at (25077): [] __up_console_sem+0x5a/0x70
[ 4.054087][ T78] hardirqs last disabled at (25086): [] __up_console_sem+0x3f/0x70
[ 4.054541][ T78] softirqs last enabled at (23934): [] handle_softirqs+0x611/0x940
[ 4.060298][ T78] softirqs last disabled at (23883): [] __irq_exit_rcu+0x103/0x1c0
[ 4.060885][ T78] ---[ end trace 0000000000000000 ]---
[ 4.085094][ T78] ip (78) used greatest stack depth: 23376 bytes left
[ 6.485945][ T74] virtme-ng-init: waiting for udev to settle
[ 7.285058][ T74] virtme-ng-init: udev is done
[ 7.293539][ T1] virtme-ng-init: initialization done