[ 9.909335][ T202] ip (202) used greatest stack depth: 23520 bytes left [ 9.909356][ T202] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.909358][ T202] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 202, name: ip [ 9.909359][ T202] preempt_count: 2, expected: 0 [ 9.909360][ T202] RCU nest depth: 0, expected: 0 [ 9.909361][ T202] locks held by ip/202: 5, last CPU#3: [ 9.909363][ T202] #0: ffffffffa9c167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 9.909374][ T202] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.909379][ T202] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.909384][ T202] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.909387][ T202] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 9.909391][ T202] irq event stamp: 43720 [ 9.909392][ T202] hardirqs last enabled at (43719): [] __down_trylock_console_sem+0x86/0xa0 [ 9.909396][ T202] hardirqs last disabled at (43720): [] console_emit_next_record+0x3d4/0x4c0 [ 9.909398][ T202] softirqs last enabled at (43346): [] handle_softirqs+0x67c/0x900 [ 9.909400][ T202] softirqs last disabled at (43341): [] __irq_exit_rcu+0x145/0x1c0 [ 9.909402][ T202] Preemption disabled at: [ 9.909403][ T202] [<0000000000000000>] 0x0 [ 9.909410][ T202] CPU: 3 UID: 0 PID: 202 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.909413][ T202] Tainted: [W]=WARN [ 9.909414][ T202] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.909416][ T202] Call Trace: [ 9.909417][ T202] [ 9.909419][ T202] dump_stack_lvl+0x6f/0xa0 [ 9.909425][ T202] __might_resched.cold+0x1fe/0x2c1 [ 9.909430][ T202] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.909434][ T202] ? __kmalloc_noprof+0xdb/0x760 [ 9.909438][ T202] __kmalloc_noprof+0x443/0x760 [ 9.909440][ T202] ? alloc_buf.isra.0+0x4b/0x260 [ 9.909447][ T202] ? do_raw_spin_unlock+0x59/0x250 [ 9.909450][ T202] alloc_buf.isra.0+0x4b/0x260 [ 9.909454][ T202] put_chars+0x1e1/0x2f0 [ 9.909456][ T202] ? __send_to_port+0x420/0x420 [ 9.909457][ T202] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 9.909461][ T202] ? validate_chain+0x38b/0xc20 [ 9.909466][ T202] hvc_console_print+0x292/0x780 [ 9.909474][ T202] ? hvc_write+0x3a0/0x3a0 [ 9.909476][ T202] ? rcu_is_watching+0x16/0xd0 [ 9.909478][ T202] ? lock_acquire+0x13c/0x160 [ 9.909483][ T202] console_emit_next_record+0x22f/0x4c0 [ 9.909487][ T202] ? devkmsg_read+0x4b0/0x4b0 [ 9.909488][ T202] ? console_flush_one_record+0x106/0x710 [ 9.909492][ T202] ? rcu_is_watching+0x16/0xd0 [ 9.909493][ T202] ? lock_acquire+0x13c/0x160 [ 9.909497][ T202] console_flush_one_record+0x46f/0x710 [ 9.909501][ T202] ? console_emit_next_record+0x4c0/0x4c0 [ 9.909503][ T202] ? __lock_acquire+0x518/0xc20 [ 9.909508][ T202] console_unlock+0xee/0x1f0 [ 9.909511][ T202] ? console_flush_one_record+0x710/0x710 [ 9.909513][ T202] ? rcu_is_watching+0x16/0xd0 [ 9.909515][ T202] ? lock_acquire+0xe0/0x160 [ 9.909519][ T202] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.909520][ T202] ? vprintk_emit+0x320/0x3e0 [ 9.909523][ T202] vprintk_emit+0x37c/0x3e0 [ 9.909526][ T202] ? wake_up_klogd_work_func+0x90/0x90 [ 9.909529][ T202] ? __lock_acquire+0x518/0xc20 [ 9.909533][ T202] _printk+0xc7/0x100 [ 9.909536][ T202] ? snapshot_read.cold+0x21/0x21 [ 9.909539][ T202] ? do_raw_spin_lock+0x131/0x280 [ 9.909542][ T202] ? __rwlock_init+0x150/0x150 [ 9.909546][ T202] ? do_raw_spin_lock+0x131/0x280 [ 9.909548][ T202] do_exit.cold+0x82/0x9c [ 9.909552][ T202] ? exit_notify+0x890/0x890 [ 9.909553][ T202] ? __lock_release.isra.0+0x69/0x1a0 [ 9.909556][ T202] ? rcu_is_watching+0x16/0xd0 [ 9.909560][ T202] do_group_exit+0xb8/0x370 [ 9.909562][ T202] __x64_sys_exit_group+0x3c/0x50 [ 9.909564][ T202] x64_sys_call+0x1567/0x1570 [ 9.909567][ T202] do_syscall_64+0xff/0x530 [ 9.909571][ T202] ? exc_page_fault+0xee/0x100 [ 9.909574][ T202] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.909576][ T202] RIP: 0033:0x7f5b88a961b8 [ 9.909578][ T202] Code: Unable to access opcode bytes at 0x7f5b88a9618e. [ 9.909579][ T202] RSP: 002b:00007ffd02fb8d28 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 9.909581][ T202] RAX: ffffffffffffffda RBX: 00007f5b88bc6f88 RCX: 00007f5b88a961b8 [ 9.909582][ T202] RDX: 00007f5b887e0fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 9.909583][ T202] RBP: 00007ffd02fb8d80 R08: 0000000000000000 R09: 0000000000000050 [ 9.909584][ T202] R10: 00007ffd02fb8b40 R11: 0000000000000246 R12: 0000000000000001 [ 9.909585][ T202] R13: 0000000000000000 R14: 00007f5b88bc5680 R15: 00007f5b88bc6fa0 [ 9.909592][ T202] [ 28.400695][ T615] br0: port 1(veth1) entered blocking state [ 28.401022][ T615] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.401024][ T615] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 615, name: ip [ 28.401026][ T615] preempt_count: 1, expected: 0 [ 28.401026][ T615] RCU nest depth: 0, expected: 0 [ 28.401027][ T615] locks held by ip/615: 5, last CPU#0: [ 28.401029][ T615] #0: ffffffffaa51b740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 28.401041][ T615] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 28.401047][ T615] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 28.401051][ T615] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 28.401054][ T615] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 28.401058][ T615] irq event stamp: 20194 [ 28.401059][ T615] hardirqs last enabled at (20193): [] irqentry_exit+0x21c/0x790 [ 28.401063][ T615] hardirqs last disabled at (20194): [] console_emit_next_record+0x3d4/0x4c0 [ 28.401065][ T615] softirqs last enabled at (20100): [] __alloc_skb+0x4c2/0x5f0 [ 28.401068][ T615] softirqs last disabled at (20098): [] __alloc_skb+0x4c2/0x5f0 [ 28.401071][ T615] Preemption disabled at: [ 28.401072][ T615] [] vprintk_emit+0x31b/0x3e0 [ 28.401076][ T615] CPU: 0 UID: 0 PID: 615 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.401080][ T615] Tainted: [W]=WARN [ 28.401081][ T615] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.401083][ T615] Call Trace: [ 28.401085][ T615] [ 28.401086][ T615] dump_stack_lvl+0x6f/0xa0 [ 28.401092][ T615] ? vprintk_emit+0x31b/0x3e0 [ 28.401094][ T615] __might_resched.cold+0x1fe/0x2c1 [ 28.401098][ T615] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.401103][ T615] ? __kmalloc_noprof+0xdb/0x760 [ 28.401107][ T615] __kmalloc_noprof+0x443/0x760 [ 28.401109][ T615] ? alloc_buf.isra.0+0x4b/0x260 [ 28.401116][ T615] ? do_raw_spin_unlock+0x59/0x250 [ 28.401119][ T615] alloc_buf.isra.0+0x4b/0x260 [ 28.401123][ T615] put_chars+0x1e1/0x2f0 [ 28.401126][ T615] ? __send_to_port+0x420/0x420 [ 28.401129][ T615] ? validate_chain+0x34a/0xc20 [ 28.401134][ T615] hvc_console_print+0x292/0x780 [ 28.401142][ T615] ? hvc_write+0x3a0/0x3a0 [ 28.401144][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401147][ T615] ? lock_acquire+0x13c/0x160 [ 28.401151][ T615] console_emit_next_record+0x22f/0x4c0 [ 28.401155][ T615] ? devkmsg_read+0x4b0/0x4b0 [ 28.401159][ T615] ? console_flush_one_record+0x106/0x710 [ 28.401163][ T615] console_flush_one_record+0x46f/0x710 [ 28.401167][ T615] ? console_emit_next_record+0x4c0/0x4c0 [ 28.401169][ T615] ? __lock_acquire+0x518/0xc20 [ 28.401174][ T615] console_unlock+0xee/0x1f0 [ 28.401177][ T615] ? console_flush_one_record+0x710/0x710 [ 28.401179][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401181][ T615] ? lock_acquire+0xe0/0x160 [ 28.401184][ T615] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.401186][ T615] ? vprintk_emit+0x320/0x3e0 [ 28.401189][ T615] vprintk_emit+0x37c/0x3e0 [ 28.401192][ T615] ? wake_up_klogd_work_func+0x90/0x90 [ 28.401194][ T615] ? __lock_release.isra.0+0x69/0x1a0 [ 28.401195][ T615] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 28.401199][ T615] ? mark_held_locks+0x40/0x70 [ 28.401202][ T615] _printk+0xc7/0x100 [ 28.401206][ T615] ? snapshot_read.cold+0x21/0x21 [ 28.401209][ T615] ? br_multicast_flood+0x960/0x960 [ 28.401212][ T615] ? do_setlink.isra.0+0x9ec/0x2a60 [ 28.401214][ T615] ? rtnl_newlink+0x9f1/0x11b0 [ 28.401215][ T615] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.401219][ T615] br_set_state+0x22f/0x430 [ 28.401223][ T615] br_init_port+0xc4/0x200 [ 28.401225][ T615] new_nbp+0x3a0/0x650 [ 28.401229][ T615] br_add_if+0x212/0x1320 [ 28.401231][ T615] ? is_bpf_text_address+0x72/0x110 [ 28.401235][ T615] ? kernel_text_address+0x149/0x170 [ 28.401240][ T615] do_set_master+0x3b2/0x780 [ 28.401243][ T615] do_setlink.isra.0+0x9ec/0x2a60 [ 28.401247][ T615] ? stack_trace_save+0x93/0xc0 [ 28.401255][ T615] ? rtnl_link_get_size+0x350/0x350 [ 28.401256][ T615] ? rcu_read_lock_any_held+0x66/0x90 [ 28.401259][ T615] ? stack_depot_save_flags+0x38e/0x790 [ 28.401262][ T615] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.401265][ T615] ? rcu_read_lock_any_held+0x3c/0x90 [ 28.401267][ T615] ? validate_chain+0x38b/0xc20 [ 28.401269][ T615] ? kasan_save_stack+0x3d/0x50 [ 28.401271][ T615] ? kasan_save_stack+0x2f/0x50 [ 28.401273][ T615] ? kasan_save_track+0x14/0x30 [ 28.401274][ T615] ? __kasan_kmalloc+0x7b/0x90 [ 28.401276][ T615] ? __lock_acquire+0x518/0xc20 [ 28.401278][ T615] ? snd_ac97_proc_read_main+0x4de/0x1f00 [ 28.401281][ T615] ? ___sys_sendmsg+0xd0/0x1d0 [ 28.401285][ T615] ? lock_acquire.part.0+0xd4/0x280 [ 28.401287][ T615] ? rtnl_newlink+0x9a8/0x11b0 [ 28.401289][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401291][ T615] ? lock_acquire+0x13c/0x160 [ 28.401293][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401294][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401296][ T615] ? trace_contention_end+0xb3/0x180 [ 28.401298][ T615] ? __mutex_lock+0x1db/0x1ea0 [ 28.401299][ T615] ? __mutex_lock+0x9a3/0x1ea0 [ 28.401301][ T615] ? rtnl_newlink+0x9a8/0x11b0 [ 28.401304][ T615] ? ww_mutex_lock+0x160/0x160 [ 28.401305][ T615] ? nla_get_range_signed+0x3d0/0x3d0 [ 28.401310][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401312][ T615] ? __rtnl_newlink+0x3fa/0xa50 [ 28.401317][ T615] rtnl_newlink+0x9f1/0x11b0 [ 28.401323][ T615] ? rtnl_bridge_getlink+0x850/0x850 [ 28.401324][ T615] ? __lock_acquire+0x518/0xc20 [ 28.401329][ T615] ? lock_acquire.part.0+0xd4/0x280 [ 28.401331][ T615] ? find_held_lock+0x2b/0x80 [ 28.401333][ T615] ? rtnl_bridge_getlink+0x850/0x850 [ 28.401334][ T615] ? __lock_release.isra.0+0x69/0x1a0 [ 28.401338][ T615] ? rtnl_bridge_getlink+0x850/0x850 [ 28.401340][ T615] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.401343][ T615] ? rtnl_link_fill+0x920/0x920 [ 28.401345][ T615] ? __lock_acquire+0x518/0xc20 [ 28.401349][ T615] ? lock_acquire.part.0+0xd4/0x280 [ 28.401351][ T615] ? find_held_lock+0x2b/0x80 [ 28.401354][ T615] netlink_rcv_skb+0x14e/0x3a0 [ 28.401357][ T615] ? rtnl_link_fill+0x920/0x920 [ 28.401360][ T615] ? netlink_ack+0xcf0/0xcf0 [ 28.401367][ T615] ? netlink_deliver_tap+0xc5/0x330 [ 28.401369][ T615] ? netlink_deliver_tap+0x13c/0x330 [ 28.401373][ T615] netlink_unicast+0x486/0x750 [ 28.401377][ T615] ? netlink_attachskb+0x810/0x810 [ 28.401380][ T615] ? find_held_lock+0x2b/0x80 [ 28.401384][ T615] netlink_sendmsg+0x75b/0xc90 [ 28.401388][ T615] ? netlink_unicast+0x750/0x750 [ 28.401392][ T615] ? __lock_release.isra.0+0x69/0x1a0 [ 28.401394][ T615] ? __import_iovec+0x36c/0x620 [ 28.401399][ T615] __sock_sendmsg+0xce/0x190 [ 28.401402][ T615] ____sys_sendmsg+0x61a/0x860 [ 28.401404][ T615] ? copy_msghdr_from_user+0x279/0x420 [ 28.401406][ T615] ? sock_write_iter+0x400/0x400 [ 28.401408][ T615] ? move_addr_to_kernel+0x40/0x40 [ 28.401415][ T615] ___sys_sendmsg+0x14e/0x1d0 [ 28.401418][ T615] ? copy_msghdr_from_user+0x420/0x420 [ 28.401434][ T615] __sys_sendmsg+0x12c/0x1d0 [ 28.401436][ T615] ? __sys_sendmsg_sock+0x20/0x20 [ 28.401443][ T615] ? rcu_is_watching+0x16/0xd0 [ 28.401446][ T615] do_syscall_64+0xff/0x530 [ 28.401449][ T615] ? exc_page_fault+0xee/0x100 [ 28.401451][ T615] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.401454][ T615] RIP: 0033:0x7fbbd866c54e [ 28.401457][ T615] 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 [ 28.401459][ T615] RSP: 002b:00007ffdc3db3540 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 28.401462][ T615] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fbbd866c54e [ 28.401463][ T615] RDX: 0000000000000000 RSI: 00007ffdc3db35f0 RDI: 0000000000000005 [ 28.401464][ T615] RBP: 00007ffdc3db3550 R08: 0000000000000000 R09: 0000000000000000 [ 28.401465][ T615] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9130de [ 28.401466][ T615] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffdc3db3cc0 [ 28.401472][ T615] [ 28.435217][ T615] br0: port 1(veth1) entered disabled state [ 28.435526][ T615] veth1: entered allmulticast mode [ 28.436569][ T615] veth1: entered promiscuous mode [ 28.452159][ T615] ip (615) used greatest stack depth: 23336 bytes left [ 28.663816][ T620] br0: port 2(veth_segment) entered blocking state [ 28.664150][ T620] br0: port 2(veth_segment) entered disabled state [ 28.664440][ T620] veth_segment: entered allmulticast mode [ 28.665459][ T620] veth_segment: entered promiscuous mode [ 28.692901][ T621] br0: port 2(veth_segment) entered blocking state [ 28.693580][ T621] br0: port 2(veth_segment) entered forwarding state [ 28.694152][ T621] br0: port 1(veth1) entered blocking state [ 28.694457][ T621] br0: port 1(veth1) entered forwarding state [ 31.008553][ T634] iperf3 (634) used greatest stack depth: 22576 bytes left [ 31.008573][ T634] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.008575][ T634] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 634, name: iperf3 [ 31.008577][ T634] preempt_count: 2, expected: 0 [ 31.008578][ T634] RCU nest depth: 0, expected: 0 [ 31.008579][ T634] locks held by iperf3/634: 5, last CPU#3: [ 31.008581][ T634] #0: ffffffffa9c167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 31.008593][ T634] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 31.008598][ T634] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 31.008603][ T634] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 31.008607][ T634] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 31.008611][ T634] irq event stamp: 1302680 [ 31.008612][ T634] hardirqs last enabled at (1302679): [] __down_trylock_console_sem+0x86/0xa0 [ 31.008615][ T634] hardirqs last disabled at (1302680): [] console_emit_next_record+0x3d4/0x4c0 [ 31.008617][ T634] softirqs last enabled at (1301660): [] handle_softirqs+0x67c/0x900 [ 31.008620][ T634] softirqs last disabled at (1301653): [] __irq_exit_rcu+0x145/0x1c0 [ 31.008622][ T634] Preemption disabled at: [ 31.008623][ T634] [<0000000000000000>] 0x0 [ 31.008629][ T634] CPU: 3 UID: 0 PID: 634 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.008633][ T634] Tainted: [W]=WARN [ 31.008634][ T634] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.008636][ T634] Call Trace: [ 31.008637][ T634] [ 31.008639][ T634] dump_stack_lvl+0x6f/0xa0 [ 31.008645][ T634] __might_resched.cold+0x1fe/0x2c1 [ 31.008650][ T634] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.008654][ T634] ? __kmalloc_noprof+0xdb/0x760 [ 31.008659][ T634] __kmalloc_noprof+0x443/0x760 [ 31.008661][ T634] ? alloc_buf.isra.0+0x4b/0x260 [ 31.008668][ T634] ? do_raw_spin_unlock+0x59/0x250 [ 31.008671][ T634] alloc_buf.isra.0+0x4b/0x260 [ 31.008675][ T634] put_chars+0x1e1/0x2f0 [ 31.008676][ T634] ? prb_final_commit+0x50/0x50 [ 31.008679][ T634] ? __send_to_port+0x420/0x420 [ 31.008682][ T634] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 31.008685][ T634] ? rcu_read_lock_any_held+0x3c/0x90 [ 31.008688][ T634] ? validate_chain+0x38b/0xc20 [ 31.008692][ T634] hvc_console_print+0x292/0x780 [ 31.008696][ T634] ? mark_usage+0x61/0x170 [ 31.008698][ T634] ? __lock_acquire+0x518/0xc20 [ 31.008700][ T634] ? __lock_acquire+0x518/0xc20 [ 31.008704][ T634] ? hvc_write+0x3a0/0x3a0 [ 31.008707][ T634] ? console_emit_next_record+0x1df/0x4c0 [ 31.008710][ T634] ? rcu_is_watching+0x16/0xd0 [ 31.008712][ T634] ? lock_acquire+0x13c/0x160 [ 31.008717][ T634] console_emit_next_record+0x22f/0x4c0 [ 31.008721][ T634] ? devkmsg_read+0x4b0/0x4b0 [ 31.008723][ T634] ? console_flush_one_record+0x106/0x710 [ 31.008726][ T634] ? rcu_is_watching+0x16/0xd0 [ 31.008728][ T634] ? lock_acquire+0x13c/0x160 [ 31.008732][ T634] console_flush_one_record+0x46f/0x710 [ 31.008737][ T634] ? console_emit_next_record+0x4c0/0x4c0 [ 31.008739][ T634] ? __lock_acquire+0x518/0xc20 [ 31.008744][ T634] console_unlock+0xee/0x1f0 [ 31.008747][ T634] ? console_flush_one_record+0x710/0x710 [ 31.008749][ T634] ? rcu_is_watching+0x16/0xd0 [ 31.008751][ T634] ? lock_acquire+0xe0/0x160 [ 31.008755][ T634] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.008757][ T634] ? vprintk_emit+0x320/0x3e0 [ 31.008759][ T634] vprintk_emit+0x37c/0x3e0 [ 31.008763][ T634] ? wake_up_klogd_work_func+0x90/0x90 [ 31.008764][ T634] ? do_raw_spin_unlock+0x59/0x250 [ 31.008767][ T634] ? __lock_acquire+0x518/0xc20 [ 31.008771][ T634] _printk+0xc7/0x100 [ 31.008775][ T634] ? snapshot_read.cold+0x21/0x21 [ 31.008778][ T634] ? do_raw_spin_lock+0x131/0x280 [ 31.008781][ T634] ? __rwlock_init+0x150/0x150 [ 31.008785][ T634] ? do_raw_spin_lock+0x131/0x280 [ 31.008788][ T634] do_exit.cold+0x82/0x9c [ 31.008792][ T634] ? exit_notify+0x890/0x890 [ 31.008797][ T634] __x64_sys_exit+0x42/0x50 [ 31.008799][ T634] x64_sys_call+0x156c/0x1570 [ 31.008802][ T634] do_syscall_64+0xff/0x530 [ 31.008806][ T634] ? exc_page_fault+0xee/0x100 [ 31.008809][ T634] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.008811][ T634] RIP: 0033:0x7f948a3a6c49 [ 31.008813][ T634] Code: Unable to access opcode bytes at 0x7f948a3a6c1f. [ 31.008814][ T634] RSP: 002b:00007f9489b65e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 31.008817][ T634] RAX: ffffffffffffffda RBX: 00007f9489b666c0 RCX: 00007f948a3a6c49 [ 31.008818][ T634] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 31.008819][ T634] RBP: 00007f9489b65f70 R08: 0000000000000001 R09: 00007f9489b666c0 [ 31.008820][ T634] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f9489366000 [ 31.008821][ T634] R13: 00007ffe28a3ff30 R14: 0000000000000002 R15: 00007ffe28a40037 [ 31.008828][ T634] [ 31.153339][ T12] br0: port 1(veth1) entered disabled state [ 31.164552][ T12] veth1 (unregistering): left allmulticast mode [ 31.165072][ T12] veth1 (unregistering): left promiscuous mode [ 31.165359][ T12] br0: port 1(veth1) entered disabled state [ 31.212246][ T12] veth_segment: left allmulticast mode [ 31.212501][ T12] veth_segment: left promiscuous mode [ 31.212816][ T12] br0: port 2(veth_segment) entered disabled state [ 44.843990][ T912] udpgso_bench_tx (912) used greatest stack depth: 22520 bytes left [ 44.844011][ T912] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 44.844013][ T912] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 912, name: udpgso_bench_tx [ 44.844014][ T912] preempt_count: 2, expected: 0 [ 44.844015][ T912] RCU nest depth: 0, expected: 0 [ 44.844016][ T912] locks held by udpgso_bench_tx/912: 5, last CPU#3: [ 44.844018][ T912] #0: ffffffffa9c167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 44.844030][ T912] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 44.844035][ T912] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 44.844040][ T912] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 44.844044][ T912] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 44.844048][ T912] irq event stamp: 49692 [ 44.844049][ T912] hardirqs last enabled at (49691): [] __down_trylock_console_sem+0x86/0xa0 [ 44.844052][ T912] hardirqs last disabled at (49692): [] console_emit_next_record+0x3d4/0x4c0 [ 44.844054][ T912] softirqs last enabled at (48524): [] handle_softirqs+0x67c/0x900 [ 44.844056][ T912] softirqs last disabled at (48517): [] __irq_exit_rcu+0x145/0x1c0 [ 44.844058][ T912] Preemption disabled at: [ 44.844059][ T912] [<0000000000000000>] 0x0 [ 44.844066][ T912] CPU: 3 UID: 0 PID: 912 Comm: udpgso_bench_tx Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 44.844070][ T912] Tainted: [W]=WARN [ 44.844071][ T912] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 44.844072][ T912] Call Trace: [ 44.844074][ T912] [ 44.844075][ T912] dump_stack_lvl+0x6f/0xa0 [ 44.844082][ T912] __might_resched.cold+0x1fe/0x2c1 [ 44.844086][ T912] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 44.844090][ T912] ? __kmalloc_noprof+0xdb/0x760 [ 44.844095][ T912] __kmalloc_noprof+0x443/0x760 [ 44.844097][ T912] ? alloc_buf.isra.0+0x4b/0x260 [ 44.844104][ T912] ? do_raw_spin_unlock+0x59/0x250 [ 44.844107][ T912] alloc_buf.isra.0+0x4b/0x260 [ 44.844111][ T912] put_chars+0x1e1/0x2f0 [ 44.844113][ T912] ? __send_to_port+0x420/0x420 [ 44.844114][ T912] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 44.844118][ T912] ? validate_chain+0x38b/0xc20 [ 44.844124][ T912] hvc_console_print+0x292/0x780 [ 44.844131][ T912] ? hvc_write+0x3a0/0x3a0 [ 44.844134][ T912] ? rcu_is_watching+0x16/0xd0 [ 44.844136][ T912] ? lock_acquire+0x13c/0x160 [ 44.844140][ T912] console_emit_next_record+0x22f/0x4c0 [ 44.844144][ T912] ? devkmsg_read+0x4b0/0x4b0 [ 44.844146][ T912] ? console_flush_one_record+0x106/0x710 [ 44.844149][ T912] ? rcu_is_watching+0x16/0xd0 [ 44.844151][ T912] ? lock_acquire+0x13c/0x160 [ 44.844155][ T912] console_flush_one_record+0x46f/0x710 [ 44.844159][ T912] ? console_emit_next_record+0x4c0/0x4c0 [ 44.844161][ T912] ? __lock_acquire+0x518/0xc20 [ 44.844166][ T912] console_unlock+0xee/0x1f0 [ 44.844169][ T912] ? console_flush_one_record+0x710/0x710 [ 44.844171][ T912] ? rcu_is_watching+0x16/0xd0 [ 44.844173][ T912] ? lock_acquire+0xe0/0x160 [ 44.844176][ T912] ? __down_trylock_console_sem+0x5e/0xa0 [ 44.844178][ T912] ? vprintk_emit+0x320/0x3e0 [ 44.844181][ T912] vprintk_emit+0x37c/0x3e0 [ 44.844184][ T912] ? wake_up_klogd_work_func+0x90/0x90 [ 44.844185][ T912] ? do_raw_spin_unlock+0x59/0x250 [ 44.844188][ T912] ? __lock_acquire+0x518/0xc20 [ 44.844192][ T912] _printk+0xc7/0x100 [ 44.844196][ T912] ? snapshot_read.cold+0x21/0x21 [ 44.844198][ T912] ? do_raw_spin_lock+0x131/0x280 [ 44.844201][ T912] ? __rwlock_init+0x150/0x150 [ 44.844205][ T912] ? do_raw_spin_lock+0x131/0x280 [ 44.844208][ T912] do_exit.cold+0x82/0x9c [ 44.844211][ T912] ? exit_notify+0x890/0x890 [ 44.844213][ T912] ? __lock_release.isra.0+0x69/0x1a0 [ 44.844215][ T912] ? rcu_is_watching+0x16/0xd0 [ 44.844219][ T912] do_group_exit+0xb8/0x370 [ 44.844222][ T912] __x64_sys_exit_group+0x3c/0x50 [ 44.844224][ T912] x64_sys_call+0x1567/0x1570 [ 44.844226][ T912] do_syscall_64+0xff/0x530 [ 44.844230][ T912] ? exc_page_fault+0xee/0x100 [ 44.844233][ T912] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 44.844235][ T912] RIP: 0033:0x7fdce4fe51b8 [ 44.844237][ T912] Code: Unable to access opcode bytes at 0x7fdce4fe518e. [ 44.844238][ T912] RSP: 002b:00007ffe86e52698 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 44.844241][ T912] RAX: ffffffffffffffda RBX: 00007fdce5115f88 RCX: 00007fdce4fe51b8 [ 44.844242][ T912] RDX: 00007fdce4f22a48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 44.844243][ T912] RBP: 00007ffe86e526f0 R08: 0000000000000000 R09: 0000000000000000 [ 44.844243][ T912] R10: 00007ffe86e52530 R11: 0000000000000246 R12: 0000000000000001 [ 44.844244][ T912] R13: 0000000000000000 R14: 00007fdce5114680 R15: 00007fdce5115fa0 [ 44.844251][ T912] [ 49.323923][ T1050] br0: port 1(veth1) entered blocking state [ 49.323944][ T1050] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 49.323946][ T1050] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1050, name: ip [ 49.323947][ T1050] preempt_count: 1, expected: 0 [ 49.323948][ T1050] RCU nest depth: 0, expected: 0 [ 49.323949][ T1050] locks held by ip/1050: 5, last CPU#0: [ 49.323951][ T1050] #0: ffffffffaa51b740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 49.323964][ T1050] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 49.323969][ T1050] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 49.323974][ T1050] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 49.323978][ T1050] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 49.323982][ T1050] irq event stamp: 22262 [ 49.323982][ T1050] hardirqs last enabled at (22261): [] __down_trylock_console_sem+0x86/0xa0 [ 49.323986][ T1050] hardirqs last disabled at (22262): [] console_emit_next_record+0x3d4/0x4c0 [ 49.323988][ T1050] softirqs last enabled at (22204): [] __alloc_skb+0x4c2/0x5f0 [ 49.323991][ T1050] softirqs last disabled at (22202): [] __alloc_skb+0x4c2/0x5f0 [ 49.323994][ T1050] Preemption disabled at: [ 49.323994][ T1050] [] vprintk_emit+0x31b/0x3e0 [ 49.323999][ T1050] CPU: 0 UID: 0 PID: 1050 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 49.324003][ T1050] Tainted: [W]=WARN [ 49.324004][ T1050] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 49.324006][ T1050] Call Trace: [ 49.324007][ T1050] [ 49.324009][ T1050] dump_stack_lvl+0x6f/0xa0 [ 49.324015][ T1050] ? vprintk_emit+0x31b/0x3e0 [ 49.324016][ T1050] __might_resched.cold+0x1fe/0x2c1 [ 49.324020][ T1050] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 49.324025][ T1050] ? __kmalloc_noprof+0xdb/0x760 [ 49.324029][ T1050] __kmalloc_noprof+0x443/0x760 [ 49.324031][ T1050] ? alloc_buf.isra.0+0x4b/0x260 [ 49.324037][ T1050] ? do_raw_spin_unlock+0x59/0x250 [ 49.324040][ T1050] alloc_buf.isra.0+0x4b/0x260 [ 49.324044][ T1050] put_chars+0x1e1/0x2f0 [ 49.324046][ T1050] ? __send_to_port+0x420/0x420 [ 49.324047][ T1050] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 49.324051][ T1050] ? validate_chain+0x38b/0xc20 [ 49.324056][ T1050] hvc_console_print+0x292/0x780 [ 49.324064][ T1050] ? hvc_write+0x3a0/0x3a0 [ 49.324066][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324068][ T1050] ? lock_acquire+0x13c/0x160 [ 49.324072][ T1050] console_emit_next_record+0x22f/0x4c0 [ 49.324076][ T1050] ? devkmsg_read+0x4b0/0x4b0 [ 49.324078][ T1050] ? console_flush_one_record+0x106/0x710 [ 49.324081][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324083][ T1050] ? lock_acquire+0x13c/0x160 [ 49.324087][ T1050] console_flush_one_record+0x46f/0x710 [ 49.324091][ T1050] ? console_emit_next_record+0x4c0/0x4c0 [ 49.324093][ T1050] ? __lock_acquire+0x518/0xc20 [ 49.324098][ T1050] console_unlock+0xee/0x1f0 [ 49.324101][ T1050] ? console_flush_one_record+0x710/0x710 [ 49.324103][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324105][ T1050] ? lock_acquire+0xe0/0x160 [ 49.324108][ T1050] ? __down_trylock_console_sem+0x5e/0xa0 [ 49.324110][ T1050] ? vprintk_emit+0x320/0x3e0 [ 49.324113][ T1050] vprintk_emit+0x37c/0x3e0 [ 49.324116][ T1050] ? wake_up_klogd_work_func+0x90/0x90 [ 49.324118][ T1050] ? __lock_release.isra.0+0x69/0x1a0 [ 49.324120][ T1050] ? mark_held_locks+0x40/0x70 [ 49.324124][ T1050] _printk+0xc7/0x100 [ 49.324128][ T1050] ? snapshot_read.cold+0x21/0x21 [ 49.324131][ T1050] ? br_multicast_flood+0x960/0x960 [ 49.324135][ T1050] ? do_setlink.isra.0+0x9ec/0x2a60 [ 49.324136][ T1050] ? rtnl_newlink+0x9f1/0x11b0 [ 49.324137][ T1050] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 49.324141][ T1050] br_set_state+0x22f/0x430 [ 49.324146][ T1050] br_init_port+0xc4/0x200 [ 49.324148][ T1050] new_nbp+0x3a0/0x650 [ 49.324152][ T1050] br_add_if+0x212/0x1320 [ 49.324154][ T1050] ? is_bpf_text_address+0x72/0x110 [ 49.324158][ T1050] ? kernel_text_address+0x149/0x170 [ 49.324163][ T1050] do_set_master+0x3b2/0x780 [ 49.324167][ T1050] do_setlink.isra.0+0x9ec/0x2a60 [ 49.324170][ T1050] ? stack_trace_save+0x93/0xc0 [ 49.324173][ T1050] ? rtnl_link_get_size+0x350/0x350 [ 49.324175][ T1050] ? rcu_read_lock_any_held+0x66/0x90 [ 49.324177][ T1050] ? stack_depot_save_flags+0x38e/0x790 [ 49.324181][ T1050] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 49.324183][ T1050] ? rcu_read_lock_any_held+0x3c/0x90 [ 49.324184][ T1050] ? validate_chain+0x38b/0xc20 [ 49.324187][ T1050] ? kasan_save_stack+0x3d/0x50 [ 49.324189][ T1050] ? kasan_save_stack+0x2f/0x50 [ 49.324190][ T1050] ? kasan_save_track+0x14/0x30 [ 49.324191][ T1050] ? __kasan_kmalloc+0x7b/0x90 [ 49.324194][ T1050] ? __lock_acquire+0x518/0xc20 [ 49.324196][ T1050] ? snd_ac97_proc_read_main+0x4de/0x1f00 [ 49.324198][ T1050] ? ___sys_sendmsg+0xd0/0x1d0 [ 49.324202][ T1050] ? lock_acquire.part.0+0xd4/0x280 [ 49.324204][ T1050] ? rtnl_newlink+0x9a8/0x11b0 [ 49.324207][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324209][ T1050] ? lock_acquire+0x13c/0x160 [ 49.324210][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324211][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324213][ T1050] ? trace_contention_end+0xb3/0x180 [ 49.324215][ T1050] ? __mutex_lock+0x1db/0x1ea0 [ 49.324218][ T1050] ? __mutex_lock+0x9a3/0x1ea0 [ 49.324220][ T1050] ? rtnl_newlink+0x9a8/0x11b0 [ 49.324223][ T1050] ? ww_mutex_lock+0x160/0x160 [ 49.324224][ T1050] ? nla_get_range_signed+0x3d0/0x3d0 [ 49.324229][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324231][ T1050] ? __rtnl_newlink+0x3fa/0xa50 [ 49.324236][ T1050] rtnl_newlink+0x9f1/0x11b0 [ 49.324242][ T1050] ? rtnl_bridge_getlink+0x850/0x850 [ 49.324243][ T1050] ? __lock_acquire+0x518/0xc20 [ 49.324248][ T1050] ? lock_acquire.part.0+0xd4/0x280 [ 49.324250][ T1050] ? find_held_lock+0x2b/0x80 [ 49.324252][ T1050] ? rtnl_bridge_getlink+0x850/0x850 [ 49.324254][ T1050] ? __lock_release.isra.0+0x69/0x1a0 [ 49.324257][ T1050] ? rtnl_bridge_getlink+0x850/0x850 [ 49.324259][ T1050] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 49.324262][ T1050] ? rtnl_link_fill+0x920/0x920 [ 49.324264][ T1050] ? __lock_acquire+0x518/0xc20 [ 49.324268][ T1050] ? lock_acquire.part.0+0xd4/0x280 [ 49.324270][ T1050] ? find_held_lock+0x2b/0x80 [ 49.324273][ T1050] netlink_rcv_skb+0x14e/0x3a0 [ 49.324276][ T1050] ? rtnl_link_fill+0x920/0x920 [ 49.324279][ T1050] ? netlink_ack+0xcf0/0xcf0 [ 49.324286][ T1050] ? netlink_deliver_tap+0xc5/0x330 [ 49.324288][ T1050] ? netlink_deliver_tap+0x13c/0x330 [ 49.324292][ T1050] netlink_unicast+0x486/0x750 [ 49.324296][ T1050] ? netlink_attachskb+0x810/0x810 [ 49.324299][ T1050] ? find_held_lock+0x2b/0x80 [ 49.324303][ T1050] netlink_sendmsg+0x75b/0xc90 [ 49.324307][ T1050] ? netlink_unicast+0x750/0x750 [ 49.324310][ T1050] ? __lock_release.isra.0+0x69/0x1a0 [ 49.324312][ T1050] ? __import_iovec+0x36c/0x620 [ 49.324317][ T1050] __sock_sendmsg+0xce/0x190 [ 49.324320][ T1050] ____sys_sendmsg+0x61a/0x860 [ 49.324326][ T1050] ? copy_msghdr_from_user+0x279/0x420 [ 49.324328][ T1050] ? sock_write_iter+0x400/0x400 [ 49.324329][ T1050] ? move_addr_to_kernel+0x40/0x40 [ 49.324337][ T1050] ___sys_sendmsg+0x14e/0x1d0 [ 49.324339][ T1050] ? copy_msghdr_from_user+0x420/0x420 [ 49.324355][ T1050] __sys_sendmsg+0x12c/0x1d0 [ 49.324357][ T1050] ? __sys_sendmsg_sock+0x20/0x20 [ 49.324364][ T1050] ? rcu_is_watching+0x16/0xd0 [ 49.324367][ T1050] do_syscall_64+0xff/0x530 [ 49.324370][ T1050] ? exc_page_fault+0xee/0x100 [ 49.324373][ T1050] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 49.324375][ T1050] RIP: 0033:0x7fda73a8854e [ 49.324379][ T1050] 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 [ 49.324381][ T1050] RSP: 002b:00007ffebd219230 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 49.324384][ T1050] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fda73a8854e [ 49.324385][ T1050] RDX: 0000000000000000 RSI: 00007ffebd2192e0 RDI: 0000000000000005 [ 49.324386][ T1050] RBP: 00007ffebd219240 R08: 0000000000000000 R09: 0000000000000000 [ 49.324387][ T1050] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a9130f3 [ 49.324388][ T1050] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffebd2199b0 [ 49.324394][ T1050] [ 49.361368][ T1050] br0: port 1(veth1) entered disabled state [ 49.361716][ T1050] veth1: entered allmulticast mode [ 49.362747][ T1050] veth1: entered promiscuous mode [ 49.558728][ T1055] br0: port 2(veth_segment) entered blocking state [ 49.559036][ T1055] br0: port 2(veth_segment) entered disabled state [ 49.559307][ T1055] veth_segment: entered allmulticast mode [ 49.560388][ T1055] veth_segment: entered promiscuous mode [ 49.596361][ T1056] br0: port 2(veth_segment) entered blocking state [ 49.596708][ T1056] br0: port 2(veth_segment) entered forwarding state [ 49.597189][ T1056] br0: port 1(veth1) entered blocking state [ 49.597513][ T1056] br0: port 1(veth1) entered forwarding state [ 51.888464][ T1069] iperf3 (1069) used greatest stack depth: 20800 bytes left [ 51.888484][ T1069] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 51.888486][ T1069] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1069, name: iperf3 [ 51.888488][ T1069] preempt_count: 2, expected: 0 [ 51.888489][ T1069] RCU nest depth: 0, expected: 0 [ 51.888490][ T1069] locks held by iperf3/1069: 5, last CPU#3: [ 51.888492][ T1069] #0: ffffffffa9c167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 51.888503][ T1069] #1: ffffffffa9d7ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 51.888508][ T1069] #2: ffffffffa9d7de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 51.888513][ T1069] #3: ffffffffa9c9d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 51.888517][ T1069] #4: ffffffffa9c9d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 51.888521][ T1069] irq event stamp: 1222804 [ 51.888521][ T1069] hardirqs last enabled at (1222803): [] __down_trylock_console_sem+0x86/0xa0 [ 51.888524][ T1069] hardirqs last disabled at (1222804): [] console_emit_next_record+0x3d4/0x4c0 [ 51.888527][ T1069] softirqs last enabled at (1222686): [] fpu__clear_user_states+0x104/0x290 [ 51.888530][ T1069] softirqs last disabled at (1222684): [] fpu__clear_user_states+0x6d/0x290 [ 51.888533][ T1069] Preemption disabled at: [ 51.888533][ T1069] [<0000000000000000>] 0x0 [ 51.888540][ T1069] CPU: 3 UID: 0 PID: 1069 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 51.888544][ T1069] Tainted: [W]=WARN [ 51.888545][ T1069] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 51.888546][ T1069] Call Trace: [ 51.888548][ T1069] [ 51.888550][ T1069] dump_stack_lvl+0x6f/0xa0 [ 51.888556][ T1069] __might_resched.cold+0x1fe/0x2c1 [ 51.888560][ T1069] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 51.888565][ T1069] ? __kmalloc_noprof+0xdb/0x760 [ 51.888569][ T1069] __kmalloc_noprof+0x443/0x760 [ 51.888571][ T1069] ? alloc_buf.isra.0+0x4b/0x260 [ 51.888578][ T1069] ? do_raw_spin_unlock+0x59/0x250 [ 51.888581][ T1069] alloc_buf.isra.0+0x4b/0x260 [ 51.888585][ T1069] put_chars+0x1e1/0x2f0 [ 51.888586][ T1069] ? prb_final_commit+0x50/0x50 [ 51.888589][ T1069] ? __send_to_port+0x420/0x420 [ 51.888592][ T1069] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 51.888595][ T1069] ? rcu_read_lock_any_held+0x3c/0x90 [ 51.888597][ T1069] ? validate_chain+0x38b/0xc20 [ 51.888601][ T1069] hvc_console_print+0x292/0x780 [ 51.888606][ T1069] ? mark_usage+0x61/0x170 [ 51.888607][ T1069] ? __lock_acquire+0x518/0xc20 [ 51.888609][ T1069] ? __lock_acquire+0x518/0xc20 [ 51.888613][ T1069] ? hvc_write+0x3a0/0x3a0 [ 51.888616][ T1069] ? console_emit_next_record+0x1df/0x4c0 [ 51.888619][ T1069] ? rcu_is_watching+0x16/0xd0 [ 51.888621][ T1069] ? lock_acquire+0x13c/0x160 [ 51.888625][ T1069] console_emit_next_record+0x22f/0x4c0 [ 51.888629][ T1069] ? devkmsg_read+0x4b0/0x4b0 [ 51.888631][ T1069] ? console_flush_one_record+0x106/0x710 [ 51.888634][ T1069] ? rcu_is_watching+0x16/0xd0 [ 51.888636][ T1069] ? lock_acquire+0x13c/0x160 [ 51.888640][ T1069] console_flush_one_record+0x46f/0x710 [ 51.888644][ T1069] ? console_emit_next_record+0x4c0/0x4c0 [ 51.888646][ T1069] ? __lock_acquire+0x518/0xc20 [ 51.888651][ T1069] console_unlock+0xee/0x1f0 [ 51.888654][ T1069] ? console_flush_one_record+0x710/0x710 [ 51.888656][ T1069] ? rcu_is_watching+0x16/0xd0 [ 51.888658][ T1069] ? lock_acquire+0xe0/0x160 [ 51.888661][ T1069] ? __down_trylock_console_sem+0x5e/0xa0 [ 51.888663][ T1069] ? vprintk_emit+0x320/0x3e0 [ 51.888666][ T1069] vprintk_emit+0x37c/0x3e0 [ 51.888669][ T1069] ? wake_up_klogd_work_func+0x90/0x90 [ 51.888670][ T1069] ? do_raw_spin_unlock+0x59/0x250 [ 51.888673][ T1069] ? __lock_acquire+0x518/0xc20 [ 51.888677][ T1069] _printk+0xc7/0x100 [ 51.888681][ T1069] ? snapshot_read.cold+0x21/0x21 [ 51.888684][ T1069] ? do_raw_spin_lock+0x131/0x280 [ 51.888686][ T1069] ? __rwlock_init+0x150/0x150 [ 51.888690][ T1069] ? do_raw_spin_lock+0x131/0x280 [ 51.888693][ T1069] do_exit.cold+0x82/0x9c [ 51.888697][ T1069] ? exit_notify+0x890/0x890 [ 51.888702][ T1069] __x64_sys_exit+0x42/0x50 [ 51.888704][ T1069] x64_sys_call+0x156c/0x1570 [ 51.888706][ T1069] do_syscall_64+0xff/0x530 [ 51.888710][ T1069] ? exc_page_fault+0xee/0x100 [ 51.888713][ T1069] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 51.888715][ T1069] RIP: 0033:0x7f73712bac49 [ 51.888717][ T1069] Code: Unable to access opcode bytes at 0x7f73712bac1f. [ 51.888719][ T1069] RSP: 002b:00007f7370a79e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 51.888721][ T1069] RAX: ffffffffffffffda RBX: 00007f7370a7a6c0 RCX: 00007f73712bac49 [ 51.888722][ T1069] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 51.888723][ T1069] RBP: 00007f7370a79f70 R08: 0000000000000001 R09: 00007f7370a7a6c0 [ 51.888724][ T1069] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f737027a000 [ 51.888725][ T1069] R13: 00007ffce164cca0 R14: 0000000000000002 R15: 00007ffce164cda7 [ 51.888732][ T1069] [ 52.054456][ T12] br0: port 1(veth1) entered disabled state [ 52.065629][ T12] veth1 (unregistering): left allmulticast mode [ 52.067335][ T12] veth1 (unregistering): left promiscuous mode [ 52.067769][ T12] br0: port 1(veth1) entered disabled state [ 52.119351][ T12] veth_segment: left allmulticast mode [ 52.119685][ T12] veth_segment: left promiscuous mode [ 52.120525][ T12] br0: port 2(veth_segment) entered disabled state