[ 10.337463][ T230] 8021q: 802.1Q VLAN Support v1.8 [ 10.337481][ T230] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.337483][ T230] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 230, name: modprobe [ 10.337485][ T230] preempt_count: 1, expected: 0 [ 10.337485][ T230] RCU nest depth: 0, expected: 0 [ 10.337486][ T230] locks held by modprobe/230: 4, last CPU#0: [ 10.337488][ T230] #0: ffffffffb1f69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.337502][ T230] #1: ffffffffb1f69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.337506][ T230] #2: ffffffffb1e89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.337510][ T230] #3: ffffffffb1e89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.337513][ T230] irq event stamp: 29232 [ 10.337514][ T230] hardirqs last enabled at (29231): [] __down_trylock_console_sem+0x86/0xa0 [ 10.337517][ T230] hardirqs last disabled at (29232): [] console_emit_next_record+0x3d4/0x4c0 [ 10.337519][ T230] softirqs last enabled at (28758): [] handle_softirqs+0x67c/0x900 [ 10.337522][ T230] softirqs last disabled at (28289): [] __irq_exit_rcu+0x145/0x1c0 [ 10.337524][ T230] Preemption disabled at: [ 10.337525][ T230] [] vprintk_emit+0x31b/0x3e0 [ 10.337530][ T230] CPU: 0 UID: 0 PID: 230 Comm: modprobe Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.337534][ T230] Tainted: [W]=WARN [ 10.337535][ T230] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.337536][ T230] Call Trace: [ 10.337538][ T230] [ 10.337539][ T230] dump_stack_lvl+0x6f/0xa0 [ 10.337545][ T230] ? vprintk_emit+0x31b/0x3e0 [ 10.337547][ T230] __might_resched.cold+0x1fe/0x2c1 [ 10.337551][ T230] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.337555][ T230] ? __kmalloc_noprof+0xdb/0x760 [ 10.337561][ T230] __kmalloc_noprof+0x443/0x760 [ 10.337563][ T230] ? alloc_buf.isra.0+0x4b/0x260 [ 10.337569][ T230] ? do_raw_spin_unlock+0x59/0x250 [ 10.337572][ T230] alloc_buf.isra.0+0x4b/0x260 [ 10.337575][ T230] put_chars+0x1e1/0x2f0 [ 10.337578][ T230] ? __send_to_port+0x420/0x420 [ 10.337579][ T230] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.337584][ T230] ? rcu_read_lock_any_held+0x3c/0x90 [ 10.337586][ T230] ? validate_chain+0x38b/0xc20 [ 10.337590][ T230] hvc_console_print+0x292/0x780 [ 10.337593][ T230] ? __lock_acquire+0x518/0xc20 [ 10.337598][ T230] ? hvc_write+0x3a0/0x3a0 [ 10.337600][ T230] ? rcu_is_watching+0x16/0xd0 [ 10.337605][ T230] console_emit_next_record+0x22f/0x4c0 [ 10.337609][ T230] ? devkmsg_read+0x4b0/0x4b0 [ 10.337611][ T230] ? console_flush_one_record+0x106/0x710 [ 10.337614][ T230] ? rcu_is_watching+0x16/0xd0 [ 10.337616][ T230] ? lock_acquire+0x13c/0x160 [ 10.337620][ T230] console_flush_one_record+0x46f/0x710 [ 10.337624][ T230] ? console_emit_next_record+0x4c0/0x4c0 [ 10.337626][ T230] ? __lock_acquire+0x518/0xc20 [ 10.337631][ T230] console_unlock+0xee/0x1f0 [ 10.337634][ T230] ? console_flush_one_record+0x710/0x710 [ 10.337636][ T230] ? rcu_is_watching+0x16/0xd0 [ 10.337638][ T230] ? lock_acquire+0x60/0x160 [ 10.337641][ T230] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.337643][ T230] ? vprintk_emit+0x320/0x3e0 [ 10.337646][ T230] vprintk_emit+0x37c/0x3e0 [ 10.337650][ T230] ? wake_up_klogd_work_func+0x90/0x90 [ 10.337656][ T230] ? vlan_netlink_fini+0x960/0x960 [8021q] [ 10.337659][ T230] _printk+0xc7/0x100 [ 10.337663][ T230] ? snapshot_read.cold+0x21/0x21 [ 10.337669][ T230] ? do_one_initcall+0x113/0x4f0 [ 10.337672][ T230] vlan_proto_init+0x24/0x90 [8021q] [ 10.337675][ T230] do_one_initcall+0x124/0x4f0 [ 10.337678][ T230] ? trace_event_raw_event_initcall_level+0x280/0x280 [ 10.337683][ T230] ? do_init_module+0xae/0x8a0 [ 10.337686][ T230] ? kasan_unpoison+0x44/0x70 [ 10.337690][ T230] do_init_module+0x2ad/0x8a0 [ 10.337694][ T230] ? lockdep_hardirqs_on+0x91/0x130 [ 10.337698][ T230] ? free_module+0x470/0x470 [ 10.337701][ T230] ? kfree+0x123/0x590 [ 10.337705][ T230] load_module+0x1424/0x1bb0 [ 10.337712][ T230] ? layout_and_allocate.isra.0+0x680/0x680 [ 10.337716][ T230] ? __ia32_sys_fsconfig+0x180/0x180 [ 10.337718][ T230] ? ovl_real_file+0x172/0x1e0 [ 10.337722][ T230] ? backing_file_read_iter+0x541/0x790 [ 10.337725][ T230] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 10.337729][ T230] init_module_from_file+0x11f/0x1a0 [ 10.337732][ T230] ? __do_sys_init_module+0x220/0x220 [ 10.337740][ T230] ? __rwlock_init+0x150/0x150 [ 10.337744][ T230] ? do_raw_spin_unlock+0x59/0x250 [ 10.337747][ T230] idempotent_init_module+0x37b/0x7c0 [ 10.337750][ T230] ? init_module_from_file+0x1a0/0x1a0 [ 10.337756][ T230] ? rcu_is_watching+0x16/0xd0 [ 10.337759][ T230] ? cap_capable+0x1d7/0x3d0 [ 10.337764][ T230] __x64_sys_finit_module+0xdf/0x190 [ 10.337766][ T230] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.337770][ T230] do_syscall_64+0xff/0x530 [ 10.337772][ T230] ? exc_page_fault+0xee/0x100 [ 10.337774][ T230] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.337777][ T230] RIP: 0033:0x7f74ba90d37d [ 10.337780][ T230] Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 4b aa 0f 00 f7 d8 64 89 01 48 [ 10.337781][ T230] RSP: 002b:00007ffce3253788 EFLAGS: 00000246 ORIG_RAX: 0000000000000139 [ 10.337784][ T230] RAX: ffffffffffffffda RBX: 0000557ee40d6810 RCX: 00007f74ba90d37d [ 10.337785][ T230] RDX: 0000000000000000 RSI: 0000557ee0507ffd RDI: 0000000000000000 [ 10.337786][ T230] RBP: 00007ffce3253820 R08: 0000000000000000 R09: 0000000000000000 [ 10.337787][ T230] R10: 0000000000000000 R11: 0000000000000246 R12: 0000557ee0507ffd [ 10.337788][ T230] R13: 0000557ee40d6960 R14: 0000000000040000 R15: 0000000000000000 [ 10.337794][ T230] [ 11.238082][ T266] br0: port 1(veth1) entered blocking state [ 11.238670][ T266] br0: port 1(veth1) entered disabled state [ 11.238975][ T266] veth1: entered allmulticast mode [ 11.240526][ T266] veth1: entered promiscuous mode [ 11.274753][ T38] br0: port 1(veth1) entered blocking state [ 11.275193][ T38] br0: port 1(veth1) entered forwarding state [ 11.328428][ T269] br0: port 2(veth2) entered blocking state [ 11.328938][ T269] br0: port 2(veth2) entered disabled state [ 11.329827][ T269] veth2: entered allmulticast mode [ 11.331433][ T269] veth2: entered promiscuous mode [ 11.368400][ T39] br0: port 2(veth2) entered blocking state [ 11.368424][ T39] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.368426][ T39] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 39, name: kworker/u20:0 [ 11.368428][ T39] preempt_count: 202, expected: 0 [ 11.368428][ T39] RCU nest depth: 0, expected: 0 [ 11.368429][ T39] locks held by kworker/u20:0/39: 8, last CPU#3: [ 11.368432][ T39] #0: ff1100000114a940 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0xd9a/0x1560 [ 11.368444][ T39] #1: ffa00000002bfd10 ((linkwatch_work).work){+.+.}-{0:0}, at: process_one_work+0xdfc/0x1560 [ 11.368448][ T39] #2: ffffffffb26d2c40 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0x4e/0xb0 [ 11.368453][ T39] #3: ff1100000f0cae58 (&br->lock){+...}-{3:3}, at: br_port_carrier_check+0x161/0x430 [bridge] [ 11.368468][ T39] #4: ffffffffb1f69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.368473][ T39] #5: ffffffffb1f69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.368476][ T39] #6: ffffffffb1e89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.368480][ T39] #7: ffffffffb1e89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.368484][ T39] irq event stamp: 70141 [ 11.368485][ T39] hardirqs last enabled at (70140): [] __down_trylock_console_sem+0x86/0xa0 [ 11.368487][ T39] hardirqs last disabled at (70141): [] console_emit_next_record+0x3d4/0x4c0 [ 11.368489][ T39] softirqs last enabled at (70102): [] inet6_fill_ifla6_attrs+0x1b3e/0x21e0 [ 11.368493][ T39] softirqs last disabled at (70136): [] br_port_carrier_check+0x161/0x430 [bridge] [ 11.368501][ T39] Preemption disabled at: [ 11.368501][ T39] [<0000000000000000>] 0x0 [ 11.368508][ T39] CPU: 3 UID: 0 PID: 39 Comm: kworker/u20:0 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.368511][ T39] Tainted: [W]=WARN [ 11.368512][ T39] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.368514][ T39] Workqueue: events_unbound linkwatch_event [ 11.368518][ T39] Call Trace: [ 11.368519][ T39] [ 11.368521][ T39] dump_stack_lvl+0x6f/0xa0 [ 11.368527][ T39] __might_resched.cold+0x1fe/0x2c1 [ 11.368532][ T39] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.368536][ T39] ? __kmalloc_noprof+0xdb/0x760 [ 11.368541][ T39] __kmalloc_noprof+0x443/0x760 [ 11.368543][ T39] ? alloc_buf.isra.0+0x4b/0x260 [ 11.368548][ T39] ? do_raw_spin_unlock+0x59/0x250 [ 11.368551][ T39] alloc_buf.isra.0+0x4b/0x260 [ 11.368554][ T39] put_chars+0x1e1/0x2f0 [ 11.368557][ T39] ? __send_to_port+0x420/0x420 [ 11.368560][ T39] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.368564][ T39] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.368566][ T39] ? validate_chain+0x38b/0xc20 [ 11.368570][ T39] hvc_console_print+0x292/0x780 [ 11.368573][ T39] ? mark_usage+0x61/0x170 [ 11.368574][ T39] ? __lock_acquire+0x518/0xc20 [ 11.368576][ T39] ? __lock_acquire+0x518/0xc20 [ 11.368580][ T39] ? hvc_write+0x3a0/0x3a0 [ 11.368581][ T39] ? lock_acquire.part.0+0xd4/0x280 [ 11.368585][ T39] ? lock_acquire+0x13c/0x160 [ 11.368589][ T39] console_emit_next_record+0x22f/0x4c0 [ 11.368593][ T39] ? devkmsg_read+0x4b0/0x4b0 [ 11.368595][ T39] ? console_flush_one_record+0x106/0x710 [ 11.368598][ T39] ? rcu_is_watching+0x16/0xd0 [ 11.368601][ T39] ? lock_acquire+0x13c/0x160 [ 11.368605][ T39] console_flush_one_record+0x46f/0x710 [ 11.368609][ T39] ? console_emit_next_record+0x4c0/0x4c0 [ 11.368610][ T39] ? __lock_acquire+0x518/0xc20 [ 11.368616][ T39] console_unlock+0xee/0x1f0 [ 11.368618][ T39] ? console_flush_one_record+0x710/0x710 [ 11.368620][ T39] ? rcu_is_watching+0x16/0xd0 [ 11.368622][ T39] ? lock_acquire+0x60/0x160 [ 11.368626][ T39] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.368628][ T39] ? vprintk_emit+0x320/0x3e0 [ 11.368631][ T39] vprintk_emit+0x37c/0x3e0 [ 11.368635][ T39] ? wake_up_klogd_work_func+0x90/0x90 [ 11.368638][ T39] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.368640][ T39] ? rcu_read_lock_any_held+0x3c/0x90 [ 11.368644][ T39] _printk+0xc7/0x100 [ 11.368648][ T39] ? snapshot_read.cold+0x21/0x21 [ 11.368653][ T39] ? lock_acquire.part.0+0xd4/0x280 [ 11.368657][ T39] br_set_state+0x22f/0x430 [bridge] [ 11.368667][ T39] br_init_port+0xc4/0x200 [bridge] [ 11.368676][ T39] br_stp_enable_port+0x12/0x50 [bridge] [ 11.368682][ T39] br_port_carrier_check+0x220/0x430 [bridge] [ 11.368691][ T39] br_device_event+0x52d/0x8f0 [bridge] [ 11.368699][ T39] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 11.368701][ T39] ? nlmsg_notify+0x62/0x250 [ 11.368708][ T39] notifier_call_chain+0xae/0x300 [ 11.368713][ T39] netif_state_change+0x139/0x340 [ 11.368718][ T39] ? call_netdevice_notifiers_info+0xd0/0xd0 [ 11.368723][ T39] ? linkwatch_do_dev+0xae/0xd0 [ 11.368725][ T39] __linkwatch_run_queue+0x34c/0x750 [ 11.368728][ T39] ? linkwatch_do_dev+0xd0/0xd0 [ 11.368730][ T39] ? lock_acquire.part.0+0xd4/0x280 [ 11.368735][ T39] linkwatch_event+0x7f/0xb0 [ 11.368737][ T39] ? __linkwatch_run_queue+0x750/0x750 [ 11.368740][ T39] process_one_work+0xe3e/0x1560 [ 11.368746][ T39] ? __queue_delayed_work+0x470/0x470 [ 11.368749][ T39] ? lock_acquire.part.0+0xd4/0x280 [ 11.368757][ T39] worker_thread+0x4f1/0xd60 [ 11.368764][ T39] ? rescuer_thread+0x1340/0x1340 [ 11.368766][ T39] kthread+0x367/0x460 [ 11.368768][ T39] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.368770][ T39] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.368773][ T39] ret_from_fork+0x474/0x6b0 [ 11.368777][ T39] ? arch_exit_to_user_mode_prepare.isra.0+0x120/0x120 [ 11.368780][ T39] ? __switch_to+0x5a3/0xe00 [ 11.368784][ T39] ? kthread_affine_preferred+0x4c0/0x4c0 [ 11.368787][ T39] ret_from_fork_asm+0x11/0x20 [ 11.368795][ T39] [ 11.394940][ T39] br0: port 2(veth2) entered forwarding state [ 23.826242][ T658] jq (658) used greatest stack depth: 23952 bytes left [ 23.826261][ T658] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 23.826263][ T658] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 658, name: jq [ 23.826264][ T658] preempt_count: 2, expected: 0 [ 23.826265][ T658] RCU nest depth: 0, expected: 0 [ 23.826266][ T658] locks held by jq/658: 5, last CPU#3: [ 23.826269][ T658] #0: ffffffffb1e027b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 23.826281][ T658] #1: ffffffffb1f69cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 23.826286][ T658] #2: ffffffffb1f69d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 23.826290][ T658] #3: ffffffffb1e89660 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 23.826294][ T658] #4: ffffffffb1e89560 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 23.826298][ T658] irq event stamp: 14212 [ 23.826299][ T658] hardirqs last enabled at (14211): [] __down_trylock_console_sem+0x86/0xa0 [ 23.826301][ T658] hardirqs last disabled at (14212): [] console_emit_next_record+0x3d4/0x4c0 [ 23.826303][ T658] softirqs last enabled at (11858): [] handle_softirqs+0x67c/0x900 [ 23.826305][ T658] softirqs last disabled at (11851): [] __irq_exit_rcu+0x145/0x1c0 [ 23.826308][ T658] Preemption disabled at: [ 23.826308][ T658] [<0000000000000000>] 0x0 [ 23.826315][ T658] CPU: 3 UID: 0 PID: 658 Comm: jq Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 23.826319][ T658] Tainted: [W]=WARN [ 23.826320][ T658] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 23.826321][ T658] Call Trace: [ 23.826323][ T658] [ 23.826324][ T658] dump_stack_lvl+0x6f/0xa0 [ 23.826330][ T658] __might_resched.cold+0x1fe/0x2c1 [ 23.826335][ T658] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 23.826339][ T658] ? __kmalloc_noprof+0xdb/0x760 [ 23.826344][ T658] __kmalloc_noprof+0x443/0x760 [ 23.826346][ T658] ? alloc_buf.isra.0+0x4b/0x260 [ 23.826352][ T658] ? do_raw_spin_unlock+0x59/0x250 [ 23.826355][ T658] alloc_buf.isra.0+0x4b/0x260 [ 23.826358][ T658] put_chars+0x1e1/0x2f0 [ 23.826360][ T658] ? __send_to_port+0x420/0x420 [ 23.826362][ T658] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 23.826366][ T658] ? validate_chain+0x38b/0xc20 [ 23.826371][ T658] hvc_console_print+0x292/0x780 [ 23.826377][ T658] ? hvc_write+0x3a0/0x3a0 [ 23.826379][ T658] ? rcu_is_watching+0x16/0xd0 [ 23.826382][ T658] ? lock_acquire+0x13c/0x160 [ 23.826385][ T658] console_emit_next_record+0x22f/0x4c0 [ 23.826389][ T658] ? devkmsg_read+0x4b0/0x4b0 [ 23.826391][ T658] ? console_flush_one_record+0x106/0x710 [ 23.826394][ T658] ? rcu_is_watching+0x16/0xd0 [ 23.826396][ T658] ? lock_acquire+0x13c/0x160 [ 23.826400][ T658] console_flush_one_record+0x46f/0x710 [ 23.826404][ T658] ? console_emit_next_record+0x4c0/0x4c0 [ 23.826406][ T658] ? __lock_acquire+0x518/0xc20 [ 23.826410][ T658] console_unlock+0xee/0x1f0 [ 23.826413][ T658] ? console_flush_one_record+0x710/0x710 [ 23.826415][ T658] ? rcu_is_watching+0x16/0xd0 [ 23.826417][ T658] ? lock_acquire+0x60/0x160 [ 23.826421][ T658] ? __down_trylock_console_sem+0x5e/0xa0 [ 23.826423][ T658] ? vprintk_emit+0x320/0x3e0 [ 23.826426][ T658] vprintk_emit+0x37c/0x3e0 [ 23.826429][ T658] ? wake_up_klogd_work_func+0x90/0x90 [ 23.826433][ T658] ? __lock_acquire+0x518/0xc20 [ 23.826436][ T658] _printk+0xc7/0x100 [ 23.826440][ T658] ? snapshot_read.cold+0x21/0x21 [ 23.826443][ T658] ? do_raw_spin_lock+0x131/0x280 [ 23.826449][ T658] ? __rwlock_init+0x150/0x150 [ 23.826453][ T658] ? do_raw_spin_lock+0x131/0x280 [ 23.826455][ T658] do_exit.cold+0x82/0x9c [ 23.826459][ T658] ? exit_notify+0x890/0x890 [ 23.826461][ T658] ? __lock_release.isra.0+0x69/0x1a0 [ 23.826463][ T658] ? rcu_is_watching+0x16/0xd0 [ 23.826468][ T658] do_group_exit+0xb8/0x370 [ 23.826470][ T658] __x64_sys_exit_group+0x3c/0x50 [ 23.826472][ T658] x64_sys_call+0x1567/0x1570 [ 23.826474][ T658] do_syscall_64+0xff/0x530 [ 23.826477][ T658] ? exc_page_fault+0xee/0x100 [ 23.826480][ T658] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 23.826483][ T658] RIP: 0033:0x7f0f284961b8 [ 23.826485][ T658] Code: Unable to access opcode bytes at 0x7f0f2849618e. [ 23.826486][ T658] RSP: 002b:00007ffca8b66d78 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 23.826489][ T658] RAX: ffffffffffffffda RBX: 00007f0f285c6f88 RCX: 00007f0f284961b8 [ 23.826490][ T658] RDX: 00007f0f282baa48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 23.826491][ T658] RBP: 00007ffca8b66dd0 R08: 00000000ffffffff R09: 0000000000000020 [ 23.826491][ T658] R10: 00007ffca8b66bf0 R11: 0000000000000246 R12: 0000000000000004 [ 23.826492][ T658] R13: 0000000000000000 R14: 00007f0f285c5680 R15: 00007f0f285c6fa0 [ 23.826499][ T658] [ 26.511260][ C3] [ 26.511276][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.511278][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 26.511280][ C3] preempt_count: 104, expected: 0 [ 26.511280][ C3] RCU nest depth: 0, expected: 0 [ 26.511281][ C3] INFO: lockdep is turned off. [ 26.511282][ C3] irq event stamp: 1064128 [ 26.511283][ C3] hardirqs last enabled at (1064128): [] _raw_spin_unlock_irq+0x28/0x50 [ 26.511292][ C3] hardirqs last disabled at (1064127): [] _raw_spin_lock_irq+0x4a/0x50 [ 26.511294][ C3] softirqs last enabled at (1064118): [] handle_softirqs+0x67c/0x900 [ 26.511297][ C3] softirqs last disabled at (1064125): [] __irq_exit_rcu+0x145/0x1c0 [ 26.511299][ C3] Preemption disabled at: [ 26.511300][ C3] [<0000000000000000>] 0x0 [ 26.511306][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.511310][ C3] Tainted: [W]=WARN [ 26.511310][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.511312][ C3] Call Trace: [ 26.511314][ C3] [ 26.511316][ C3] dump_stack_lvl+0x6f/0xa0 [ 26.511321][ C3] __might_resched.cold+0x1fe/0x2c1 [ 26.511325][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.511329][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.511332][ C3] ? __asan_memcpy+0x3c/0x60 [ 26.511335][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511337][ C3] __kmalloc_noprof+0x443/0x760 [ 26.511340][ C3] ? __rwlock_init+0x150/0x150 [ 26.511343][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 26.511347][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 26.511348][ C3] alloc_buf.isra.0+0x4b/0x260 [ 26.511350][ C3] put_chars+0x1e1/0x2f0 [ 26.511352][ C3] ? __send_to_port+0x420/0x420 [ 26.511354][ C3] ? console_prepend_replay+0x20/0x20 [ 26.511357][ C3] hvc_console_print+0x292/0x780 [ 26.511361][ C3] ? hvc_write+0x3a0/0x3a0 [ 26.511362][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511364][ C3] ? lock_acquire+0x13c/0x160 [ 26.511366][ C3] console_emit_next_record+0x22f/0x4c0 [ 26.511369][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 26.511371][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511372][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511374][ C3] ? lock_acquire+0x13c/0x160 [ 26.511376][ C3] ? console_flush_one_record+0x111/0x710 [ 26.511378][ C3] console_flush_one_record+0x46f/0x710 [ 26.511380][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 26.511383][ C3] console_unlock+0xee/0x1f0 [ 26.511384][ C3] ? lock_acquire+0x13c/0x160 [ 26.511386][ C3] ? console_flush_one_record+0x710/0x710 [ 26.511388][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511389][ C3] ? lock_release+0x184/0x1f0 [ 26.511391][ C3] ? lock_acquire+0x60/0x160 [ 26.511393][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.511394][ C3] ? vprintk_emit+0x320/0x3e0 [ 26.511396][ C3] vprintk_emit+0x37c/0x3e0 [ 26.511399][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 26.511401][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511413][ C3] ? lock_release+0x184/0x1f0 [ 26.511414][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511421][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511427][ C3] ? is_module_text_address+0x154/0x250 [ 26.511430][ C3] _printk+0xc7/0x100 [ 26.511434][ C3] ? snapshot_read.cold+0x21/0x21 [ 26.511435][ C3] ? arch_stack_walk+0xd7/0x130 [ 26.511439][ C3] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.511442][ C3] ? nbcon_cpu_emergency_enter+0x28/0x80 [ 26.511443][ C3] print_irq_inversion_bug.part.0+0x32/0xc0 [ 26.511446][ C3] mark_lock_irq+0x989/0x9c0 [ 26.511449][ C3] mark_lock+0x1d7/0xa00 [ 26.511453][ C3] mark_usage+0x42/0x170 [ 26.511455][ C3] __lock_acquire+0x388/0xc20 [ 26.511457][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.511459][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511466][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511468][ C3] ? lock_acquire+0x13c/0x160 [ 26.511469][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.511476][ C3] _raw_spin_lock+0x33/0x40 [ 26.511477][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511484][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.511490][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.511498][ C3] call_timer_fn+0x160/0x4d0 [ 26.511501][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 26.511502][ C3] ? debug_object_active_state+0x430/0x430 [ 26.511506][ C3] ? find_held_lock+0x2b/0x80 [ 26.511508][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.511509][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511512][ C3] __run_timers+0x68f/0xaa0 [ 26.511514][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.511521][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.511522][ C3] ? __lock_acquire+0x518/0xc20 [ 26.511525][ C3] ? __rwlock_init+0x150/0x150 [ 26.511528][ C3] run_timer_softirq+0xf0/0x160 [ 26.511530][ C3] ? __run_timers+0xaa0/0xaa0 [ 26.511531][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.511533][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511535][ C3] handle_softirqs+0x1d3/0x900 [ 26.511537][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.511539][ C3] ? _local_bh_enable+0xc0/0xc0 [ 26.511541][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.511542][ C3] irq_exit_rcu+0xe/0x30 [ 26.511544][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.511547][ C3] [ 26.511547][ C3] [ 26.511548][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 26.511550][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.511552][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.511555][ C3] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 26.511556][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 26.511560][ C3] RAX: 0000000000103cbb RBX: ff11000001c88040 RCX: ffffffffaecf0307 [ 26.511561][ C3] RDX: ff11000001c88040 RSI: ffffffffb1a38af6 RDI: ffffffffb148d8e0 [ 26.511562][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.511563][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 26.511563][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.511565][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.511568][ C3] default_idle+0x9/0x10 [ 26.511570][ C3] default_idle_call+0x6e/0xb0 [ 26.511572][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.511573][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 26.511575][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 26.511577][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.511579][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.511581][ C3] do_idle+0xd8/0x190 [ 26.511582][ C3] cpu_startup_entry+0x53/0x70 [ 26.511584][ C3] start_secondary+0x204/0x2b0 [ 26.511586][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.511588][ C3] common_startup_64+0x13e/0x148 [ 26.511592][ C3] [ 26.530317][ C3] ======================================================== [ 26.530528][ C3] WARNING: possible irq lock inversion dependency detected [ 26.530742][ C3] 7.2.0-virtme #1 Tainted: G W [ 26.530917][ C3] -------------------------------------------------------- [ 26.531124][ C3] swapper/3/0 just changed the state of lock: [ 26.531303][ C3] ff1100000f0cae58 (&br->lock){+.-.}-{3:3}, at: br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.531602][ C3] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 26.531813][ C3] (fs_reclaim){+.+.}-{0:0} [ 26.531815][ C3] [ 26.531815][ C3] [ 26.531815][ C3] and interrupts could create inverse lock ordering between them. [ 26.531815][ C3] [ 26.532379][ C3] [ 26.532379][ C3] other info that might help us debug this: [ 26.532635][ C3] Chain exists of: [ 26.532635][ C3] &br->lock --> console_owner --> fs_reclaim [ 26.532635][ C3] [ 26.533000][ C3] Possible interrupt unsafe locking scenario: [ 26.533000][ C3] [ 26.533258][ C3] CPU0 CPU1 [ 26.533403][ C3] ---- ---- [ 26.533595][ C3] lock(fs_reclaim); [ 26.533705][ C3] local_irq_disable(); [ 26.533923][ C3] lock(&br->lock); [ 26.534143][ C3] lock(console_owner); [ 26.534317][ C3] [ 26.534472][ C3] lock(&br->lock); [ 26.534577][ C3] [ 26.534577][ C3] *** DEADLOCK *** [ 26.534577][ C3] [ 26.534821][ C3] locks held by swapper/3/0: 1, last CPU#3: [ 26.534992][ C3] #0: ffa0000000280c90 ((&p->forward_delay_timer)){+.-.}-{0:0}, at: call_timer_fn+0x110/0x4d0 [ 26.535323][ C3] [ 26.535323][ C3] the shortest dependencies between 2nd lock and 1st lock: [ 26.535612][ C3] -> (fs_reclaim){+.+.}-{0:0} { [ 26.535801][ C3] HARDIRQ-ON-W at: [ 26.535909][ C3] __lock_acquire+0x388/0xc20 [ 26.536134][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.536311][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.536538][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.536796][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.537009][ C3] workqueue_init+0x2a/0x680 [ 26.537236][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.537500][ C3] kernel_init+0x21/0x150 [ 26.537682][ C3] ret_from_fork+0x474/0x6b0 [ 26.537907][ C3] ret_from_fork_asm+0x11/0x20 [ 26.538135][ C3] SOFTIRQ-ON-W at: [ 26.538241][ C3] __lock_acquire+0x388/0xc20 [ 26.538469][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.538646][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.538873][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.539131][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.539345][ C3] workqueue_init+0x2a/0x680 [ 26.539568][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.539824][ C3] kernel_init+0x21/0x150 [ 26.540000][ C3] ret_from_fork+0x474/0x6b0 [ 26.540224][ C3] ret_from_fork_asm+0x11/0x20 [ 26.540447][ C3] INITIAL USE at: [ 26.540561][ C3] __lock_acquire+0x388/0xc20 [ 26.540787][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.540964][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.541190][ C3] __kmalloc_cache_noprof+0x6e/0x620 [ 26.541459][ C3] kthread_create_worker_on_node+0xea/0x210 [ 26.541679][ C3] workqueue_init+0x2a/0x680 [ 26.541906][ C3] kernel_init_freeable+0x2fe/0x630 [ 26.542134][ C3] kernel_init+0x21/0x150 [ 26.542308][ C3] ret_from_fork+0x474/0x6b0 [ 26.542532][ C3] ret_from_fork_asm+0x11/0x20 [ 26.542760][ C3] } [ 26.542834][ C3] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 26.543095][ C3] ... acquired at: [ 26.543202][ C3] __lock_acquire+0x518/0xc20 [ 26.543346][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.543537][ C3] fs_reclaim_acquire+0xd5/0x120 [ 26.543677][ C3] __kmalloc_noprof+0xd3/0x760 [ 26.543861][ C3] alloc_buf.isra.0+0x4b/0x260 [ 26.544003][ C3] put_chars+0x1e1/0x2f0 [ 26.544190][ C3] hvc_console_print+0x292/0x780 [ 26.544334][ C3] console_emit_next_record+0x22f/0x4c0 [ 26.544525][ C3] console_flush_one_record+0x46f/0x710 [ 26.544667][ C3] console_unlock+0xee/0x1f0 [ 26.544855][ C3] vprintk_emit+0x37c/0x3e0 [ 26.544997][ C3] dev_vprintk_emit+0x27f/0x2c0 [ 26.545187][ C3] dev_printk_emit+0xb9/0xee [ 26.545329][ C3] _dev_info+0xe2/0x116 [ 26.545485][ C3] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 26.545662][ C3] cmos_do_probe+0x73b/0x98a [ 26.545851][ C3] platform_probe+0xfe/0x1f0 [ 26.545992][ C3] call_driver_probe+0x61/0x1c0 [ 26.546179][ C3] really_probe+0x199/0x760 [ 26.546320][ C3] __driver_probe_device+0x24f/0x440 [ 26.546513][ C3] driver_probe_device+0x4a/0xf0 [ 26.546656][ C3] __driver_attach+0x1b8/0x540 [ 26.546847][ C3] bus_for_each_dev+0x130/0x1e0 [ 26.546988][ C3] bus_add_driver+0x2c8/0x530 [ 26.547175][ C3] driver_register+0x1a3/0x390 [ 26.547317][ C3] __platform_driver_probe+0x13f/0x270 [ 26.547507][ C3] cmos_init+0x31/0x40 [ 26.547612][ C3] do_one_initcall+0x124/0x4f0 [ 26.547801][ C3] kernel_init_freeable+0x596/0x630 [ 26.547945][ C3] kernel_init+0x21/0x150 [ 26.548131][ C3] ret_from_fork+0x474/0x6b0 [ 26.548271][ C3] ret_from_fork_asm+0x11/0x20 [ 26.548478][ C3] [ 26.548551][ C3] -> (console_owner){....}-{0:0} { [ 26.548745][ C3] INITIAL USE at: [ 26.548853][ C3] } [ 26.548924][ C3] ... key at: [] console_owner_dep_map+0x0/0x60 [ 26.549181][ C3] ... acquired at: [ 26.549285][ C3] __lock_acquire+0x518/0xc20 [ 26.549476][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.549616][ C3] console_lock_spinning_enable+0x5c/0x60 [ 26.549836][ C3] console_emit_next_record+0x1d1/0x4c0 [ 26.549974][ C3] console_flush_one_record+0x46f/0x710 [ 26.550156][ C3] console_unlock+0xee/0x1f0 [ 26.550290][ C3] vprintk_emit+0x37c/0x3e0 [ 26.550476][ C3] _printk+0xc7/0x100 [ 26.550581][ C3] br_set_state+0x22f/0x430 [bridge] [ 26.550771][ C3] br_init_port+0xc4/0x200 [bridge] [ 26.550913][ C3] br_stp_enable_port+0x12/0x50 [bridge] [ 26.551134][ C3] br_port_carrier_check+0x220/0x430 [bridge] [ 26.551362][ C3] br_device_event+0x52d/0x8f0 [bridge] [ 26.551516][ C3] notifier_call_chain+0xae/0x300 [ 26.551704][ C3] netif_state_change+0x139/0x340 [ 26.551846][ C3] __linkwatch_run_queue+0x34c/0x750 [ 26.552032][ C3] linkwatch_event+0x7f/0xb0 [ 26.552171][ C3] process_one_work+0xe3e/0x1560 [ 26.552359][ C3] worker_thread+0x4f1/0xd60 [ 26.552504][ C3] kthread+0x367/0x460 [ 26.552610][ C3] ret_from_fork+0x474/0x6b0 [ 26.552799][ C3] ret_from_fork_asm+0x11/0x20 [ 26.552938][ C3] [ 26.553054][ C3] -> (&br->lock){+.-.}-{3:3} { [ 26.553199][ C3] HARDIRQ-ON-W at: [ 26.553350][ C3] __lock_acquire+0x388/0xc20 [ 26.553534][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.553763][ C3] _raw_spin_lock_bh+0x38/0x50 [ 26.553941][ C3] br_stp_enable_bridge+0x23/0x340 [bridge] [ 26.554204][ C3] br_dev_open+0x94/0x120 [bridge] [ 26.554435][ C3] __dev_open+0x2f3/0x610 [ 26.554619][ C3] __dev_change_flags+0x4a4/0x660 [ 26.554842][ C3] netif_change_flags+0x87/0x190 [ 26.555064][ C3] do_setlink.isra.0+0x1cc3/0x2750 [ 26.555245][ C3] rtnl_newlink+0x9f1/0x11c0 [ 26.555468][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.555688][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 26.555861][ C3] netlink_unicast+0x486/0x750 [ 26.556082][ C3] netlink_sendmsg+0x735/0xc60 [ 26.556255][ C3] ____sys_sendmsg+0x415/0x880 [ 26.556481][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 26.556705][ C3] __sys_sendmsg+0x12c/0x1d0 [ 26.556875][ C3] do_syscall_64+0xff/0x530 [ 26.557123][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.557384][ C3] IN-SOFTIRQ-W at: [ 26.557494][ C3] __lock_acquire+0x388/0xc20 [ 26.557720][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.557899][ C3] _raw_spin_lock+0x33/0x40 [ 26.558122][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.558386][ C3] call_timer_fn+0x160/0x4d0 [ 26.558564][ C3] __run_timers+0x68f/0xaa0 [ 26.558785][ C3] run_timer_softirq+0xf0/0x160 [ 26.559000][ C3] handle_softirqs+0x1d3/0x900 [ 26.559172][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.559391][ C3] irq_exit_rcu+0xe/0x30 [ 26.559571][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.559830][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.560077][ C3] pv_native_safe_halt+0xf/0x10 [ 26.560248][ C3] default_idle+0x9/0x10 [ 26.560416][ C3] default_idle_call+0x6e/0xb0 [ 26.560636][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.560894][ C3] do_idle+0xd8/0x190 [ 26.561039][ C3] cpu_startup_entry+0x53/0x70 [ 26.561264][ C3] start_secondary+0x204/0x2b0 [ 26.561442][ C3] common_startup_64+0x13e/0x148 [ 26.561674][ C3] INITIAL USE at: [ 26.561779][ C3] __lock_acquire+0x388/0xc20 [ 26.561999][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.562222][ C3] _raw_spin_lock_bh+0x38/0x50 [ 26.562399][ C3] br_stp_enable_bridge+0x23/0x340 [bridge] [ 26.562665][ C3] br_dev_open+0x94/0x120 [bridge] [ 26.562896][ C3] __dev_open+0x2f3/0x610 [ 26.563073][ C3] __dev_change_flags+0x4a4/0x660 [ 26.563298][ C3] netif_change_flags+0x87/0x190 [ 26.563479][ C3] do_setlink.isra.0+0x1cc3/0x2750 [ 26.563704][ C3] rtnl_newlink+0x9f1/0x11c0 [ 26.563926][ C3] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 26.564101][ C3] netlink_rcv_skb+0x14e/0x3a0 [ 26.564322][ C3] netlink_unicast+0x486/0x750 [ 26.564547][ C3] netlink_sendmsg+0x735/0xc60 [ 26.564720][ C3] ____sys_sendmsg+0x415/0x880 [ 26.564941][ C3] ___sys_sendmsg+0x14e/0x1d0 [ 26.565113][ C3] __sys_sendmsg+0x12c/0x1d0 [ 26.565325][ C3] do_syscall_64+0xff/0x530 [ 26.565548][ C3] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.565759][ C3] } [ 26.565873][ C3] ... key at: [] __key.7+0x0/0x40 [bridge] [ 26.566077][ C3] ... acquired at: [ 26.566225][ C3] mark_lock+0x1d7/0xa00 [ 26.566367][ C3] mark_usage+0x42/0x170 [ 26.566556][ C3] __lock_acquire+0x388/0xc20 [ 26.566696][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.566880][ C3] _raw_spin_lock+0x33/0x40 [ 26.567017][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.567243][ C3] call_timer_fn+0x160/0x4d0 [ 26.567380][ C3] __run_timers+0x68f/0xaa0 [ 26.567567][ C3] run_timer_softirq+0xf0/0x160 [ 26.567703][ C3] handle_softirqs+0x1d3/0x900 [ 26.567880][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.568015][ C3] irq_exit_rcu+0xe/0x30 [ 26.568196][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.568409][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.568582][ C3] pv_native_safe_halt+0xf/0x10 [ 26.568765][ C3] default_idle+0x9/0x10 [ 26.568904][ C3] default_idle_call+0x6e/0xb0 [ 26.569082][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.569249][ C3] do_idle+0xd8/0x190 [ 26.569395][ C3] cpu_startup_entry+0x53/0x70 [ 26.569536][ C3] start_secondary+0x204/0x2b0 [ 26.569720][ C3] common_startup_64+0x13e/0x148 [ 26.569861][ C3] [ 26.569931][ C3] [ 26.569931][ C3] stack backtrace: [ 26.570157][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.570161][ C3] Tainted: [W]=WARN [ 26.570162][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.570163][ C3] Call Trace: [ 26.570165][ C3] [ 26.570167][ C3] dump_stack_lvl+0x6f/0xa0 [ 26.570171][ C3] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 26.570175][ C3] mark_lock_irq+0x989/0x9c0 [ 26.570178][ C3] mark_lock+0x1d7/0xa00 [ 26.570180][ C3] mark_usage+0x42/0x170 [ 26.570181][ C3] __lock_acquire+0x388/0xc20 [ 26.570184][ C3] lock_acquire.part.0+0xd4/0x280 [ 26.570185][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.570193][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.570196][ C3] ? lock_acquire+0x13c/0x160 [ 26.570198][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.570204][ C3] _raw_spin_lock+0x33/0x40 [ 26.570205][ C3] ? br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.570212][ C3] br_forward_delay_timer_expired+0x44/0x5d0 [bridge] [ 26.570218][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.570224][ C3] call_timer_fn+0x160/0x4d0 [ 26.570226][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 26.570228][ C3] ? debug_object_active_state+0x430/0x430 [ 26.570231][ C3] ? find_held_lock+0x2b/0x80 [ 26.570233][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.570235][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.570237][ C3] __run_timers+0x68f/0xaa0 [ 26.570239][ C3] ? br_message_age_timer_expired+0x70/0x70 [bridge] [ 26.570246][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 26.570247][ C3] ? __lock_acquire+0x518/0xc20 [ 26.570250][ C3] ? __rwlock_init+0x150/0x150 [ 26.570252][ C3] run_timer_softirq+0xf0/0x160 [ 26.570254][ C3] ? __run_timers+0xaa0/0xaa0 [ 26.570256][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.570258][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.570260][ C3] handle_softirqs+0x1d3/0x900 [ 26.570262][ C3] ? __lock_release.isra.0+0x69/0x1a0 [ 26.570264][ C3] ? _local_bh_enable+0xc0/0xc0 [ 26.570266][ C3] __irq_exit_rcu+0x145/0x1c0 [ 26.570267][ C3] irq_exit_rcu+0xe/0x30 [ 26.570268][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 26.570270][ C3] [ 26.570271][ C3] [ 26.570271][ C3] ? lockdep_hardirqs_on+0x91/0x130 [ 26.570273][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 26.570275][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 26.570277][ C3] Code: 48 8b 3d 94 d2 f5 01 e8 1f 00 00 00 48 2b 05 58 93 95 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 86 11 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 26.570279][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000282 [ 26.570282][ C3] RAX: 0000000000103cbb RBX: ff11000001c88040 RCX: ffffffffaecf0307 [ 26.570283][ C3] RDX: ff11000001c88040 RSI: ffffffffb1a38af6 RDI: ffffffffb148d8e0 [ 26.570284][ C3] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 [ 26.570286][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: 1ff400000002cfc3 [ 26.570286][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 26.570288][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.570290][ C3] default_idle+0x9/0x10 [ 26.570292][ C3] default_idle_call+0x6e/0xb0 [ 26.570293][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 26.570295][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 26.570297][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 26.570298][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 26.570299][ C3] ? rcu_is_watching+0x16/0xd0 [ 26.570301][ C3] do_idle+0xd8/0x190 [ 26.570303][ C3] cpu_startup_entry+0x53/0x70 [ 26.570304][ C3] start_secondary+0x204/0x2b0 [ 26.570306][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 26.570308][ C3] common_startup_64+0x13e/0x148 [ 26.570310][ C3] [ 50.119936][ T2057] br0: port 2(veth2) entered disabled state [ 50.119953][ T2057] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 50.119955][ T2057] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 2057, name: ip [ 50.119957][ T2057] preempt_count: 202, expected: 0 [ 50.119958][ T2057] RCU nest depth: 0, expected: 0 [ 50.119958][ T2057] INFO: lockdep is turned off. [ 50.119960][ T2057] irq event stamp: 0 [ 50.119960][ T2057] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 50.119965][ T2057] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 50.119971][ T2057] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 50.119972][ T2057] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 50.119974][ T2057] Preemption disabled at: [ 50.119975][ T2057] [<0000000000000000>] 0x0 [ 50.119979][ T2057] CPU: 3 UID: 0 PID: 2057 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 50.119983][ T2057] Tainted: [W]=WARN [ 50.119984][ T2057] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 50.119985][ T2057] Call Trace: [ 50.119987][ T2057] [ 50.119988][ T2057] dump_stack_lvl+0x6f/0xa0 [ 50.119994][ T2057] __might_resched.cold+0x1fe/0x2c1 [ 50.119998][ T2057] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 50.120001][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120005][ T2057] __kmalloc_noprof+0x443/0x760 [ 50.120009][ T2057] ? __rwlock_init+0x150/0x150 [ 50.120011][ T2057] ? alloc_buf.isra.0+0x4b/0x260 [ 50.120015][ T2057] ? do_raw_spin_unlock+0x59/0x250 [ 50.120017][ T2057] alloc_buf.isra.0+0x4b/0x260 [ 50.120019][ T2057] put_chars+0x1e1/0x2f0 [ 50.120020][ T2057] ? __send_to_port+0x420/0x420 [ 50.120022][ T2057] ? printk_get_next_message+0x240/0x650 [ 50.120025][ T2057] hvc_console_print+0x292/0x780 [ 50.120028][ T2057] ? hvc_write+0x3a0/0x3a0 [ 50.120031][ T2057] ? __rwlock_init+0x150/0x150 [ 50.120032][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120034][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120036][ T2057] console_emit_next_record+0x22f/0x4c0 [ 50.120038][ T2057] ? devkmsg_read+0x4b0/0x4b0 [ 50.120040][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120042][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120043][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120045][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120047][ T2057] ? console_flush_one_record+0x111/0x710 [ 50.120048][ T2057] console_flush_one_record+0x46f/0x710 [ 50.120051][ T2057] ? console_emit_next_record+0x4c0/0x4c0 [ 50.120053][ T2057] console_unlock+0xee/0x1f0 [ 50.120055][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120056][ T2057] ? console_flush_one_record+0x710/0x710 [ 50.120058][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120059][ T2057] ? lock_release+0x184/0x1f0 [ 50.120061][ T2057] ? lock_acquire+0x60/0x160 [ 50.120062][ T2057] ? __rcu_read_lock+0x30/0x70 [ 50.120064][ T2057] ? __down_trylock_console_sem+0x5e/0xa0 [ 50.120066][ T2057] ? vprintk_emit+0x320/0x3e0 [ 50.120068][ T2057] vprintk_emit+0x37c/0x3e0 [ 50.120070][ T2057] ? wake_up_klogd_work_func+0x90/0x90 [ 50.120072][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120073][ T2057] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 50.120076][ T2057] ? trace_hardirqs_on+0x36/0x40 [ 50.120077][ T2057] _printk+0xc7/0x100 [ 50.120080][ T2057] ? snapshot_read.cold+0x21/0x21 [ 50.120082][ T2057] ? ipv6_mc_down+0x17e/0x2d0 [ 50.120087][ T2057] br_set_state+0x22f/0x430 [bridge] [ 50.120099][ T2057] br_stp_disable_port+0x11f/0x390 [bridge] [ 50.120107][ T2057] br_device_event+0x7b5/0x8f0 [bridge] [ 50.120115][ T2057] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 50.120118][ T2057] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 50.120120][ T2057] ? addrconf_notify+0x2c8/0xf30 [ 50.120123][ T2057] notifier_call_chain+0xae/0x300 [ 50.120126][ T2057] __dev_notify_flags+0x23c/0x3c0 [ 50.120130][ T2057] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 50.120131][ T2057] ? netif_change_name+0x8c0/0x8c0 [ 50.120133][ T2057] ? netif_set_allmulti+0x250/0x250 [ 50.120135][ T2057] ? __kernel_text_address+0x12/0x30 [ 50.120137][ T2057] ? write_profile+0xf0/0xf0 [ 50.120139][ T2057] ? unwind_get_return_address+0x67/0xd0 [ 50.120142][ T2057] netif_change_flags+0xfe/0x190 [ 50.120144][ T2057] do_setlink.isra.0+0x1cc3/0x2750 [ 50.120147][ T2057] ? stack_trace_save+0x93/0xc0 [ 50.120149][ T2057] ? rtnl_link_get_size+0x350/0x350 [ 50.120150][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120151][ T2057] ? stack_depot_save_flags+0x1bc/0x790 [ 50.120155][ T2057] ? kasan_save_stack+0x3d/0x50 [ 50.120158][ T2057] ? kasan_save_stack+0x2f/0x50 [ 50.120159][ T2057] ? kasan_save_track+0x14/0x30 [ 50.120160][ T2057] ? __kasan_kmalloc+0x7b/0x90 [ 50.120162][ T2057] ? __kmalloc_cache_noprof+0x29a/0x620 [ 50.120163][ T2057] ? rtnl_newlink+0x124/0x11c0 [ 50.120164][ T2057] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 50.120165][ T2057] ? netlink_rcv_skb+0x14e/0x3a0 [ 50.120168][ T2057] ? netlink_unicast+0x486/0x750 [ 50.120169][ T2057] ? netlink_sendmsg+0x735/0xc60 [ 50.120170][ T2057] ? ____sys_sendmsg+0x415/0x880 [ 50.120173][ T2057] ? ___sys_sendmsg+0x14e/0x1d0 [ 50.120174][ T2057] ? __sys_sendmsg+0x12c/0x1d0 [ 50.120176][ T2057] ? do_syscall_64+0xff/0x530 [ 50.120178][ T2057] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 50.120180][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120182][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120183][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120185][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120187][ T2057] ? trace_contention_end+0xb3/0x180 [ 50.120190][ T2057] ? __mutex_lock+0x1db/0x1ea0 [ 50.120191][ T2057] ? __mutex_lock+0x9a3/0x1ea0 [ 50.120192][ T2057] ? rtnl_newlink+0x9a8/0x11c0 [ 50.120194][ T2057] ? ww_mutex_lock+0x160/0x160 [ 50.120196][ T2057] ? __rtnl_newlink+0x3fa/0xa50 [ 50.120198][ T2057] rtnl_newlink+0x9f1/0x11c0 [ 50.120200][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120202][ T2057] ? rtnl_bridge_getlink+0x850/0x850 [ 50.120203][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120204][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120206][ T2057] ? is_bpf_text_address+0x3e/0x110 [ 50.120212][ T2057] ? is_bpf_text_address+0x72/0x110 [ 50.120214][ T2057] ? kernel_text_address+0x149/0x170 [ 50.120215][ T2057] ? __kernel_text_address+0x12/0x30 [ 50.120216][ T2057] ? write_profile+0xf0/0xf0 [ 50.120217][ T2057] ? unwind_get_return_address+0x67/0xd0 [ 50.120219][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120220][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120222][ T2057] ? cap_capable+0x1d7/0x3d0 [ 50.120225][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120227][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120229][ T2057] ? rtnl_bridge_getlink+0x850/0x850 [ 50.120230][ T2057] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 50.120231][ T2057] ? rtnl_link_fill+0x920/0x920 [ 50.120233][ T2057] ? filter_irq_stacks+0xd0/0xd0 [ 50.120234][ T2057] ? stack_depot_save_flags+0x1bc/0x790 [ 50.120236][ T2057] netlink_rcv_skb+0x14e/0x3a0 [ 50.120238][ T2057] ? rtnl_link_fill+0x920/0x920 [ 50.120239][ T2057] ? lock_release+0x184/0x1f0 [ 50.120241][ T2057] ? netlink_ack+0xcf0/0xcf0 [ 50.120242][ T2057] ? __netlink_lookup+0xb9/0x6b0 [ 50.120244][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120246][ T2057] ? lock_release+0x184/0x1f0 [ 50.120248][ T2057] netlink_unicast+0x486/0x750 [ 50.120250][ T2057] ? netlink_attachskb+0x810/0x810 [ 50.120251][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120253][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120255][ T2057] ? lock_acquire+0x13c/0x160 [ 50.120256][ T2057] netlink_sendmsg+0x735/0xc60 [ 50.120258][ T2057] ? netlink_unicast+0x750/0x750 [ 50.120260][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120262][ T2057] ? lock_release+0x184/0x1f0 [ 50.120264][ T2057] ____sys_sendmsg+0x415/0x880 [ 50.120265][ T2057] ? copy_msghdr_from_user+0x279/0x420 [ 50.120267][ T2057] ? get_timestamp.constprop.0+0x390/0x390 [ 50.120268][ T2057] ? move_addr_to_kernel+0x40/0x40 [ 50.120270][ T2057] ? filter_irq_stacks+0xd0/0xd0 [ 50.120272][ T2057] ___sys_sendmsg+0x14e/0x1d0 [ 50.120274][ T2057] ? copy_msghdr_from_user+0x420/0x420 [ 50.120279][ T2057] __sys_sendmsg+0x12c/0x1d0 [ 50.120281][ T2057] ? __sys_sendmsg_sock+0x20/0x20 [ 50.120283][ T2057] ? rcu_is_watching+0x16/0xd0 [ 50.120285][ T2057] do_syscall_64+0xff/0x530 [ 50.120287][ T2057] ? exc_page_fault+0xee/0x100 [ 50.120289][ T2057] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 50.120290][ T2057] RIP: 0033:0x7f9ee3adc54e [ 50.120292][ T2057] Code: 4d 89 d8 e8 b4 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 [ 50.120294][ T2057] RSP: 002b:00007fffca6eb540 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 50.120297][ T2057] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f9ee3adc54e [ 50.120299][ T2057] RDX: 0000000000000000 RSI: 00007fffca6eb5f0 RDI: 0000000000000005 [ 50.120299][ T2057] RBP: 00007fffca6eb550 R08: 0000000000000000 R09: 0000000000000000 [ 50.120300][ T2057] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91afff [ 50.120301][ T2057] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007fffca6ebcb0 [ 50.120303][ T2057] [ 50.154410][ T2057] ip (2057) used greatest stack depth: 23016 bytes left [ 50.174338][ T2058] veth2: left allmulticast mode [ 50.174519][ T2058] veth2: left promiscuous mode [ 50.174728][ T2058] br0: port 2(veth2) entered disabled state [ 50.192498][ T2059] br0: port 1(veth1) entered disabled state [ 50.214335][ T2060] veth1: left allmulticast mode [ 50.214494][ T2060] veth1: left promiscuous mode [ 50.214701][ T2060] br0: port 1(veth1) entered disabled state [ 50.384975][ T2078] br0: port 1(veth1) entered blocking state [ 50.385252][ T2078] br0: port 1(veth1) entered disabled state [ 50.385491][ T2078] veth1: entered allmulticast mode [ 50.386419][ T2078] veth1: entered promiscuous mode [ 50.406902][ T2079] br0: port 1(veth1) entered blocking state [ 50.407112][ T2079] br0: port 1(veth1) entered forwarding state [ 50.481755][ T2083] br0: port 2(veth2) entered blocking state [ 50.482019][ T2083] br0: port 2(veth2) entered disabled state [ 50.488006][ T2083] veth2: entered allmulticast mode [ 50.488994][ T2083] veth2: entered promiscuous mode [ 50.504139][ T69] br0: port 2(veth2) entered blocking state [ 50.504384][ T69] br0: port 2(veth2) entered forwarding state [ 87.468153][ T3880] br0: port 2(veth2) entered disabled state [ 87.468171][ T3880] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 87.468173][ T3880] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 3880, name: ip [ 87.468175][ T3880] preempt_count: 202, expected: 0 [ 87.468176][ T3880] RCU nest depth: 0, expected: 0 [ 87.468177][ T3880] INFO: lockdep is turned off. [ 87.468178][ T3880] irq event stamp: 0 [ 87.468179][ T3880] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 87.468183][ T3880] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 87.468189][ T3880] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 87.468191][ T3880] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 87.468193][ T3880] Preemption disabled at: [ 87.468194][ T3880] [<0000000000000000>] 0x0 [ 87.468198][ T3880] CPU: 0 UID: 0 PID: 3880 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 87.468202][ T3880] Tainted: [W]=WARN [ 87.468203][ T3880] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 87.468204][ T3880] Call Trace: [ 87.468206][ T3880] [ 87.468207][ T3880] dump_stack_lvl+0x6f/0xa0 [ 87.468215][ T3880] __might_resched.cold+0x1fe/0x2c1 [ 87.468218][ T3880] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 87.468222][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468226][ T3880] __kmalloc_noprof+0x443/0x760 [ 87.468230][ T3880] ? __rwlock_init+0x150/0x150 [ 87.468233][ T3880] ? alloc_buf.isra.0+0x4b/0x260 [ 87.468237][ T3880] ? do_raw_spin_unlock+0x59/0x250 [ 87.468239][ T3880] alloc_buf.isra.0+0x4b/0x260 [ 87.468241][ T3880] put_chars+0x1e1/0x2f0 [ 87.468243][ T3880] ? __send_to_port+0x420/0x420 [ 87.468244][ T3880] ? printk_get_next_message+0x240/0x650 [ 87.468248][ T3880] hvc_console_print+0x292/0x780 [ 87.468251][ T3880] ? hvc_write+0x3a0/0x3a0 [ 87.468253][ T3880] ? __rwlock_init+0x150/0x150 [ 87.468255][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468257][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468259][ T3880] console_emit_next_record+0x22f/0x4c0 [ 87.468261][ T3880] ? devkmsg_read+0x4b0/0x4b0 [ 87.468263][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468265][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468267][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468268][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468270][ T3880] ? console_flush_one_record+0x111/0x710 [ 87.468272][ T3880] console_flush_one_record+0x46f/0x710 [ 87.468274][ T3880] ? console_emit_next_record+0x4c0/0x4c0 [ 87.468277][ T3880] console_unlock+0xee/0x1f0 [ 87.468279][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468280][ T3880] ? console_flush_one_record+0x710/0x710 [ 87.468282][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468283][ T3880] ? lock_release+0x184/0x1f0 [ 87.468285][ T3880] ? lock_acquire+0x60/0x160 [ 87.468286][ T3880] ? __rcu_read_lock+0x30/0x70 [ 87.468288][ T3880] ? __down_trylock_console_sem+0x5e/0xa0 [ 87.468290][ T3880] ? vprintk_emit+0x320/0x3e0 [ 87.468292][ T3880] vprintk_emit+0x37c/0x3e0 [ 87.468295][ T3880] ? wake_up_klogd_work_func+0x90/0x90 [ 87.468297][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468298][ T3880] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 87.468301][ T3880] ? trace_hardirqs_on+0x36/0x40 [ 87.468302][ T3880] _printk+0xc7/0x100 [ 87.468305][ T3880] ? snapshot_read.cold+0x21/0x21 [ 87.468308][ T3880] ? ipv6_mc_down+0x17e/0x2d0 [ 87.468312][ T3880] br_set_state+0x22f/0x430 [bridge] [ 87.468325][ T3880] br_stp_disable_port+0x11f/0x390 [bridge] [ 87.468333][ T3880] br_device_event+0x7b5/0x8f0 [bridge] [ 87.468342][ T3880] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 87.468345][ T3880] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 87.468347][ T3880] ? addrconf_notify+0x2c8/0xf30 [ 87.468351][ T3880] notifier_call_chain+0xae/0x300 [ 87.468354][ T3880] __dev_notify_flags+0x23c/0x3c0 [ 87.468358][ T3880] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 87.468360][ T3880] ? netif_change_name+0x8c0/0x8c0 [ 87.468362][ T3880] ? netif_set_allmulti+0x250/0x250 [ 87.468364][ T3880] ? __kernel_text_address+0x12/0x30 [ 87.468366][ T3880] ? write_profile+0xf0/0xf0 [ 87.468368][ T3880] ? unwind_get_return_address+0x67/0xd0 [ 87.468371][ T3880] netif_change_flags+0xfe/0x190 [ 87.468373][ T3880] do_setlink.isra.0+0x1cc3/0x2750 [ 87.468376][ T3880] ? stack_trace_save+0x93/0xc0 [ 87.468378][ T3880] ? rtnl_link_get_size+0x350/0x350 [ 87.468379][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468380][ T3880] ? stack_depot_save_flags+0x1bc/0x790 [ 87.468385][ T3880] ? kasan_save_stack+0x3d/0x50 [ 87.468387][ T3880] ? kasan_save_stack+0x2f/0x50 [ 87.468389][ T3880] ? kasan_save_track+0x14/0x30 [ 87.468390][ T3880] ? __kasan_kmalloc+0x7b/0x90 [ 87.468392][ T3880] ? __kmalloc_cache_noprof+0x29a/0x620 [ 87.468393][ T3880] ? rtnl_newlink+0x124/0x11c0 [ 87.468394][ T3880] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 87.468396][ T3880] ? netlink_rcv_skb+0x14e/0x3a0 [ 87.468398][ T3880] ? netlink_unicast+0x486/0x750 [ 87.468399][ T3880] ? netlink_sendmsg+0x735/0xc60 [ 87.468401][ T3880] ? ____sys_sendmsg+0x415/0x880 [ 87.468403][ T3880] ? ___sys_sendmsg+0x14e/0x1d0 [ 87.468405][ T3880] ? __sys_sendmsg+0x12c/0x1d0 [ 87.468406][ T3880] ? do_syscall_64+0xff/0x530 [ 87.468408][ T3880] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 87.468411][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468413][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468414][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468416][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468417][ T3880] ? trace_contention_end+0xb3/0x180 [ 87.468421][ T3880] ? __mutex_lock+0x1db/0x1ea0 [ 87.468422][ T3880] ? __mutex_lock+0x9a3/0x1ea0 [ 87.468423][ T3880] ? rtnl_newlink+0x9a8/0x11c0 [ 87.468425][ T3880] ? ww_mutex_lock+0x160/0x160 [ 87.468427][ T3880] ? __rtnl_newlink+0x3fa/0xa50 [ 87.468429][ T3880] rtnl_newlink+0x9f1/0x11c0 [ 87.468431][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468433][ T3880] ? rtnl_bridge_getlink+0x850/0x850 [ 87.468434][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468435][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468437][ T3880] ? is_bpf_text_address+0x3e/0x110 [ 87.468441][ T3880] ? is_bpf_text_address+0x72/0x110 [ 87.468442][ T3880] ? kernel_text_address+0x149/0x170 [ 87.468444][ T3880] ? __kernel_text_address+0x12/0x30 [ 87.468445][ T3880] ? write_profile+0xf0/0xf0 [ 87.468446][ T3880] ? unwind_get_return_address+0x67/0xd0 [ 87.468447][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468449][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468451][ T3880] ? cap_capable+0x1d7/0x3d0 [ 87.468454][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468456][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468457][ T3880] ? rtnl_bridge_getlink+0x850/0x850 [ 87.468459][ T3880] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 87.468460][ T3880] ? rtnl_link_fill+0x920/0x920 [ 87.468462][ T3880] ? filter_irq_stacks+0xd0/0xd0 [ 87.468463][ T3880] ? stack_depot_save_flags+0x1bc/0x790 [ 87.468465][ T3880] netlink_rcv_skb+0x14e/0x3a0 [ 87.468467][ T3880] ? rtnl_link_fill+0x920/0x920 [ 87.468468][ T3880] ? lock_release+0x184/0x1f0 [ 87.468470][ T3880] ? netlink_ack+0xcf0/0xcf0 [ 87.468471][ T3880] ? __netlink_lookup+0xb9/0x6b0 [ 87.468473][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468475][ T3880] ? lock_release+0x184/0x1f0 [ 87.468477][ T3880] netlink_unicast+0x486/0x750 [ 87.468479][ T3880] ? netlink_attachskb+0x810/0x810 [ 87.468481][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468482][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468484][ T3880] ? lock_acquire+0x13c/0x160 [ 87.468486][ T3880] netlink_sendmsg+0x735/0xc60 [ 87.468488][ T3880] ? netlink_unicast+0x750/0x750 [ 87.468490][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468491][ T3880] ? lock_release+0x184/0x1f0 [ 87.468493][ T3880] ____sys_sendmsg+0x415/0x880 [ 87.468495][ T3880] ? copy_msghdr_from_user+0x279/0x420 [ 87.468497][ T3880] ? get_timestamp.constprop.0+0x390/0x390 [ 87.468498][ T3880] ? move_addr_to_kernel+0x40/0x40 [ 87.468499][ T3880] ? filter_irq_stacks+0xd0/0xd0 [ 87.468502][ T3880] ___sys_sendmsg+0x14e/0x1d0 [ 87.468504][ T3880] ? copy_msghdr_from_user+0x420/0x420 [ 87.468509][ T3880] __sys_sendmsg+0x12c/0x1d0 [ 87.468510][ T3880] ? __sys_sendmsg_sock+0x20/0x20 [ 87.468513][ T3880] ? rcu_is_watching+0x16/0xd0 [ 87.468515][ T3880] do_syscall_64+0xff/0x530 [ 87.468516][ T3880] ? exc_page_fault+0xee/0x100 [ 87.468519][ T3880] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 87.468520][ T3880] RIP: 0033:0x7f057281354e [ 87.468522][ T3880] Code: 4d 89 d8 e8 b4 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 [ 87.468524][ T3880] RSP: 002b:00007ffe5eeec640 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 87.468528][ T3880] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f057281354e [ 87.468529][ T3880] RDX: 0000000000000000 RSI: 00007ffe5eeec6f0 RDI: 0000000000000005 [ 87.468530][ T3880] RBP: 00007ffe5eeec650 R08: 0000000000000000 R09: 0000000000000000 [ 87.468531][ T3880] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b024 [ 87.468532][ T3880] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe5eeecdb0 [ 87.468534][ T3880] [ 87.516919][ T3881] veth2: left allmulticast mode [ 87.517085][ T3881] veth2: left promiscuous mode [ 87.517291][ T3881] br0: port 2(veth2) entered disabled state [ 87.537224][ T3882] br0: port 1(veth1) entered disabled state [ 87.551362][ T3883] veth1: left allmulticast mode [ 87.551516][ T3883] veth1: left promiscuous mode [ 87.551722][ T3883] br0: port 1(veth1) entered disabled state [ 87.732569][ T3901] br0: port 1(veth1) entered blocking state [ 87.732839][ T3901] br0: port 1(veth1) entered disabled state [ 87.733098][ T3901] veth1: entered allmulticast mode [ 87.734387][ T3901] veth1: entered promiscuous mode [ 87.757290][ T3902] br0: port 1(veth1) entered blocking state [ 87.757547][ T3902] br0: port 1(veth1) entered forwarding state [ 87.830269][ T3906] br0: port 2(veth2) entered blocking state [ 87.830472][ T3906] br0: port 2(veth2) entered disabled state [ 87.830669][ T3906] veth2: entered allmulticast mode [ 87.831608][ T3906] veth2: entered promiscuous mode [ 87.846494][ T189] br0: port 2(veth2) entered blocking state [ 87.852666][ T189] br0: port 2(veth2) entered forwarding state [ 160.676333][ T7759] br0: port 2(veth2) entered disabled state [ 160.676349][ T7759] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 160.676351][ T7759] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 7759, name: ip [ 160.676353][ T7759] preempt_count: 202, expected: 0 [ 160.676354][ T7759] RCU nest depth: 0, expected: 0 [ 160.676355][ T7759] INFO: lockdep is turned off. [ 160.676356][ T7759] irq event stamp: 0 [ 160.676356][ T7759] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 160.676361][ T7759] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 160.676367][ T7759] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 160.676369][ T7759] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 160.676371][ T7759] Preemption disabled at: [ 160.676372][ T7759] [<0000000000000000>] 0x0 [ 160.676376][ T7759] CPU: 2 UID: 0 PID: 7759 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 160.676380][ T7759] Tainted: [W]=WARN [ 160.676381][ T7759] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 160.676382][ T7759] Call Trace: [ 160.676384][ T7759] [ 160.676385][ T7759] dump_stack_lvl+0x6f/0xa0 [ 160.676391][ T7759] __might_resched.cold+0x1fe/0x2c1 [ 160.676395][ T7759] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 160.676398][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676402][ T7759] __kmalloc_noprof+0x443/0x760 [ 160.676405][ T7759] ? __rwlock_init+0x150/0x150 [ 160.676408][ T7759] ? alloc_buf.isra.0+0x4b/0x260 [ 160.676412][ T7759] ? do_raw_spin_unlock+0x59/0x250 [ 160.676413][ T7759] alloc_buf.isra.0+0x4b/0x260 [ 160.676415][ T7759] put_chars+0x1e1/0x2f0 [ 160.676417][ T7759] ? __send_to_port+0x420/0x420 [ 160.676419][ T7759] ? printk_get_next_message+0x240/0x650 [ 160.676422][ T7759] hvc_console_print+0x292/0x780 [ 160.676425][ T7759] ? hvc_write+0x3a0/0x3a0 [ 160.676427][ T7759] ? __rwlock_init+0x150/0x150 [ 160.676429][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676430][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676432][ T7759] console_emit_next_record+0x22f/0x4c0 [ 160.676435][ T7759] ? devkmsg_read+0x4b0/0x4b0 [ 160.676437][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676438][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676440][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676442][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676443][ T7759] ? console_flush_one_record+0x111/0x710 [ 160.676445][ T7759] console_flush_one_record+0x46f/0x710 [ 160.676447][ T7759] ? console_emit_next_record+0x4c0/0x4c0 [ 160.676450][ T7759] console_unlock+0xee/0x1f0 [ 160.676451][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676453][ T7759] ? console_flush_one_record+0x710/0x710 [ 160.676454][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676456][ T7759] ? lock_release+0x184/0x1f0 [ 160.676457][ T7759] ? lock_acquire+0x60/0x160 [ 160.676459][ T7759] ? __rcu_read_lock+0x30/0x70 [ 160.676461][ T7759] ? __down_trylock_console_sem+0x5e/0xa0 [ 160.676463][ T7759] ? vprintk_emit+0x320/0x3e0 [ 160.676465][ T7759] vprintk_emit+0x37c/0x3e0 [ 160.676467][ T7759] ? wake_up_klogd_work_func+0x90/0x90 [ 160.676469][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676471][ T7759] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 160.676473][ T7759] ? trace_hardirqs_on+0x36/0x40 [ 160.676475][ T7759] _printk+0xc7/0x100 [ 160.676478][ T7759] ? snapshot_read.cold+0x21/0x21 [ 160.676480][ T7759] ? ipv6_mc_down+0x17e/0x2d0 [ 160.676484][ T7759] br_set_state+0x22f/0x430 [bridge] [ 160.676497][ T7759] br_stp_disable_port+0x11f/0x390 [bridge] [ 160.676505][ T7759] br_device_event+0x7b5/0x8f0 [bridge] [ 160.676514][ T7759] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 160.676517][ T7759] ? _sub_I_65535_1+0x4d0/0x4d0 [stp] [ 160.676519][ T7759] ? addrconf_notify+0x2c8/0xf30 [ 160.676522][ T7759] notifier_call_chain+0xae/0x300 [ 160.676525][ T7759] __dev_notify_flags+0x23c/0x3c0 [ 160.676529][ T7759] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 160.676530][ T7759] ? netif_change_name+0x8c0/0x8c0 [ 160.676532][ T7759] ? netif_set_allmulti+0x250/0x250 [ 160.676534][ T7759] ? __kernel_text_address+0x12/0x30 [ 160.676536][ T7759] ? write_profile+0xf0/0xf0 [ 160.676538][ T7759] ? unwind_get_return_address+0x67/0xd0 [ 160.676541][ T7759] netif_change_flags+0xfe/0x190 [ 160.676543][ T7759] do_setlink.isra.0+0x1cc3/0x2750 [ 160.676546][ T7759] ? stack_trace_save+0x93/0xc0 [ 160.676548][ T7759] ? rtnl_link_get_size+0x350/0x350 [ 160.676549][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676550][ T7759] ? stack_depot_save_flags+0x1bc/0x790 [ 160.676554][ T7759] ? kasan_save_stack+0x3d/0x50 [ 160.676557][ T7759] ? kasan_save_stack+0x2f/0x50 [ 160.676558][ T7759] ? kasan_save_track+0x14/0x30 [ 160.676560][ T7759] ? __kasan_kmalloc+0x7b/0x90 [ 160.676561][ T7759] ? __kmalloc_cache_noprof+0x29a/0x620 [ 160.676562][ T7759] ? rtnl_newlink+0x124/0x11c0 [ 160.676564][ T7759] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 160.676565][ T7759] ? netlink_rcv_skb+0x14e/0x3a0 [ 160.676567][ T7759] ? netlink_unicast+0x486/0x750 [ 160.676569][ T7759] ? netlink_sendmsg+0x735/0xc60 [ 160.676570][ T7759] ? ____sys_sendmsg+0x415/0x880 [ 160.676572][ T7759] ? ___sys_sendmsg+0x14e/0x1d0 [ 160.676574][ T7759] ? __sys_sendmsg+0x12c/0x1d0 [ 160.676575][ T7759] ? do_syscall_64+0xff/0x530 [ 160.676577][ T7759] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 160.676580][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676581][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676583][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676584][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676586][ T7759] ? trace_contention_end+0xb3/0x180 [ 160.676589][ T7759] ? __mutex_lock+0x1db/0x1ea0 [ 160.676591][ T7759] ? __mutex_lock+0x9a3/0x1ea0 [ 160.676592][ T7759] ? rtnl_newlink+0x9a8/0x11c0 [ 160.676594][ T7759] ? ww_mutex_lock+0x160/0x160 [ 160.676596][ T7759] ? __rtnl_newlink+0x3fa/0xa50 [ 160.676598][ T7759] rtnl_newlink+0x9f1/0x11c0 [ 160.676599][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676601][ T7759] ? rtnl_bridge_getlink+0x850/0x850 [ 160.676602][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676604][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676605][ T7759] ? is_bpf_text_address+0x3e/0x110 [ 160.676609][ T7759] ? is_bpf_text_address+0x72/0x110 [ 160.676610][ T7759] ? kernel_text_address+0x149/0x170 [ 160.676611][ T7759] ? __kernel_text_address+0x12/0x30 [ 160.676613][ T7759] ? write_profile+0xf0/0xf0 [ 160.676614][ T7759] ? unwind_get_return_address+0x67/0xd0 [ 160.676615][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676617][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676618][ T7759] ? cap_capable+0x1d7/0x3d0 [ 160.676622][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676623][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676625][ T7759] ? rtnl_bridge_getlink+0x850/0x850 [ 160.676626][ T7759] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 160.676628][ T7759] ? rtnl_link_fill+0x920/0x920 [ 160.676629][ T7759] ? filter_irq_stacks+0xd0/0xd0 [ 160.676630][ T7759] ? stack_depot_save_flags+0x1bc/0x790 [ 160.676633][ T7759] netlink_rcv_skb+0x14e/0x3a0 [ 160.676634][ T7759] ? rtnl_link_fill+0x920/0x920 [ 160.676635][ T7759] ? lock_release+0x184/0x1f0 [ 160.676637][ T7759] ? netlink_ack+0xcf0/0xcf0 [ 160.676638][ T7759] ? __netlink_lookup+0xb9/0x6b0 [ 160.676640][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676642][ T7759] ? lock_release+0x184/0x1f0 [ 160.676644][ T7759] netlink_unicast+0x486/0x750 [ 160.676646][ T7759] ? netlink_attachskb+0x810/0x810 [ 160.676647][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676649][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676651][ T7759] ? lock_acquire+0x13c/0x160 [ 160.676652][ T7759] netlink_sendmsg+0x735/0xc60 [ 160.676654][ T7759] ? netlink_unicast+0x750/0x750 [ 160.676656][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676658][ T7759] ? lock_release+0x184/0x1f0 [ 160.676660][ T7759] ____sys_sendmsg+0x415/0x880 [ 160.676661][ T7759] ? copy_msghdr_from_user+0x279/0x420 [ 160.676663][ T7759] ? get_timestamp.constprop.0+0x390/0x390 [ 160.676664][ T7759] ? move_addr_to_kernel+0x40/0x40 [ 160.676666][ T7759] ? filter_irq_stacks+0xd0/0xd0 [ 160.676668][ T7759] ___sys_sendmsg+0x14e/0x1d0 [ 160.676670][ T7759] ? copy_msghdr_from_user+0x420/0x420 [ 160.676675][ T7759] __sys_sendmsg+0x12c/0x1d0 [ 160.676677][ T7759] ? __sys_sendmsg_sock+0x20/0x20 [ 160.676679][ T7759] ? rcu_is_watching+0x16/0xd0 [ 160.676681][ T7759] do_syscall_64+0xff/0x530 [ 160.676682][ T7759] ? exc_page_fault+0xee/0x100 [ 160.676685][ T7759] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 160.676686][ T7759] RIP: 0033:0x7f49d720754e [ 160.676688][ T7759] Code: 4d 89 d8 e8 b4 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 [ 160.676690][ T7759] RSP: 002b:00007ffc4c346420 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 160.676693][ T7759] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f49d720754e [ 160.676695][ T7759] RDX: 0000000000000000 RSI: 00007ffc4c3464d0 RDI: 0000000000000005 [ 160.676696][ T7759] RBP: 00007ffc4c346430 R08: 0000000000000000 R09: 0000000000000000 [ 160.676696][ T7759] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b06e [ 160.676697][ T7759] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc4c346b90 [ 160.676700][ T7759] [ 160.727050][ T7760] veth2: left allmulticast mode [ 160.727223][ T7760] veth2: left promiscuous mode [ 160.727423][ T7760] br0: port 2(veth2) entered disabled state [ 160.746469][ T7761] br0: port 1(veth1) entered disabled state [ 160.760041][ T7762] veth1: left allmulticast mode [ 160.760198][ T7762] veth1: left promiscuous mode [ 160.760426][ T7762] br0: port 1(veth1) entered disabled state [ 160.940491][ T7780] br0: port 1(veth1) entered blocking state [ 160.940754][ T7780] br0: port 1(veth1) entered disabled state [ 160.941006][ T7780] veth1: entered allmulticast mode [ 160.941950][ T7780] veth1: entered promiscuous mode [ 160.973839][ T7781] br0: port 1(veth1) entered blocking state [ 160.974144][ T7781] br0: port 1(veth1) entered forwarding state [ 161.051204][ T7785] br0: port 2(veth2) entered blocking state [ 161.051471][ T7785] br0: port 2(veth2) entered disabled state [ 161.051719][ T7785] veth2: entered allmulticast mode [ 161.052678][ T7785] veth2: entered promiscuous mode [ 161.082500][ T46] br0: port 2(veth2) entered blocking state [ 161.082700][ T46] br0: port 2(veth2) entered forwarding state [ 166.335999][ T7809] br0: port 2(veth2) entered disabled state [ 166.336014][ T7809] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 166.336016][ T7809] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 7809, name: ip [ 166.336018][ T7809] preempt_count: 202, expected: 0 [ 166.336019][ T7809] RCU nest depth: 0, expected: 0 [ 166.336020][ T7809] INFO: lockdep is turned off. [ 166.336021][ T7809] irq event stamp: 0 [ 166.336021][ T7809] hardirqs last enabled at (0): [<0000000000000000>] 0x0 [ 166.336026][ T7809] hardirqs last disabled at (0): [] copy_process+0x1ccd/0x6240 [ 166.336032][ T7809] softirqs last enabled at (0): [] copy_process+0x1d21/0x6240 [ 166.336033][ T7809] softirqs last disabled at (0): [<0000000000000000>] 0x0 [ 166.336035][ T7809] Preemption disabled at: [ 166.336036][ T7809] [<0000000000000000>] 0x0 [ 166.336040][ T7809] CPU: 3 UID: 0 PID: 7809 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 166.336044][ T7809] Tainted: [W]=WARN [ 166.336045][ T7809] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 166.336046][ T7809] Call Trace: [ 166.336048][ T7809] [ 166.336049][ T7809] dump_stack_lvl+0x6f/0xa0 [ 166.336055][ T7809] __might_resched.cold+0x1fe/0x2c1 [ 166.336059][ T7809] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 166.336062][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336066][ T7809] __kmalloc_noprof+0x443/0x760 [ 166.336070][ T7809] ? __rwlock_init+0x150/0x150 [ 166.336073][ T7809] ? alloc_buf.isra.0+0x4b/0x260 [ 166.336076][ T7809] ? do_raw_spin_unlock+0x59/0x250 [ 166.336078][ T7809] alloc_buf.isra.0+0x4b/0x260 [ 166.336080][ T7809] put_chars+0x1e1/0x2f0 [ 166.336081][ T7809] ? desc_read_finalized_seq+0x79/0x120 [ 166.336083][ T7809] ? __send_to_port+0x420/0x420 [ 166.336085][ T7809] ? console_prepend_replay+0x20/0x20 [ 166.336088][ T7809] hvc_console_print+0x292/0x780 [ 166.336091][ T7809] ? hvc_write+0x3a0/0x3a0 [ 166.336092][ T7809] ? do_raw_spin_lock+0x131/0x280 [ 166.336094][ T7809] ? __rwlock_init+0x150/0x150 [ 166.336095][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336097][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336099][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336101][ T7809] console_emit_next_record+0x22f/0x4c0 [ 166.336103][ T7809] ? devkmsg_read+0x4b0/0x4b0 [ 166.336105][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336107][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336108][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336110][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336112][ T7809] ? console_flush_one_record+0x111/0x710 [ 166.336113][ T7809] console_flush_one_record+0x46f/0x710 [ 166.336115][ T7809] ? console_emit_next_record+0x4c0/0x4c0 [ 166.336118][ T7809] console_unlock+0xee/0x1f0 [ 166.336119][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336121][ T7809] ? console_flush_one_record+0x710/0x710 [ 166.336122][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336124][ T7809] ? lock_release+0x184/0x1f0 [ 166.336125][ T7809] ? lock_acquire+0x60/0x160 [ 166.336127][ T7809] ? __rcu_read_lock+0x30/0x70 [ 166.336129][ T7809] ? __down_trylock_console_sem+0x5e/0xa0 [ 166.336130][ T7809] ? vprintk_emit+0x320/0x3e0 [ 166.336132][ T7809] vprintk_emit+0x37c/0x3e0 [ 166.336136][ T7809] ? wake_up_klogd_work_func+0x90/0x90 [ 166.336138][ T7809] ? debug_object_assert_init+0x1d9/0x360 [ 166.336141][ T7809] ? debug_object_activate+0x4a0/0x4a0 [ 166.336143][ T7809] _printk+0xc7/0x100 [ 166.336147][ T7809] ? snapshot_read.cold+0x21/0x21 [ 166.336149][ T7809] ? __rwlock_init+0x150/0x150 [ 166.336150][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336152][ T7809] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 166.336155][ T7809] br_set_state+0x22f/0x430 [bridge] [ 166.336168][ T7809] br_stp_disable_port+0x11f/0x390 [bridge] [ 166.336176][ T7809] br_stp_disable_bridge+0xb9/0x180 [bridge] [ 166.336182][ T7809] br_dev_stop+0x28/0x1a0 [bridge] [ 166.336190][ T7809] ? rtnl_is_locked+0x15/0x20 [ 166.336193][ T7809] __dev_close_many+0x1c8/0x530 [ 166.336196][ T7809] ? netif_open+0x120/0x120 [ 166.336198][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336200][ T7809] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 166.336201][ T7809] __dev_change_flags+0x288/0x660 [ 166.336204][ T7809] ? netif_set_allmulti+0x250/0x250 [ 166.336206][ T7809] ? __kernel_text_address+0x12/0x30 [ 166.336207][ T7809] ? write_profile+0xf0/0xf0 [ 166.336212][ T7809] ? unwind_get_return_address+0x67/0xd0 [ 166.336215][ T7809] netif_change_flags+0x87/0x190 [ 166.336217][ T7809] do_setlink.isra.0+0x1cc3/0x2750 [ 166.336220][ T7809] ? stack_trace_save+0x93/0xc0 [ 166.336221][ T7809] ? rtnl_link_get_size+0x350/0x350 [ 166.336222][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336224][ T7809] ? stack_depot_save_flags+0x1bc/0x790 [ 166.336227][ T7809] ? kasan_save_stack+0x3d/0x50 [ 166.336230][ T7809] ? kasan_save_stack+0x2f/0x50 [ 166.336231][ T7809] ? kasan_save_track+0x14/0x30 [ 166.336233][ T7809] ? __kasan_kmalloc+0x7b/0x90 [ 166.336234][ T7809] ? __kmalloc_cache_noprof+0x29a/0x620 [ 166.336235][ T7809] ? rtnl_newlink+0x124/0x11c0 [ 166.336236][ T7809] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 166.336238][ T7809] ? netlink_rcv_skb+0x14e/0x3a0 [ 166.336240][ T7809] ? netlink_unicast+0x486/0x750 [ 166.336241][ T7809] ? netlink_sendmsg+0x735/0xc60 [ 166.336243][ T7809] ? ____sys_sendmsg+0x415/0x880 [ 166.336245][ T7809] ? ___sys_sendmsg+0x14e/0x1d0 [ 166.336247][ T7809] ? __sys_sendmsg+0x12c/0x1d0 [ 166.336248][ T7809] ? do_syscall_64+0xff/0x530 [ 166.336251][ T7809] ? entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 166.336253][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336255][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336256][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336258][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336260][ T7809] ? trace_contention_end+0xb3/0x180 [ 166.336263][ T7809] ? __mutex_lock+0x1db/0x1ea0 [ 166.336265][ T7809] ? __mutex_lock+0x9a3/0x1ea0 [ 166.336266][ T7809] ? rtnl_newlink+0x9a8/0x11c0 [ 166.336268][ T7809] ? ww_mutex_lock+0x160/0x160 [ 166.336270][ T7809] ? __rtnl_newlink+0x3fa/0xa50 [ 166.336272][ T7809] rtnl_newlink+0x9f1/0x11c0 [ 166.336274][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336275][ T7809] ? rtnl_bridge_getlink+0x850/0x850 [ 166.336277][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336278][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336280][ T7809] ? is_bpf_text_address+0x3e/0x110 [ 166.336283][ T7809] ? is_bpf_text_address+0x72/0x110 [ 166.336285][ T7809] ? kernel_text_address+0x149/0x170 [ 166.336286][ T7809] ? __kernel_text_address+0x12/0x30 [ 166.336287][ T7809] ? write_profile+0xf0/0xf0 [ 166.336288][ T7809] ? unwind_get_return_address+0x67/0xd0 [ 166.336290][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336291][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336293][ T7809] ? cap_capable+0x1d7/0x3d0 [ 166.336296][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336297][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336299][ T7809] ? rtnl_bridge_getlink+0x850/0x850 [ 166.336300][ T7809] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 166.336302][ T7809] ? rtnl_link_fill+0x920/0x920 [ 166.336303][ T7809] ? filter_irq_stacks+0xd0/0xd0 [ 166.336304][ T7809] ? stack_depot_save_flags+0x1bc/0x790 [ 166.336307][ T7809] netlink_rcv_skb+0x14e/0x3a0 [ 166.336308][ T7809] ? rtnl_link_fill+0x920/0x920 [ 166.336309][ T7809] ? lock_release+0x184/0x1f0 [ 166.336311][ T7809] ? netlink_ack+0xcf0/0xcf0 [ 166.336312][ T7809] ? __netlink_lookup+0xb9/0x6b0 [ 166.336314][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336316][ T7809] ? lock_release+0x184/0x1f0 [ 166.336318][ T7809] netlink_unicast+0x486/0x750 [ 166.336320][ T7809] ? netlink_attachskb+0x810/0x810 [ 166.336321][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336323][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336325][ T7809] ? lock_acquire+0x13c/0x160 [ 166.336326][ T7809] netlink_sendmsg+0x735/0xc60 [ 166.336328][ T7809] ? netlink_unicast+0x750/0x750 [ 166.336330][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336332][ T7809] ? lock_release+0x184/0x1f0 [ 166.336334][ T7809] ____sys_sendmsg+0x415/0x880 [ 166.336335][ T7809] ? copy_msghdr_from_user+0x279/0x420 [ 166.336337][ T7809] ? get_timestamp.constprop.0+0x390/0x390 [ 166.336338][ T7809] ? move_addr_to_kernel+0x40/0x40 [ 166.336340][ T7809] ? filter_irq_stacks+0xd0/0xd0 [ 166.336342][ T7809] ___sys_sendmsg+0x14e/0x1d0 [ 166.336344][ T7809] ? copy_msghdr_from_user+0x420/0x420 [ 166.336348][ T7809] __sys_sendmsg+0x12c/0x1d0 [ 166.336350][ T7809] ? __sys_sendmsg_sock+0x20/0x20 [ 166.336353][ T7809] ? rcu_is_watching+0x16/0xd0 [ 166.336355][ T7809] do_syscall_64+0xff/0x530 [ 166.336356][ T7809] ? exc_page_fault+0xee/0x100 [ 166.336358][ T7809] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 166.336360][ T7809] RIP: 0033:0x7f03934be54e [ 166.336361][ T7809] Code: 4d 89 d8 e8 b4 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 [ 166.336363][ T7809] RSP: 002b:00007ffca4109790 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 166.336367][ T7809] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00007f03934be54e [ 166.336368][ T7809] RDX: 0000000000000000 RSI: 00007ffca4109840 RDI: 0000000000000005 [ 166.336369][ T7809] RBP: 00007ffca41097a0 R08: 0000000000000000 R09: 0000000000000000 [ 166.336370][ T7809] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91b073 [ 166.336370][ T7809] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffca4109f00 [ 166.336373][ T7809] [ 166.368016][ T7809] br0: port 1(veth1) entered disabled state [ 166.470031][ T7815] br0: port 2(veth2) entered blocking state [ 166.470282][ T7815] br0: port 2(veth2) entered forwarding state [ 166.470581][ T7815] br0: port 1(veth1) entered blocking state [ 166.470766][ T7815] br0: port 1(veth1) entered forwarding state [ 166.709036][ T7831] br0: port 2(veth2) entered disabled state [ 166.709500][ T7831] br0: port 1(veth1) entered disabled state [ 166.767500][ T7834] br0: port 2(veth2) entered blocking state [ 166.767719][ T7834] br0: port 2(veth2) entered forwarding state [ 166.767992][ T7834] br0: port 1(veth1) entered blocking state [ 166.768165][ T7834] br0: port 1(veth1) entered forwarding state [ 166.877705][ T7841] br0: port 2(veth2) entered disabled state [ 166.891949][ T7842] veth2: left allmulticast mode [ 166.892111][ T7842] veth2: left promiscuous mode [ 166.892322][ T7842] br0: port 2(veth2) entered disabled state [ 166.916499][ T7843] br0: port 1(veth1) entered disabled state [ 166.931762][ T7844] veth1: left allmulticast mode [ 166.931922][ T7844] veth1: left promiscuous mode [ 166.932117][ T7844] br0: port 1(veth1) entered disabled state