[ 191.360789][ T1697] br0: port 1(c1) entered blocking state [ 191.361322][ T1697] br0: port 1(c1) entered disabled state [ 191.361724][ T1697] c1: entered allmulticast mode [ 191.365560][ T1697] c1: entered promiscuous mode [ 192.009568][ T1702] br0: port 2(c2) entered blocking state [ 192.009990][ T1702] br0: port 2(c2) entered disabled state [ 192.010325][ T1702] c2: entered allmulticast mode [ 192.014262][ T1702] c2: entered promiscuous mode [ 192.688072][ T1707] br0: port 3(c3) entered blocking state [ 192.688515][ T1707] br0: port 3(c3) entered disabled state [ 192.688864][ T1707] c3: entered allmulticast mode [ 192.693082][ T1707] c3: entered promiscuous mode [ 193.351396][ T1712] br0: port 4(sender) entered blocking state [ 193.351816][ T1712] br0: port 4(sender) entered disabled state [ 193.352645][ T1712] sender: entered allmulticast mode [ 193.356762][ T1712] sender: entered promiscuous mode [ 193.603670][ T1714] br0: port 4(sender) entered blocking state [ 193.604168][ T1714] br0: port 4(sender) entered forwarding state [ 193.604897][ T1714] br0: port 3(c3) entered blocking state [ 193.605220][ T1714] br0: port 3(c3) entered forwarding state [ 193.605865][ T1714] br0: port 2(c2) entered blocking state [ 193.606190][ T1714] br0: port 2(c2) entered forwarding state [ 193.606833][ T1714] br0: port 1(c1) entered blocking state [ 193.607165][ T1714] br0: port 1(c1) entered forwarding state [ 193.803922][ T1715] Bridge firewalling registered [ 207.259813][ T67] br0: port 1(c1) entered disabled state [ 207.414825][ T67] c1 (unregistering): left allmulticast mode [ 207.415255][ T67] c1 (unregistering): left promiscuous mode [ 207.415643][ T67] br0: port 1(c1) entered disabled state [ 207.800941][ T67] br0: port 2(c2) entered disabled state [ 207.930808][ T67] c2 (unregistering): left allmulticast mode [ 207.931240][ T67] c2 (unregistering): left promiscuous mode [ 207.931639][ T67] br0: port 2(c2) entered disabled state [ 208.342894][ T67] br0: port 3(c3) entered disabled state [ 208.448337][ T67] c3 (unregistering): left allmulticast mode [ 208.448846][ T67] c3 (unregistering): left promiscuous mode [ 208.449296][ T67] br0: port 3(c3) entered disabled state [ 208.904101][ T67] br0: port 4(sender) entered disabled state [ 209.046770][ T67] sender (unregistering): left allmulticast mode [ 209.047300][ T67] sender (unregistering): left promiscuous mode [ 209.047750][ T67] br0: port 4(sender) entered disabled state [ 209.124890][ C0] [ 209.125048][ C0] ================================ [ 209.125267][ C0] WARNING: inconsistent lock state [ 209.125491][ C0] 6.15.0-virtme #1 Not tainted [ 209.125716][ C0] -------------------------------- [ 209.125934][ C0] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 209.126206][ C0] swapper/0/0 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 209.126484][ C0] ffffffffaf5d0bb8 (pin_fs_lock){+.?.}-{3:3}, at: simple_pin_fs+0x24/0x150 [ 209.126893][ C0] {SOFTIRQ-ON-W} state was registered at: [ 209.127111][ C0] __lock_acquire+0x20b/0x7e0 [ 209.127339][ C0] lock_acquire.part.0+0xb6/0x240 [ 209.127566][ C0] _raw_spin_lock+0x33/0x40 [ 209.127792][ C0] simple_pin_fs+0x24/0x150 [ 209.128017][ C0] start_creating.part.0+0x52/0x310 [ 209.128244][ C0] debugfs_create_dir+0x6a/0x570 [ 209.128464][ C0] component_debug_init+0x17/0x30 [ 209.128685][ C0] do_one_initcall+0x8f/0x1e0 [ 209.128910][ C0] do_initcalls+0x176/0x280 [ 209.129133][ C0] kernel_init_freeable+0x22d/0x300 [ 209.129357][ C0] kernel_init+0x20/0x200 [ 209.129571][ C0] ret_from_fork+0x240/0x320 [ 209.129792][ C0] ret_from_fork_asm+0x1a/0x30 [ 209.130007][ C0] irq event stamp: 3484972 [ 209.130230][ C0] hardirqs last enabled at (3484972): [] _raw_spin_unlock_irqrestore+0x5d/0x80 [ 209.130675][ C0] hardirqs last disabled at (3484971): [] _raw_spin_lock_irqsave+0x5b/0x60 [ 209.131116][ C0] softirqs last enabled at (3481828): [] handle_softirqs+0x358/0x620 [ 209.131509][ C0] softirqs last disabled at (3481835): [] __irq_exit_rcu+0xfa/0x160 [ 209.131901][ C0] [ 209.131901][ C0] other info that might help us debug this: [ 209.132235][ C0] Possible unsafe locking scenario: [ 209.132235][ C0] [ 209.132563][ C0] CPU0 [ 209.132729][ C0] ---- [ 209.132902][ C0] lock(pin_fs_lock); [ 209.133076][ C0] [ 209.133244][ C0] lock(pin_fs_lock); [ 209.133412][ C0] [ 209.133412][ C0] *** DEADLOCK *** [ 209.133412][ C0] [ 209.133737][ C0] 1 lock held by swapper/0/0: [ 209.133957][ C0] #0: ffffffffaf377c00 (rcu_callback){....}-{0:0}, at: rcu_do_batch+0x2e4/0xf20 [ 209.134352][ C0] [ 209.134352][ C0] stack backtrace: [ 209.134626][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 209.134631][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 209.134633][ C0] Call Trace: [ 209.134635][ C0] [ 209.134637][ C0] dump_stack_lvl+0x82/0xd0 [ 209.134643][ C0] print_usage_bug.part.0+0x25f/0x360 [ 209.134648][ C0] mark_lock_irq+0x343/0x400 [ 209.134652][ C0] ? is_bpf_text_address+0x67/0x120 [ 209.134658][ C0] ? __lock_release+0x5d/0x170 [ 209.134662][ C0] ? save_trace+0x52/0x170 [ 209.134666][ C0] mark_lock+0x174/0x2f0 [ 209.134670][ C0] mark_usage+0x46/0x150 [ 209.134674][ C0] __lock_acquire+0x20b/0x7e0 [ 209.134677][ C0] ? __lock_acquire+0x44d/0x7e0 [ 209.134682][ C0] lock_acquire.part.0+0xb6/0x240 [ 209.134686][ C0] ? simple_pin_fs+0x24/0x150 [ 209.134690][ C0] ? rcu_is_watching+0x12/0xc0 [ 209.134696][ C0] ? lock_acquire+0x10c/0x170 [ 209.134699][ C0] ? simple_pin_fs+0x24/0x150 [ 209.134704][ C0] _raw_spin_lock+0x33/0x40 [ 209.134707][ C0] ? simple_pin_fs+0x24/0x150 [ 209.134710][ C0] simple_pin_fs+0x24/0x150 [ 209.134714][ C0] debugfs_remove+0x35/0x70 [ 209.134717][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 209.134722][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 209.134726][ C0] ? __sk_destruct+0x383/0x780 [ 209.134731][ C0] ? rcu_do_batch+0x34f/0xf20 [ 209.134735][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 209.134738][ C0] ? irq_exit_rcu+0xe/0x30 [ 209.134741][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 209.134745][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 209.134748][ C0] ? pv_native_safe_halt+0xf/0x20 [ 209.134751][ C0] ? default_idle+0x9/0x10 [ 209.134754][ C0] ? default_idle_call+0x6d/0xb0 [ 209.134756][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 209.134761][ C0] ? do_idle+0xf6/0x160 [ 209.134763][ C0] ? cpu_startup_entry+0x54/0x60 [ 209.134766][ C0] ? rest_init+0x14b/0x260 [ 209.134769][ C0] ? start_kernel+0x350/0x410 [ 209.134774][ C0] __put_net+0x19/0x60 [ 209.134778][ C0] __sk_destruct+0x58a/0x780 [ 209.134782][ C0] ? rcu_do_batch+0x34a/0xf20 [ 209.134785][ C0] rcu_do_batch+0x34f/0xf20 [ 209.134789][ C0] ? find_held_lock+0x2b/0x80 [ 209.134793][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 209.134797][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 209.134800][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 209.134804][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 209.134808][ C0] rcu_core+0x2bb/0x500 [ 209.134812][ C0] handle_softirqs+0x21b/0x620 [ 209.134818][ C0] __irq_exit_rcu+0xfa/0x160 [ 209.134821][ C0] irq_exit_rcu+0xe/0x30 [ 209.134824][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 209.134827][ C0] [ 209.134828][ C0] [ 209.134830][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 209.134832][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 209.134836][ C0] Code: f2 ce 00 c3 cc cc cc cc 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d 83 17 28 00 fb f4 fc 54 02 00 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 209.134839][ C0] RSP: 0018:ffffffffaf007df8 EFLAGS: 00000242 [ 209.134842][ C0] RAX: 00000000003520e9 RBX: 1ffffffff5e00fc3 RCX: ffffffffae2125d9 [ 209.134844][ C0] RDX: 0000000000000000 RSI: ffffffffaeea61cd RDI: ffffffffae658be0 [ 209.134846][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c066fa [ 209.134847][ C0] R10: ffff8880360337d3 R11: ffffffffaf011288 R12: 0000000000000000 [ 209.134849][ C0] R13: ffffffffaf01f240 R14: dffffc0000000000 R15: 0000000000014770 [ 209.134853][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 209.134858][ C0] default_idle+0x9/0x10 [ 209.134860][ C0] default_idle_call+0x6d/0xb0 [ 209.134862][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 209.134866][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 209.134870][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 209.134876][ C0] do_idle+0xf6/0x160 [ 209.134881][ C0] cpu_startup_entry+0x54/0x60 [ 209.134884][ C0] rest_init+0x14b/0x260 [ 209.134887][ C0] start_kernel+0x350/0x410 [ 209.134891][ C0] x86_64_start_reservations+0x18/0x30 [ 209.134896][ C0] x86_64_start_kernel+0xf8/0x150 [ 209.134899][ C0] common_startup_64+0x13e/0x148 [ 209.134907][ C0] [ 209.156818][ C0] BUG: sleeping function called from invalid context at kernel/locking/rwsem.c:1576 [ 209.157160][ C0] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 0, name: swapper/0 [ 209.157618][ C0] preempt_count: 101, expected: 0 [ 209.157815][ C0] RCU nest depth: 0, expected: 0 [ 209.158011][ C0] INFO: lockdep is turned off. [ 209.158204][ C0] Preemption disabled at: [ 209.158206][ C0] [] schedule_preempt_disabled+0x22/0x30 [ 209.158759][ C0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 6.15.0-virtme #1 PREEMPT(full) [ 209.158764][ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 209.158766][ C0] Call Trace: [ 209.158767][ C0] [ 209.158769][ C0] dump_stack_lvl+0xb0/0xd0 [ 209.158775][ C0] __might_resched+0x360/0x5a0 [ 209.158781][ C0] down_write+0x72/0x210 [ 209.158784][ C0] ? __pfx_down_write+0x10/0x10 [ 209.158787][ C0] ? simple_recursive_removal+0x33/0x610 [ 209.158791][ C0] ? rcu_is_watching+0x12/0xc0 [ 209.158797][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 209.158801][ C0] simple_recursive_removal+0x6a/0x610 [ 209.158804][ C0] ? do_raw_spin_unlock+0x58/0x220 [ 209.158806][ C0] ? __pfx_remove_one+0x10/0x10 [ 209.158812][ C0] debugfs_remove+0x44/0x70 [ 209.158815][ C0] ref_tracker_dir_exit+0xcf/0x740 [ 209.158820][ C0] ? __pfx_ref_tracker_free+0x10/0x10 [ 209.158823][ C0] ? __sk_destruct+0x383/0x780 [ 209.158828][ C0] ? rcu_do_batch+0x34f/0xf20 [ 209.158832][ C0] ? __pfx_ref_tracker_dir_exit+0x10/0x10 [ 209.158835][ C0] ? irq_exit_rcu+0xe/0x30 [ 209.158838][ C0] ? sysvec_apic_timer_interrupt+0xa8/0xc0 [ 209.158842][ C0] ? asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 209.158846][ C0] ? pv_native_safe_halt+0xf/0x20 [ 209.158849][ C0] ? default_idle+0x9/0x10 [ 209.158852][ C0] ? default_idle_call+0x6d/0xb0 [ 209.158854][ C0] ? cpuidle_idle_call+0x26f/0x3a0 [ 209.158858][ C0] ? do_idle+0xf6/0x160 [ 209.158861][ C0] ? cpu_startup_entry+0x54/0x60 [ 209.158864][ C0] ? rest_init+0x14b/0x260 [ 209.158866][ C0] ? start_kernel+0x350/0x410 [ 209.158873][ C0] __put_net+0x19/0x60 [ 209.158876][ C0] __sk_destruct+0x58a/0x780 [ 209.158880][ C0] ? rcu_do_batch+0x34a/0xf20 [ 209.158883][ C0] rcu_do_batch+0x34f/0xf20 [ 209.158887][ C0] ? find_held_lock+0x2b/0x80 [ 209.158891][ C0] ? __pfx_rcu_do_batch+0x10/0x10 [ 209.158895][ C0] ? _raw_spin_unlock_irqrestore+0x5d/0x80 [ 209.158899][ C0] ? lockdep_hardirqs_on+0x7c/0x110 [ 209.158903][ C0] ? _raw_spin_unlock_irqrestore+0x46/0x80 [ 209.158908][ C0] rcu_core+0x2bb/0x500 [ 209.158912][ C0] handle_softirqs+0x21b/0x620 [ 209.158918][ C0] __irq_exit_rcu+0xfa/0x160 [ 209.158921][ C0] irq_exit_rcu+0xe/0x30 [ 209.158925][ C0] sysvec_apic_timer_interrupt+0xa8/0xc0 [ 209.158929][ C0] [ 209.158930][ C0] [ 209.158931][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 209.158934][ C0] RIP: 0010:pv_native_safe_halt+0xf/0x20 [ 209.158938][ C0] Code: f2 ce 00 c3 cc cc cc cc 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa 66 90 0f 00 2d 83 17 28 00 fb f4 fc 54 02 00 66 2e 0f 1f 84 00 00 00 00 00 66 90 90 90 90 90 90 [ 209.158940][ C0] RSP: 0018:ffffffffaf007df8 EFLAGS: 00000242 [ 209.158944][ C0] RAX: 00000000003520e9 RBX: 1ffffffff5e00fc3 RCX: ffffffffae2125d9 [ 209.158946][ C0] RDX: 0000000000000000 RSI: ffffffffaeea61cd RDI: ffffffffae658be0 [ 209.158947][ C0] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006c066fa [ 209.158949][ C0] R10: ffff8880360337d3 R11: ffffffffaf011288 R12: 0000000000000000 [ 209.158951][ C0] R13: ffffffffaf01f240 R14: dffffc0000000000 R15: 0000000000014770 [ 209.158954][ C0] ? ct_kernel_exit.constprop.0+0x109/0x160 [ 209.158959][ C0] default_idle+0x9/0x10 [ 209.158961][ C0] default_idle_call+0x6d/0xb0 [ 209.158964][ C0] cpuidle_idle_call+0x26f/0x3a0 [ 209.158967][ C0] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 209.158971][ C0] ? tsc_verify_tsc_adjust+0x98/0x310 [ 209.158977][ C0] do_idle+0xf6/0x160 [ 209.158980][ C0] cpu_startup_entry+0x54/0x60 [ 209.158984][ C0] rest_init+0x14b/0x260 [ 209.158987][ C0] start_kernel+0x350/0x410 [ 209.158991][ C0] x86_64_start_reservations+0x18/0x30 [ 209.158995][ C0] x86_64_start_kernel+0xf8/0x150 [ 209.158999][ C0] common_startup_64+0x13e/0x148 [ 209.159006][ C0]