[ 10.074258][ T198] netconsole: network logging started [ 12.663259][ T255] Test #1 from CPU2: netcons_li9Xa [ 12.663384][ T242] ------------[ cut here ]------------ [ 12.663646][ T242] WARNING: kernel/softirq.c:430 at __local_bh_enable_ip+0xc0/0x140, CPU#3: pr/netcon_ext0/242 [ 12.663931][ T242] Modules linked in: netconsole netdevsim [ 12.664119][ T242] CPU: 3 UID: 0 PID: 242 Comm: pr/netcon_ext0 Not tainted 6.19.0-virtme #1 PREEMPT(full) [ 12.664511][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.664684][ T242] RIP: 0010:__local_bh_enable_ip+0xc0/0x140 [ 12.664872][ T242] Code: 00 00 00 e8 12 15 0a 00 e8 3d 7c 3c 00 fb 65 8b 05 05 72 40 04 85 c0 74 64 48 83 c4 10 c3 65 8b 05 11 b6 40 04 85 c0 75 a2 90 <0f> 0b 90 eb 9c 89 74 24 0c 4c 89 04 24 e8 ce 7f 3c 00 8b 74 24 0c [ 12.665374][ T242] RSP: 0018:ffa00000006478b8 EFLAGS: 00010046 [ 12.665547][ T242] RAX: 0000000000000000 RBX: 000000007ac3e332 RCX: 1ffffffff0d0ca80 [ 12.665755][ T242] RDX: 0000000000000001 RSI: 0000000000000201 RDI: ffffffff846657ff [ 12.665962][ T242] RBP: ffa00000006478e8 R08: ffffffff846657ff R09: ffe21c00018d61e3 [ 12.666172][ T242] R10: ffe21c00018d61e4 R11: ff1100000c6b0f14 R12: ffa0000000647990 [ 12.666384][ T242] R13: ff110000019cb400 R14: ff11000004c6a000 R15: ff11000004c32d00 [ 12.666590][ T242] FS: 0000000000000000(0000) GS:ff110000ae20b000(0000) knlGS:0000000000000000 [ 12.666836][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 12.667041][ T242] CR2: 0000560487397d00 CR3: 000000001773b003 CR4: 0000000000771ef0 [ 12.667247][ T242] PKRU: 55555554 [ 12.667352][ T242] Call Trace: [ 12.667455][ T242] [ 12.667529][ T242] ? _raw_spin_unlock_bh+0x23/0x40 [ 12.667670][ T242] mock_phc_gettime64+0x3f/0x80 [ 12.667817][ T242] nsim_start_xmit+0x3be/0x10d0 [netdevsim] [ 12.667996][ T242] ? __lock_acquire+0x577/0xc10 [ 12.668135][ T242] ? nsim_poll+0x500/0x500 [netdevsim] [ 12.668274][ T242] ? lock_acquire.part.0+0xbc/0x260 [ 12.668409][ T242] ? rcu_is_watching+0x15/0xd0 [ 12.668544][ T242] ? netif_skb_features+0x27c/0xce0 [ 12.668682][ T242] netpoll_start_xmit+0x18e/0x2e0 [ 12.668822][ T242] __netpoll_send_skb+0x66b/0x800 [ 12.668963][ T242] netpoll_send_skb+0x22/0x90 [ 12.669098][ T242] send_ext_msg_udp+0x523/0x700 [netconsole] [ 12.669270][ T242] netconsole_write+0x18f/0x2c0 [netconsole] [ 12.669443][ T242] nbcon_emit_next_record+0x79b/0x930 [ 12.669581][ T242] ? nbcon_can_proceed+0x120/0x120 [ 12.669722][ T242] ? nbcon_context_try_acquire+0x26a/0x5b0 [ 12.669898][ T242] nbcon_emit_one+0x158/0x220 [ 12.670039][ T242] ? nbcon_emit_next_record+0x930/0x930 [ 12.670176][ T242] nbcon_kthread_func+0x3d9/0x570 [ 12.670316][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.670490][ T242] ? __lock_release.isra.0+0x59/0x170 [ 12.670628][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.670800][ T242] ? __kthread_parkme+0xb3/0x200 [ 12.670943][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.671111][ T242] kthread+0x30f/0x3f0 [ 12.671214][ T242] ? trace_irq_enable.constprop.0+0x13c/0x190 [ 12.671385][ T242] ? kthread_affine_node+0x150/0x150 [ 12.671520][ T242] ret_from_fork+0x472/0x6b0 [ 12.671655][ T242] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 12.671827][ T242] ? __switch_to+0x538/0xcf0 [ 12.671994][ T242] ? kthread_affine_node+0x150/0x150 [ 12.672179][ T242] ret_from_fork_asm+0x11/0x20 [ 12.672323][ T242] [ 12.672426][ T242] irq event stamp: 61 [ 12.672530][ T242] hardirqs last enabled at (59): [] finish_task_switch.isra.0+0x15f/0x6a0 [ 12.672809][ T242] hardirqs last disabled at (60): [] _raw_spin_lock_irqsave+0x50/0x60 [ 12.673051][ T242] softirqs last enabled at (0): [] copy_process+0x1673/0x5700 [ 12.673290][ T242] softirqs last disabled at (61): [] mock_phc_gettime64+0x24/0x80 [ 12.673524][ T242] ---[ end trace 0000000000000000 ]--- [ 12.673942][ T242] ------------[ cut here ]------------ [ 12.674122][ T242] netpoll_send_skb_on_dev(): eni364np1 enabled interrupts in poll (nsim_start_xmit+0x0/0x10d0 [netdevsim]) [ 12.674465][ T242] WARNING: net/core/netpoll.c:356 at __netpoll_send_skb+0x710/0x800, CPU#3: pr/netcon_ext0/242 [ 12.674711][ T242] Modules linked in: netconsole netdevsim [ 12.674913][ T242] CPU: 3 UID: 0 PID: 242 Comm: pr/netcon_ext0 Tainted: G W 6.19.0-virtme #1 PREEMPT(full) [ 12.675198][ T242] Tainted: [W]=WARN [ 12.675302][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.675461][ T242] RIP: 0010:__netpoll_send_skb+0x71c/0x800 [ 12.675625][ T242] Code: 08 49 8d 7c 24 20 48 89 fa 48 c1 ea 03 80 3c 02 00 0f 85 d9 00 00 00 48 8d 3d a0 72 ea 01 49 8b 54 24 20 48 8d b3 18 01 00 00 <67> 48 0f b9 3a e9 cc fd ff ff e8 65 3f ca fe e9 56 fb ff ff e8 7b [ 12.676078][ T242] RSP: 0018:ffa0000000647a40 EFLAGS: 00010246 [ 12.676242][ T242] RAX: dffffc0000000000 RBX: ff11000004c32000 RCX: 0000000000000002 [ 12.676428][ T242] RDX: ffffffffc0405f00 RSI: ff11000004c32118 RDI: ffffffff868b1be0 [ 12.676614][ T242] RBP: ff11000009490e00 R08: ffffffff82efcb29 R09: ffe21c00014302a0 [ 12.676804][ T242] R10: ffe21c00014302a1 R11: 0000000000000001 R12: ffffffffc0253c60 [ 12.677000][ T242] R13: 0000000000000003 R14: ff11000004c32004 R15: ff1100000a181400 [ 12.677189][ T242] FS: 0000000000000000(0000) GS:ff110000ae20b000(0000) knlGS:0000000000000000 [ 12.677415][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 12.677572][ T242] CR2: 0000560487397d00 CR3: 000000001773b003 CR4: 0000000000771ef0 [ 12.677764][ T242] PKRU: 55555554 [ 12.677859][ T242] Call Trace: [ 12.677959][ T242] [ 12.678026][ T242] netpoll_send_skb+0x22/0x90 [ 12.678154][ T242] send_ext_msg_udp+0x523/0x700 [netconsole] [ 12.678316][ T242] netconsole_write+0x18f/0x2c0 [netconsole] [ 12.678474][ T242] nbcon_emit_next_record+0x79b/0x930 [ 12.678603][ T242] ? nbcon_can_proceed+0x120/0x120 [ 12.678730][ T242] ? nbcon_context_try_acquire+0x26a/0x5b0 [ 12.678895][ T242] nbcon_emit_one+0x158/0x220 [ 12.679022][ T242] ? nbcon_emit_next_record+0x930/0x930 [ 12.679148][ T242] nbcon_kthread_func+0x3d9/0x570 [ 12.679282][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.679437][ T242] ? __lock_release.isra.0+0x59/0x170 [ 12.679565][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.679724][ T242] ? __kthread_parkme+0xb3/0x200 [ 12.679853][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.680011][ T242] kthread+0x30f/0x3f0 [ 12.680105][ T242] ? trace_irq_enable.constprop.0+0x13c/0x190 [ 12.680289][ T242] ? kthread_affine_node+0x150/0x150 [ 12.680415][ T242] ret_from_fork+0x472/0x6b0 [ 12.680542][ T242] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 12.680700][ T242] ? __switch_to+0x538/0xcf0 [ 12.680832][ T242] ? kthread_affine_node+0x150/0x150 [ 12.680963][ T242] ret_from_fork_asm+0x11/0x20 [ 12.681096][ T242] [ 12.681192][ T242] irq event stamp: 529 [ 12.681293][ T242] hardirqs last enabled at (539): [] __up_console_sem+0x5a/0x70 [ 12.681508][ T242] hardirqs last disabled at (546): [] __up_console_sem+0x3f/0x70 [ 12.681729][ T242] softirqs last enabled at (470): [] handle_softirqs+0x60c/0x920 [ 12.681949][ T242] softirqs last disabled at (465): [] irq_exit_rcu+0xa2/0xf0 [ 12.682166][ T242] ---[ end trace 0000000000000000 ]--- [ 12.682302][ T242] ------------[ cut here ]------------ [ 12.682473][ T242] raw_local_irq_restore() called with IRQs enabled [ 12.682622][ T242] WARNING: kernel/locking/irqflag-debug.c:10 at warn_bogus_irq_restore+0xc/0x20, CPU#3: pr/netcon_ext0/242 [ 12.682952][ T242] Modules linked in: netconsole netdevsim [ 12.683082][ T242] CPU: 3 UID: 0 PID: 242 Comm: pr/netcon_ext0 Tainted: G W 6.19.0-virtme #1 PREEMPT(full) [ 12.683372][ T242] Tainted: [W]=WARN [ 12.683467][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.683622][ T242] RIP: 0010:warn_bogus_irq_restore+0xc/0x20 [ 12.683792][ T242] Code: e5 85 48 89 54 24 08 48 89 0c 24 e8 7e 0d d1 fe 48 8b 54 24 08 48 8b 0c 24 e9 25 ff ff ff f3 0f 1e fa 90 48 8d 3d 54 d2 75 01 <67> 48 0f b9 3a 90 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f [ 12.684246][ T242] RSP: 0018:ffa0000000647a98 EFLAGS: 00010202 [ 12.684403][ T242] RAX: 0000000000000000 RBX: ff11000008bc1130 RCX: 0000000000000000 [ 12.684589][ T242] RDX: 0000000000000282 RSI: ffffffff859bc59e RDI: ffffffff8687ae60 [ 12.684780][ T242] RBP: 000000000000003f R08: 0000000000000001 R09: ffe21c00014302a0 [ 12.684970][ T242] R10: 0000000000000003 R11: 0000000000000001 R12: 00000000000003a9 [ 12.685157][ T242] R13: ffa0000000647da0 R14: ff11000008bc1000 R15: ff11000008bc1650 [ 12.685350][ T242] FS: 0000000000000000(0000) GS:ff110000ae20b000(0000) knlGS:0000000000000000 [ 12.685570][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 12.685729][ T242] CR2: 0000560487397d00 CR3: 000000001773b003 CR4: 0000000000771ef0 [ 12.685921][ T242] PKRU: 55555554 [ 12.686014][ T242] Call Trace: [ 12.686107][ T242] [ 12.686169][ T242] netpoll_send_skb+0x81/0x90 [ 12.686298][ T242] send_ext_msg_udp+0x523/0x700 [netconsole] [ 12.686455][ T242] netconsole_write+0x18f/0x2c0 [netconsole] [ 12.686610][ T242] nbcon_emit_next_record+0x79b/0x930 [ 12.686740][ T242] ? nbcon_can_proceed+0x120/0x120 [ 12.686867][ T242] ? nbcon_context_try_acquire+0x26a/0x5b0 [ 12.687103][ T242] nbcon_emit_one+0x158/0x220 [ 12.687311][ T242] ? nbcon_emit_next_record+0x930/0x930 [ 12.687517][ T242] nbcon_kthread_func+0x3d9/0x570 [ 12.687693][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.687855][ T242] ? __lock_release.isra.0+0x59/0x170 [ 12.687987][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.688140][ T242] ? __kthread_parkme+0xb3/0x200 [ 12.688270][ T242] ? __nbcon_atomic_flush_pending+0x3d0/0x3d0 [ 12.688422][ T242] kthread+0x30f/0x3f0 [ 12.688515][ T242] ? trace_irq_enable.constprop.0+0x13c/0x190 [ 12.688669][ T242] ? kthread_affine_node+0x150/0x150 [ 12.688799][ T242] ret_from_fork+0x472/0x6b0 [ 12.688928][ T242] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 [ 12.689084][ T242] ? __switch_to+0x538/0xcf0 [ 12.689207][ T242] ? kthread_affine_node+0x150/0x150 [ 12.689334][ T242] ret_from_fork_asm+0x11/0x20 [ 12.689464][ T242] [ 12.689558][ T242] irq event stamp: 977 [ 12.689653][ T242] hardirqs last enabled at (985): [] __up_console_sem+0x5a/0x70 [ 12.689874][ T242] hardirqs last disabled at (992): [] __up_console_sem+0x3f/0x70 [ 12.690092][ T242] softirqs last enabled at (470): [] handle_softirqs+0x60c/0x920 [ 12.690311][ T242] softirqs last disabled at (465): [] irq_exit_rcu+0xa2/0xf0 [ 12.690525][ T242] ---[ end trace 0000000000000000 ]--- [ 13.499083][ T277] Test #2 from CPU3: netcons_li9Xa [ 14.298865][ T298] Test #3 from CPU0: netcons_li9Xa