[ 11.513471][ T264] ip (264) used greatest stack depth: 24128 bytes left [ 11.513490][ T264] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.513493][ T264] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 264, name: ip [ 11.513495][ T264] preempt_count: 2, expected: 0 [ 11.513495][ T264] RCU nest depth: 0, expected: 0 [ 11.513496][ T264] locks held by ip/264: 5, last CPU#0: [ 11.513498][ T264] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 11.513509][ T264] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.513515][ T264] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.513519][ T264] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.513523][ T264] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 11.513527][ T264] irq event stamp: 20948 [ 11.513528][ T264] hardirqs last enabled at (20947): [] __down_trylock_console_sem+0x86/0xa0 [ 11.513531][ T264] hardirqs last disabled at (20948): [] console_emit_next_record+0x3d4/0x4c0 [ 11.513533][ T264] softirqs last enabled at (19382): [] netlink_release+0x17b/0xcf0 [ 11.513537][ T264] softirqs last disabled at (19380): [] netlink_release+0xd2/0xcf0 [ 11.513540][ T264] Preemption disabled at: [ 11.513540][ T264] [<0000000000000000>] 0x0 [ 11.513547][ T264] CPU: 0 UID: 0 PID: 264 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.513550][ T264] Tainted: [W]=WARN [ 11.513551][ T264] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.513553][ T264] Call Trace: [ 11.513554][ T264] [ 11.513556][ T264] dump_stack_lvl+0x6f/0xa0 [ 11.513562][ T264] __might_resched.cold+0x1fe/0x2c1 [ 11.513567][ T264] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.513571][ T264] ? __kmalloc_noprof+0xdb/0x760 [ 11.513575][ T264] __kmalloc_noprof+0x443/0x760 [ 11.513577][ T264] ? alloc_buf.isra.0+0x4b/0x260 [ 11.513583][ T264] ? do_raw_spin_unlock+0x59/0x250 [ 11.513586][ T264] alloc_buf.isra.0+0x4b/0x260 [ 11.513590][ T264] put_chars+0x1e1/0x2f0 [ 11.513593][ T264] ? __send_to_port+0x420/0x420 [ 11.513594][ T264] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 11.513597][ T264] ? validate_chain+0x38b/0xc20 [ 11.513603][ T264] hvc_console_print+0x292/0x780 [ 11.513610][ T264] ? hvc_write+0x3a0/0x3a0 [ 11.513613][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.513615][ T264] ? lock_acquire+0x13c/0x160 [ 11.513619][ T264] console_emit_next_record+0x22f/0x4c0 [ 11.513623][ T264] ? devkmsg_read+0x4b0/0x4b0 [ 11.513625][ T264] ? console_flush_one_record+0x106/0x710 [ 11.513628][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.513629][ T264] ? lock_acquire+0x13c/0x160 [ 11.513633][ T264] console_flush_one_record+0x46f/0x710 [ 11.513637][ T264] ? console_emit_next_record+0x4c0/0x4c0 [ 11.513639][ T264] ? __lock_acquire+0x518/0xc20 [ 11.513645][ T264] console_unlock+0xee/0x1f0 [ 11.513647][ T264] ? console_flush_one_record+0x710/0x710 [ 11.513649][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.513651][ T264] ? lock_acquire+0xe0/0x160 [ 11.513655][ T264] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.513656][ T264] ? vprintk_emit+0x320/0x3e0 [ 11.513659][ T264] vprintk_emit+0x37c/0x3e0 [ 11.513662][ T264] ? wake_up_klogd_work_func+0x90/0x90 [ 11.513665][ T264] ? __lock_acquire+0x518/0xc20 [ 11.513668][ T264] _printk+0xc7/0x100 [ 11.513673][ T264] ? snapshot_read.cold+0x21/0x21 [ 11.513675][ T264] ? do_raw_spin_lock+0x131/0x280 [ 11.513678][ T264] ? __rwlock_init+0x150/0x150 [ 11.513682][ T264] ? do_raw_spin_lock+0x131/0x280 [ 11.513685][ T264] do_exit.cold+0x82/0x9c [ 11.513689][ T264] ? exit_notify+0x890/0x890 [ 11.513690][ T264] ? __lock_release.isra.0+0x69/0x1a0 [ 11.513693][ T264] ? rcu_is_watching+0x16/0xd0 [ 11.513696][ T264] do_group_exit+0xb8/0x370 [ 11.513699][ T264] __x64_sys_exit_group+0x3c/0x50 [ 11.513701][ T264] x64_sys_call+0x1567/0x1570 [ 11.513703][ T264] do_syscall_64+0xff/0x530 [ 11.513707][ T264] ? exc_page_fault+0xee/0x100 [ 11.513710][ T264] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.513712][ T264] RIP: 0033:0x7f638b3111b8 [ 11.513714][ T264] Code: Unable to access opcode bytes at 0x7f638b31118e. [ 11.513716][ T264] RSP: 002b:00007ffe32d5e468 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 11.513718][ T264] RAX: ffffffffffffffda RBX: 00007f638b441f88 RCX: 00007f638b3111b8 [ 11.513719][ T264] RDX: 00007f638b05bfc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 11.513720][ T264] RBP: 00007ffe32d5e4c0 R08: 0000000000000000 R09: 0000000000000050 [ 11.513721][ T264] R10: 00007ffe32d5e280 R11: 0000000000000246 R12: 0000000000000001 [ 11.513722][ T264] R13: 0000000000000000 R14: 00007f638b440680 R15: 00007f638b441fa0 [ 11.513729][ T264] [ 15.064583][ T377] ip (377) used greatest stack depth: 24096 bytes left [ 15.064603][ T377] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.064606][ T377] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 377, name: ip [ 15.064608][ T377] preempt_count: 2, expected: 0 [ 15.064609][ T377] RCU nest depth: 0, expected: 0 [ 15.064611][ T377] locks held by ip/377: 5, last CPU#3: [ 15.064613][ T377] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 15.064628][ T377] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 15.064637][ T377] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 15.064645][ T377] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 15.064651][ T377] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 15.064658][ T377] irq event stamp: 35512 [ 15.064659][ T377] hardirqs last enabled at (35511): [] __down_trylock_console_sem+0x86/0xa0 [ 15.064664][ T377] hardirqs last disabled at (35512): [] console_emit_next_record+0x3d4/0x4c0 [ 15.064667][ T377] softirqs last enabled at (35382): [] handle_softirqs+0x67c/0x900 [ 15.064670][ T377] softirqs last disabled at (34195): [] __irq_exit_rcu+0x145/0x1c0 [ 15.064674][ T377] Preemption disabled at: [ 15.064675][ T377] [<0000000000000000>] 0x0 [ 15.064684][ T377] CPU: 3 UID: 0 PID: 377 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.064688][ T377] Tainted: [W]=WARN [ 15.064690][ T377] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.064692][ T377] Call Trace: [ 15.064694][ T377] [ 15.064696][ T377] dump_stack_lvl+0x6f/0xa0 [ 15.064705][ T377] __might_resched.cold+0x1fe/0x2c1 [ 15.064712][ T377] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.064718][ T377] ? __kmalloc_noprof+0xdb/0x760 [ 15.064725][ T377] __kmalloc_noprof+0x443/0x760 [ 15.064729][ T377] ? alloc_buf.isra.0+0x4b/0x260 [ 15.064739][ T377] ? do_raw_spin_unlock+0x59/0x250 [ 15.064743][ T377] alloc_buf.isra.0+0x4b/0x260 [ 15.064749][ T377] put_chars+0x1e1/0x2f0 [ 15.064754][ T377] ? __send_to_port+0x420/0x420 [ 15.064756][ T377] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 15.064762][ T377] ? validate_chain+0x38b/0xc20 [ 15.064772][ T377] hvc_console_print+0x292/0x780 [ 15.064785][ T377] ? hvc_write+0x3a0/0x3a0 [ 15.064789][ T377] ? rcu_is_watching+0x16/0xd0 [ 15.064793][ T377] ? lock_acquire+0x13c/0x160 [ 15.064800][ T377] console_emit_next_record+0x22f/0x4c0 [ 15.064807][ T377] ? devkmsg_read+0x4b0/0x4b0 [ 15.064810][ T377] ? console_flush_one_record+0x106/0x710 [ 15.064816][ T377] ? rcu_is_watching+0x16/0xd0 [ 15.064819][ T377] ? lock_acquire+0x13c/0x160 [ 15.064826][ T377] console_flush_one_record+0x46f/0x710 [ 15.064834][ T377] ? console_emit_next_record+0x4c0/0x4c0 [ 15.064837][ T377] ? __lock_acquire+0x518/0xc20 [ 15.064847][ T377] console_unlock+0xee/0x1f0 [ 15.064853][ T377] ? console_flush_one_record+0x710/0x710 [ 15.064855][ T377] ? rcu_is_watching+0x16/0xd0 [ 15.064858][ T377] ? lock_acquire+0xe0/0x160 [ 15.064866][ T377] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.064868][ T377] ? vprintk_emit+0x320/0x3e0 [ 15.064874][ T377] vprintk_emit+0x37c/0x3e0 [ 15.064880][ T377] ? wake_up_klogd_work_func+0x90/0x90 [ 15.064886][ T377] ? __lock_acquire+0x518/0xc20 [ 15.064894][ T377] _printk+0xc7/0x100 [ 15.064899][ T377] ? snapshot_read.cold+0x21/0x21 [ 15.064904][ T377] ? do_raw_spin_lock+0x131/0x280 [ 15.064908][ T377] ? __rwlock_init+0x150/0x150 [ 15.064915][ T377] ? do_raw_spin_lock+0x131/0x280 [ 15.064920][ T377] do_exit.cold+0x82/0x9c [ 15.064926][ T377] ? exit_notify+0x890/0x890 [ 15.064928][ T377] ? __lock_release.isra.0+0x69/0x1a0 [ 15.064933][ T377] ? rcu_is_watching+0x16/0xd0 [ 15.064940][ T377] do_group_exit+0xb8/0x370 [ 15.064945][ T377] __x64_sys_exit_group+0x3c/0x50 [ 15.064948][ T377] x64_sys_call+0x1567/0x1570 [ 15.064952][ T377] do_syscall_64+0xff/0x530 [ 15.064957][ T377] ? exc_page_fault+0xee/0x100 [ 15.064962][ T377] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 15.064965][ T377] RIP: 0033:0x7ff14b2171b8 [ 15.064968][ T377] Code: Unable to access opcode bytes at 0x7ff14b21718e. [ 15.064970][ T377] RSP: 002b:00007ffc0204b978 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 15.064974][ T377] RAX: ffffffffffffffda RBX: 00007ff14b347f88 RCX: 00007ff14b2171b8 [ 15.064976][ T377] RDX: 00007ff14af61fc8 RSI: fffffffffffffeb8 RDI: 0000000000000000 [ 15.064977][ T377] RBP: 00007ffc0204b9d0 R08: 0000000000000000 R09: 0000000000008010 [ 15.064979][ T377] R10: 00007ffc0204b790 R11: 0000000000000246 R12: 0000000000000001 [ 15.064980][ T377] R13: 0000000000000000 R14: 00007ff14b346680 R15: 00007ff14b347fa0 [ 15.064994][ T377] [ 26.701294][ T548] udpgso_bench_tx (548) used greatest stack depth: 23056 bytes left [ 26.701313][ T548] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 26.701315][ T548] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 548, name: udpgso_bench_tx [ 26.701317][ T548] preempt_count: 2, expected: 0 [ 26.701318][ T548] RCU nest depth: 0, expected: 0 [ 26.701319][ T548] locks held by udpgso_bench_tx/548: 5, last CPU#2: [ 26.701320][ T548] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 26.701331][ T548] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 26.701336][ T548] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 26.701340][ T548] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 26.701344][ T548] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 26.701348][ T548] irq event stamp: 51478 [ 26.701349][ T548] hardirqs last enabled at (51477): [] __down_trylock_console_sem+0x86/0xa0 [ 26.701352][ T548] hardirqs last disabled at (51478): [] console_emit_next_record+0x3d4/0x4c0 [ 26.701354][ T548] softirqs last enabled at (51472): [] handle_softirqs+0x67c/0x900 [ 26.701357][ T548] softirqs last disabled at (51467): [] __irq_exit_rcu+0x145/0x1c0 [ 26.701359][ T548] Preemption disabled at: [ 26.701360][ T548] [<0000000000000000>] 0x0 [ 26.701366][ T548] CPU: 2 UID: 0 PID: 548 Comm: udpgso_bench_tx Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 26.701370][ T548] Tainted: [W]=WARN [ 26.701371][ T548] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 26.701372][ T548] Call Trace: [ 26.701374][ T548] [ 26.701375][ T548] dump_stack_lvl+0x6f/0xa0 [ 26.701382][ T548] __might_resched.cold+0x1fe/0x2c1 [ 26.701386][ T548] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 26.701390][ T548] ? __kmalloc_noprof+0xdb/0x760 [ 26.701395][ T548] __kmalloc_noprof+0x443/0x760 [ 26.701396][ T548] ? alloc_buf.isra.0+0x4b/0x260 [ 26.701403][ T548] ? do_raw_spin_unlock+0x59/0x250 [ 26.701406][ T548] alloc_buf.isra.0+0x4b/0x260 [ 26.701410][ T548] put_chars+0x1e1/0x2f0 [ 26.701412][ T548] ? __send_to_port+0x420/0x420 [ 26.701413][ T548] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 26.701417][ T548] ? validate_chain+0x38b/0xc20 [ 26.701422][ T548] hvc_console_print+0x292/0x780 [ 26.701430][ T548] ? hvc_write+0x3a0/0x3a0 [ 26.701433][ T548] ? rcu_is_watching+0x16/0xd0 [ 26.701435][ T548] ? lock_acquire+0x13c/0x160 [ 26.701439][ T548] console_emit_next_record+0x22f/0x4c0 [ 26.701443][ T548] ? devkmsg_read+0x4b0/0x4b0 [ 26.701444][ T548] ? console_flush_one_record+0x106/0x710 [ 26.701448][ T548] ? rcu_is_watching+0x16/0xd0 [ 26.701449][ T548] ? lock_acquire+0x13c/0x160 [ 26.701453][ T548] console_flush_one_record+0x46f/0x710 [ 26.701457][ T548] ? console_emit_next_record+0x4c0/0x4c0 [ 26.701459][ T548] ? __lock_acquire+0x518/0xc20 [ 26.701464][ T548] console_unlock+0xee/0x1f0 [ 26.701467][ T548] ? console_flush_one_record+0x710/0x710 [ 26.701469][ T548] ? rcu_is_watching+0x16/0xd0 [ 26.701471][ T548] ? lock_acquire+0xe0/0x160 [ 26.701475][ T548] ? __down_trylock_console_sem+0x5e/0xa0 [ 26.701476][ T548] ? vprintk_emit+0x320/0x3e0 [ 26.701479][ T548] vprintk_emit+0x37c/0x3e0 [ 26.701482][ T548] ? wake_up_klogd_work_func+0x90/0x90 [ 26.701484][ T548] ? do_raw_spin_unlock+0x59/0x250 [ 26.701487][ T548] ? __lock_acquire+0x518/0xc20 [ 26.701490][ T548] _printk+0xc7/0x100 [ 26.701494][ T548] ? snapshot_read.cold+0x21/0x21 [ 26.701497][ T548] ? do_raw_spin_lock+0x131/0x280 [ 26.701500][ T548] ? __rwlock_init+0x150/0x150 [ 26.701504][ T548] ? do_raw_spin_lock+0x131/0x280 [ 26.701506][ T548] do_exit.cold+0x82/0x9c [ 26.701510][ T548] ? exit_notify+0x890/0x890 [ 26.701511][ T548] ? __lock_release.isra.0+0x69/0x1a0 [ 26.701514][ T548] ? rcu_is_watching+0x16/0xd0 [ 26.701517][ T548] do_group_exit+0xb8/0x370 [ 26.701520][ T548] __x64_sys_exit_group+0x3c/0x50 [ 26.701522][ T548] x64_sys_call+0x1567/0x1570 [ 26.701525][ T548] do_syscall_64+0xff/0x530 [ 26.701529][ T548] ? exc_page_fault+0xee/0x100 [ 26.701531][ T548] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 26.701534][ T548] RIP: 0033:0x7f5bdaecd1b8 [ 26.701536][ T548] Code: Unable to access opcode bytes at 0x7f5bdaecd18e. [ 26.701537][ T548] RSP: 002b:00007fff4e8584d8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 26.701539][ T548] RAX: ffffffffffffffda RBX: 00007f5bdaffdf88 RCX: 00007f5bdaecd1b8 [ 26.701540][ T548] RDX: 00007f5bdae0aa48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 26.701541][ T548] RBP: 00007fff4e858530 R08: 0000000000000000 R09: 0000000000000000 [ 26.701542][ T548] R10: 00007fff4e858370 R11: 0000000000000246 R12: 0000000000000001 [ 26.701543][ T548] R13: 0000000000000000 R14: 00007f5bdaffc680 R15: 00007f5bdaffdfa0 [ 26.701550][ T548] [ 28.742833][ T616] br0: port 1(veth1) entered blocking state [ 28.743027][ T616] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 28.743030][ T616] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 616, name: ip [ 28.743032][ T616] preempt_count: 1, expected: 0 [ 28.743032][ T616] RCU nest depth: 0, expected: 0 [ 28.743034][ T616] locks held by ip/616: 5, last CPU#2: [ 28.743035][ T616] #0: ffffffff9e11b740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 28.743047][ T616] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 28.743053][ T616] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 28.743057][ T616] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 28.743061][ T616] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 28.743065][ T616] irq event stamp: 15868 [ 28.743066][ T616] hardirqs last enabled at (15867): [] __down_trylock_console_sem+0x86/0xa0 [ 28.743070][ T616] hardirqs last disabled at (15868): [] console_emit_next_record+0x3d4/0x4c0 [ 28.743072][ T616] softirqs last enabled at (15780): [] __alloc_skb+0x4c2/0x5f0 [ 28.743075][ T616] softirqs last disabled at (15778): [] __alloc_skb+0x4c2/0x5f0 [ 28.743078][ T616] Preemption disabled at: [ 28.743078][ T616] [] vprintk_emit+0x31b/0x3e0 [ 28.743083][ T616] CPU: 2 UID: 0 PID: 616 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 28.743087][ T616] Tainted: [W]=WARN [ 28.743088][ T616] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 28.743089][ T616] Call Trace: [ 28.743093][ T616] [ 28.743095][ T616] dump_stack_lvl+0x6f/0xa0 [ 28.743101][ T616] ? vprintk_emit+0x31b/0x3e0 [ 28.743103][ T616] __might_resched.cold+0x1fe/0x2c1 [ 28.743107][ T616] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 28.743111][ T616] ? __kmalloc_noprof+0xdb/0x760 [ 28.743116][ T616] __kmalloc_noprof+0x443/0x760 [ 28.743118][ T616] ? alloc_buf.isra.0+0x4b/0x260 [ 28.743124][ T616] ? do_raw_spin_unlock+0x59/0x250 [ 28.743127][ T616] alloc_buf.isra.0+0x4b/0x260 [ 28.743131][ T616] put_chars+0x1e1/0x2f0 [ 28.743134][ T616] ? __send_to_port+0x420/0x420 [ 28.743136][ T616] ? validate_chain+0x34a/0xc20 [ 28.743142][ T616] hvc_console_print+0x292/0x780 [ 28.743149][ T616] ? hvc_write+0x3a0/0x3a0 [ 28.743152][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743155][ T616] ? lock_acquire+0x13c/0x160 [ 28.743159][ T616] console_emit_next_record+0x22f/0x4c0 [ 28.743163][ T616] ? devkmsg_read+0x4b0/0x4b0 [ 28.743165][ T616] ? console_flush_one_record+0x106/0x710 [ 28.743168][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743170][ T616] ? lock_acquire+0x13c/0x160 [ 28.743174][ T616] console_flush_one_record+0x46f/0x710 [ 28.743178][ T616] ? console_emit_next_record+0x4c0/0x4c0 [ 28.743180][ T616] ? __lock_acquire+0x518/0xc20 [ 28.743185][ T616] console_unlock+0xee/0x1f0 [ 28.743188][ T616] ? console_flush_one_record+0x710/0x710 [ 28.743190][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743192][ T616] ? lock_acquire+0xe0/0x160 [ 28.743195][ T616] ? __down_trylock_console_sem+0x5e/0xa0 [ 28.743197][ T616] ? vprintk_emit+0x320/0x3e0 [ 28.743200][ T616] vprintk_emit+0x37c/0x3e0 [ 28.743203][ T616] ? wake_up_klogd_work_func+0x90/0x90 [ 28.743205][ T616] ? __lock_release.isra.0+0x69/0x1a0 [ 28.743206][ T616] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 28.743211][ T616] ? mark_held_locks+0x40/0x70 [ 28.743214][ T616] _printk+0xc7/0x100 [ 28.743218][ T616] ? snapshot_read.cold+0x21/0x21 [ 28.743221][ T616] ? br_multicast_flood+0x960/0x960 [ 28.743225][ T616] ? do_setlink.isra.0+0x9ec/0x2a60 [ 28.743226][ T616] ? rtnl_newlink+0x9f1/0x11b0 [ 28.743227][ T616] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.743232][ T616] br_set_state+0x22f/0x430 [ 28.743236][ T616] br_init_port+0xc4/0x200 [ 28.743238][ T616] new_nbp+0x3a0/0x650 [ 28.743242][ T616] br_add_if+0x212/0x1320 [ 28.743244][ T616] ? is_bpf_text_address+0x72/0x110 [ 28.743248][ T616] ? kernel_text_address+0x149/0x170 [ 28.743261][ T616] do_set_master+0x3b2/0x780 [ 28.743265][ T616] do_setlink.isra.0+0x9ec/0x2a60 [ 28.743268][ T616] ? stack_trace_save+0x93/0xc0 [ 28.743272][ T616] ? rtnl_link_get_size+0x350/0x350 [ 28.743273][ T616] ? rcu_read_lock_any_held+0x66/0x90 [ 28.743276][ T616] ? stack_depot_save_flags+0x38e/0x790 [ 28.743279][ T616] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 28.743281][ T616] ? rcu_read_lock_any_held+0x3c/0x90 [ 28.743283][ T616] ? validate_chain+0x38b/0xc20 [ 28.743286][ T616] ? kasan_save_stack+0x3d/0x50 [ 28.743288][ T616] ? kasan_save_stack+0x2f/0x50 [ 28.743289][ T616] ? kasan_save_track+0x14/0x30 [ 28.743290][ T616] ? __kasan_kmalloc+0x7b/0x90 [ 28.743293][ T616] ? __lock_acquire+0x518/0xc20 [ 28.743295][ T616] ? snd_ac97_proc_read_main+0x4de/0x1f00 [ 28.743298][ T616] ? ___sys_sendmsg+0xd0/0x1d0 [ 28.743302][ T616] ? lock_acquire.part.0+0xd4/0x280 [ 28.743304][ T616] ? rtnl_newlink+0x9a8/0x11b0 [ 28.743306][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743308][ T616] ? lock_acquire+0x13c/0x160 [ 28.743310][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743311][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743312][ T616] ? trace_contention_end+0xb3/0x180 [ 28.743315][ T616] ? __mutex_lock+0x1db/0x1ea0 [ 28.743316][ T616] ? __mutex_lock+0x9a3/0x1ea0 [ 28.743318][ T616] ? rtnl_newlink+0x9a8/0x11b0 [ 28.743322][ T616] ? ww_mutex_lock+0x160/0x160 [ 28.743323][ T616] ? nla_get_range_signed+0x3d0/0x3d0 [ 28.743328][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743330][ T616] ? __rtnl_newlink+0x3fa/0xa50 [ 28.743336][ T616] rtnl_newlink+0x9f1/0x11b0 [ 28.743341][ T616] ? rtnl_bridge_getlink+0x850/0x850 [ 28.743343][ T616] ? __lock_acquire+0x518/0xc20 [ 28.743348][ T616] ? lock_acquire.part.0+0xd4/0x280 [ 28.743349][ T616] ? find_held_lock+0x2b/0x80 [ 28.743352][ T616] ? rtnl_bridge_getlink+0x850/0x850 [ 28.743353][ T616] ? __lock_release.isra.0+0x69/0x1a0 [ 28.743357][ T616] ? rtnl_bridge_getlink+0x850/0x850 [ 28.743359][ T616] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 28.743362][ T616] ? rtnl_link_fill+0x920/0x920 [ 28.743364][ T616] ? __lock_acquire+0x518/0xc20 [ 28.743368][ T616] ? lock_acquire.part.0+0xd4/0x280 [ 28.743370][ T616] ? find_held_lock+0x2b/0x80 [ 28.743374][ T616] netlink_rcv_skb+0x14e/0x3a0 [ 28.743377][ T616] ? rtnl_link_fill+0x920/0x920 [ 28.743380][ T616] ? netlink_ack+0xcf0/0xcf0 [ 28.743387][ T616] ? netlink_deliver_tap+0xc5/0x330 [ 28.743389][ T616] ? netlink_deliver_tap+0x13c/0x330 [ 28.743393][ T616] netlink_unicast+0x486/0x750 [ 28.743397][ T616] ? netlink_attachskb+0x810/0x810 [ 28.743400][ T616] ? find_held_lock+0x2b/0x80 [ 28.743404][ T616] netlink_sendmsg+0x75b/0xc90 [ 28.743408][ T616] ? netlink_unicast+0x750/0x750 [ 28.743412][ T616] ? __lock_release.isra.0+0x69/0x1a0 [ 28.743414][ T616] ? __import_iovec+0x36c/0x620 [ 28.743419][ T616] __sock_sendmsg+0xce/0x190 [ 28.743422][ T616] ____sys_sendmsg+0x61a/0x860 [ 28.743424][ T616] ? copy_msghdr_from_user+0x279/0x420 [ 28.743427][ T616] ? sock_write_iter+0x400/0x400 [ 28.743428][ T616] ? move_addr_to_kernel+0x40/0x40 [ 28.743436][ T616] ___sys_sendmsg+0x14e/0x1d0 [ 28.743439][ T616] ? copy_msghdr_from_user+0x420/0x420 [ 28.743455][ T616] __sys_sendmsg+0x12c/0x1d0 [ 28.743458][ T616] ? __sys_sendmsg_sock+0x20/0x20 [ 28.743465][ T616] ? rcu_is_watching+0x16/0xd0 [ 28.743468][ T616] do_syscall_64+0xff/0x530 [ 28.743471][ T616] ? exc_page_fault+0xee/0x100 [ 28.743473][ T616] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 28.743476][ T616] RIP: 0033:0x7f053fe9254e [ 28.743480][ T616] 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.743482][ T616] RSP: 002b:00007ffe006de620 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 28.743484][ T616] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f053fe9254e [ 28.743486][ T616] RDX: 0000000000000000 RSI: 00007ffe006de6d0 RDI: 0000000000000005 [ 28.743486][ T616] RBP: 00007ffe006de630 R08: 0000000000000000 R09: 0000000000000000 [ 28.743487][ T616] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91af7b [ 28.743488][ T616] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffe006deda0 [ 28.743495][ T616] [ 28.793229][ T616] br0: port 1(veth1) entered disabled state [ 28.793690][ T616] veth1: entered allmulticast mode [ 28.795178][ T616] veth1: entered promiscuous mode [ 29.005886][ T621] br0: port 2(veth_segment) entered blocking state [ 29.006250][ T621] br0: port 2(veth_segment) entered disabled state [ 29.006605][ T621] veth_segment: entered allmulticast mode [ 29.007709][ T621] veth_segment: entered promiscuous mode [ 29.040716][ T622] br0: port 2(veth_segment) entered blocking state [ 29.041165][ T622] br0: port 2(veth_segment) entered forwarding state [ 29.041817][ T622] br0: port 1(veth1) entered blocking state [ 29.042100][ T622] br0: port 1(veth1) entered forwarding state [ 31.534602][ T638] iperf3 (638) used greatest stack depth: 22624 bytes left [ 31.534622][ T638] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 31.534624][ T638] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 638, name: iperf3 [ 31.534626][ T638] preempt_count: 2, expected: 0 [ 31.534627][ T638] RCU nest depth: 0, expected: 0 [ 31.534628][ T638] locks held by iperf3/638: 5, last CPU#0: [ 31.534629][ T638] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 31.534641][ T638] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 31.534646][ T638] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 31.534651][ T638] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 31.534655][ T638] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 31.534659][ T638] irq event stamp: 1354200 [ 31.534660][ T638] hardirqs last enabled at (1354199): [] __down_trylock_console_sem+0x86/0xa0 [ 31.534663][ T638] hardirqs last disabled at (1354200): [] console_emit_next_record+0x3d4/0x4c0 [ 31.534665][ T638] softirqs last enabled at (1353562): [] handle_softirqs+0x67c/0x900 [ 31.534668][ T638] softirqs last disabled at (1353471): [] __irq_exit_rcu+0x145/0x1c0 [ 31.534670][ T638] Preemption disabled at: [ 31.534671][ T638] [<0000000000000000>] 0x0 [ 31.534680][ T638] CPU: 0 UID: 0 PID: 638 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 31.534684][ T638] Tainted: [W]=WARN [ 31.534685][ T638] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 31.534687][ T638] Call Trace: [ 31.534688][ T638] [ 31.534690][ T638] dump_stack_lvl+0x6f/0xa0 [ 31.534697][ T638] __might_resched.cold+0x1fe/0x2c1 [ 31.534701][ T638] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 31.534705][ T638] ? __kmalloc_noprof+0xdb/0x760 [ 31.534710][ T638] __kmalloc_noprof+0x443/0x760 [ 31.534712][ T638] ? alloc_buf.isra.0+0x4b/0x260 [ 31.534718][ T638] ? do_raw_spin_unlock+0x59/0x250 [ 31.534721][ T638] alloc_buf.isra.0+0x4b/0x260 [ 31.534725][ T638] put_chars+0x1e1/0x2f0 [ 31.534727][ T638] ? prb_final_commit+0x50/0x50 [ 31.534729][ T638] ? __send_to_port+0x420/0x420 [ 31.534732][ T638] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 31.534735][ T638] ? rcu_read_lock_any_held+0x3c/0x90 [ 31.534738][ T638] ? validate_chain+0x38b/0xc20 [ 31.534742][ T638] hvc_console_print+0x292/0x780 [ 31.534747][ T638] ? mark_usage+0x61/0x170 [ 31.534749][ T638] ? __lock_acquire+0x518/0xc20 [ 31.534750][ T638] ? __lock_acquire+0x518/0xc20 [ 31.534754][ T638] ? hvc_write+0x3a0/0x3a0 [ 31.534757][ T638] ? console_emit_next_record+0x1df/0x4c0 [ 31.534760][ T638] ? rcu_is_watching+0x16/0xd0 [ 31.534762][ T638] ? lock_acquire+0x13c/0x160 [ 31.534766][ T638] console_emit_next_record+0x22f/0x4c0 [ 31.534770][ T638] ? devkmsg_read+0x4b0/0x4b0 [ 31.534772][ T638] ? console_flush_one_record+0x106/0x710 [ 31.534775][ T638] ? rcu_is_watching+0x16/0xd0 [ 31.534777][ T638] ? lock_acquire+0x13c/0x160 [ 31.534781][ T638] console_flush_one_record+0x46f/0x710 [ 31.534785][ T638] ? console_emit_next_record+0x4c0/0x4c0 [ 31.534787][ T638] ? __lock_acquire+0x518/0xc20 [ 31.534792][ T638] console_unlock+0xee/0x1f0 [ 31.534795][ T638] ? console_flush_one_record+0x710/0x710 [ 31.534797][ T638] ? rcu_is_watching+0x16/0xd0 [ 31.534798][ T638] ? lock_acquire+0xe0/0x160 [ 31.534802][ T638] ? __down_trylock_console_sem+0x5e/0xa0 [ 31.534804][ T638] ? vprintk_emit+0x320/0x3e0 [ 31.534806][ T638] vprintk_emit+0x37c/0x3e0 [ 31.534809][ T638] ? wake_up_klogd_work_func+0x90/0x90 [ 31.534811][ T638] ? do_raw_spin_unlock+0x59/0x250 [ 31.534814][ T638] ? __lock_acquire+0x518/0xc20 [ 31.534817][ T638] _printk+0xc7/0x100 [ 31.534821][ T638] ? snapshot_read.cold+0x21/0x21 [ 31.534824][ T638] ? do_raw_spin_lock+0x131/0x280 [ 31.534826][ T638] ? __rwlock_init+0x150/0x150 [ 31.534830][ T638] ? do_raw_spin_lock+0x131/0x280 [ 31.534833][ T638] do_exit.cold+0x82/0x9c [ 31.534837][ T638] ? exit_notify+0x890/0x890 [ 31.534842][ T638] __x64_sys_exit+0x42/0x50 [ 31.534844][ T638] x64_sys_call+0x156c/0x1570 [ 31.534846][ T638] do_syscall_64+0xff/0x530 [ 31.534850][ T638] ? exc_page_fault+0xee/0x100 [ 31.534853][ T638] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 31.534855][ T638] RIP: 0033:0x7f4108cd4c49 [ 31.534857][ T638] Code: Unable to access opcode bytes at 0x7f4108cd4c1f. [ 31.534859][ T638] RSP: 002b:00007f4108493e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 31.534861][ T638] RAX: ffffffffffffffda RBX: 00007f41084946c0 RCX: 00007f4108cd4c49 [ 31.534863][ T638] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 31.534864][ T638] RBP: 00007f4108493f70 R08: 0000000000000001 R09: 00007f41084946c0 [ 31.534865][ T638] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f4107c94000 [ 31.534865][ T638] R13: 00007ffeaccd94d0 R14: 0000000000000002 R15: 00007ffeaccd95d7 [ 31.534872][ T638] [ 31.711915][ T12] br0: port 1(veth1) entered disabled state [ 31.721644][ T12] veth1 (unregistering): left allmulticast mode [ 31.722119][ T12] veth1 (unregistering): left promiscuous mode [ 31.723179][ T12] br0: port 1(veth1) entered disabled state [ 31.753616][ T12] veth_segment: left allmulticast mode [ 31.753869][ T12] veth_segment: left promiscuous mode [ 31.754191][ T12] br0: port 2(veth_segment) entered disabled state [ 48.123361][ T1007] udpgso_bench_tx (1007) used greatest stack depth: 22592 bytes left [ 48.123379][ T1007] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 48.123381][ T1007] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1007, name: udpgso_bench_tx [ 48.123383][ T1007] preempt_count: 2, expected: 0 [ 48.123384][ T1007] RCU nest depth: 0, expected: 0 [ 48.123385][ T1007] locks held by udpgso_bench_tx/1007: 5, last CPU#3: [ 48.123387][ T1007] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 48.123398][ T1007] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 48.123403][ T1007] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 48.123407][ T1007] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 48.123411][ T1007] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 48.123415][ T1007] irq event stamp: 49660 [ 48.123416][ T1007] hardirqs last enabled at (49659): [] __down_trylock_console_sem+0x86/0xa0 [ 48.123419][ T1007] hardirqs last disabled at (49660): [] console_emit_next_record+0x3d4/0x4c0 [ 48.123421][ T1007] softirqs last enabled at (49570): [] handle_softirqs+0x67c/0x900 [ 48.123423][ T1007] softirqs last disabled at (49565): [] __irq_exit_rcu+0x145/0x1c0 [ 48.123426][ T1007] Preemption disabled at: [ 48.123426][ T1007] [<0000000000000000>] 0x0 [ 48.123433][ T1007] CPU: 3 UID: 0 PID: 1007 Comm: udpgso_bench_tx Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 48.123436][ T1007] Tainted: [W]=WARN [ 48.123437][ T1007] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 48.123439][ T1007] Call Trace: [ 48.123440][ T1007] [ 48.123441][ T1007] dump_stack_lvl+0x6f/0xa0 [ 48.123448][ T1007] __might_resched.cold+0x1fe/0x2c1 [ 48.123452][ T1007] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 48.123456][ T1007] ? __kmalloc_noprof+0xdb/0x760 [ 48.123460][ T1007] __kmalloc_noprof+0x443/0x760 [ 48.123462][ T1007] ? alloc_buf.isra.0+0x4b/0x260 [ 48.123469][ T1007] ? do_raw_spin_unlock+0x59/0x250 [ 48.123472][ T1007] alloc_buf.isra.0+0x4b/0x260 [ 48.123475][ T1007] put_chars+0x1e1/0x2f0 [ 48.123478][ T1007] ? __send_to_port+0x420/0x420 [ 48.123479][ T1007] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 48.123483][ T1007] ? validate_chain+0x38b/0xc20 [ 48.123488][ T1007] hvc_console_print+0x292/0x780 [ 48.123499][ T1007] ? hvc_write+0x3a0/0x3a0 [ 48.123502][ T1007] ? rcu_is_watching+0x16/0xd0 [ 48.123504][ T1007] ? lock_acquire+0x13c/0x160 [ 48.123508][ T1007] console_emit_next_record+0x22f/0x4c0 [ 48.123512][ T1007] ? devkmsg_read+0x4b0/0x4b0 [ 48.123514][ T1007] ? console_flush_one_record+0x106/0x710 [ 48.123517][ T1007] ? rcu_is_watching+0x16/0xd0 [ 48.123519][ T1007] ? lock_acquire+0x13c/0x160 [ 48.123522][ T1007] console_flush_one_record+0x46f/0x710 [ 48.123527][ T1007] ? console_emit_next_record+0x4c0/0x4c0 [ 48.123528][ T1007] ? __lock_acquire+0x518/0xc20 [ 48.123534][ T1007] console_unlock+0xee/0x1f0 [ 48.123536][ T1007] ? console_flush_one_record+0x710/0x710 [ 48.123538][ T1007] ? rcu_is_watching+0x16/0xd0 [ 48.123540][ T1007] ? lock_acquire+0xe0/0x160 [ 48.123544][ T1007] ? __down_trylock_console_sem+0x5e/0xa0 [ 48.123545][ T1007] ? vprintk_emit+0x320/0x3e0 [ 48.123548][ T1007] vprintk_emit+0x37c/0x3e0 [ 48.123551][ T1007] ? wake_up_klogd_work_func+0x90/0x90 [ 48.123552][ T1007] ? do_raw_spin_unlock+0x59/0x250 [ 48.123555][ T1007] ? __lock_acquire+0x518/0xc20 [ 48.123559][ T1007] _printk+0xc7/0x100 [ 48.123563][ T1007] ? snapshot_read.cold+0x21/0x21 [ 48.123565][ T1007] ? do_raw_spin_lock+0x131/0x280 [ 48.123568][ T1007] ? __rwlock_init+0x150/0x150 [ 48.123572][ T1007] ? do_raw_spin_lock+0x131/0x280 [ 48.123575][ T1007] do_exit.cold+0x82/0x9c [ 48.123578][ T1007] ? exit_notify+0x890/0x890 [ 48.123580][ T1007] ? __lock_release.isra.0+0x69/0x1a0 [ 48.123582][ T1007] ? rcu_is_watching+0x16/0xd0 [ 48.123586][ T1007] do_group_exit+0xb8/0x370 [ 48.123589][ T1007] __x64_sys_exit_group+0x3c/0x50 [ 48.123591][ T1007] x64_sys_call+0x1567/0x1570 [ 48.123593][ T1007] do_syscall_64+0xff/0x530 [ 48.123597][ T1007] ? exc_page_fault+0xee/0x100 [ 48.123600][ T1007] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 48.123602][ T1007] RIP: 0033:0x7fa87430f1b8 [ 48.123604][ T1007] Code: Unable to access opcode bytes at 0x7fa87430f18e. [ 48.123606][ T1007] RSP: 002b:00007ffeaec7c4b8 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 48.123608][ T1007] RAX: ffffffffffffffda RBX: 00007fa87443ff88 RCX: 00007fa87430f1b8 [ 48.123609][ T1007] RDX: 00007fa87424ca48 RSI: ffffffffffffffb0 RDI: 0000000000000000 [ 48.123610][ T1007] RBP: 00007ffeaec7c510 R08: 0000000000000000 R09: 0000000000000000 [ 48.123611][ T1007] R10: 00007ffeaec7c350 R11: 0000000000000246 R12: 0000000000000001 [ 48.123612][ T1007] R13: 0000000000000000 R14: 00007fa87443e680 R15: 00007fa87443ffa0 [ 48.123619][ T1007] [ 50.179368][ T1075] br0: port 1(veth1) entered blocking state [ 50.179388][ T1075] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 50.179390][ T1075] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1075, name: ip [ 50.179392][ T1075] preempt_count: 1, expected: 0 [ 50.179393][ T1075] RCU nest depth: 0, expected: 0 [ 50.179394][ T1075] locks held by ip/1075: 5, last CPU#2: [ 50.179396][ T1075] #0: ffffffff9e11b740 (rtnl_mutex){+.+.}-{4:4}, at: rtnl_newlink+0x9a8/0x11b0 [ 50.179408][ T1075] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 50.179413][ T1075] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 50.179418][ T1075] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 50.179421][ T1075] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 50.179426][ T1075] irq event stamp: 16434 [ 50.179426][ T1075] hardirqs last enabled at (16433): [] __down_trylock_console_sem+0x86/0xa0 [ 50.179430][ T1075] hardirqs last disabled at (16434): [] console_emit_next_record+0x3d4/0x4c0 [ 50.179432][ T1075] softirqs last enabled at (16394): [] handle_softirqs+0x67c/0x900 [ 50.179435][ T1075] softirqs last disabled at (16387): [] __irq_exit_rcu+0x145/0x1c0 [ 50.179437][ T1075] Preemption disabled at: [ 50.179438][ T1075] [] vprintk_emit+0x31b/0x3e0 [ 50.179443][ T1075] CPU: 2 UID: 0 PID: 1075 Comm: ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 50.179447][ T1075] Tainted: [W]=WARN [ 50.179448][ T1075] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 50.179450][ T1075] Call Trace: [ 50.179451][ T1075] [ 50.179453][ T1075] dump_stack_lvl+0x6f/0xa0 [ 50.179459][ T1075] ? vprintk_emit+0x31b/0x3e0 [ 50.179461][ T1075] __might_resched.cold+0x1fe/0x2c1 [ 50.179465][ T1075] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 50.179469][ T1075] ? __kmalloc_noprof+0xdb/0x760 [ 50.179473][ T1075] __kmalloc_noprof+0x443/0x760 [ 50.179475][ T1075] ? alloc_buf.isra.0+0x4b/0x260 [ 50.179482][ T1075] ? do_raw_spin_unlock+0x59/0x250 [ 50.179484][ T1075] alloc_buf.isra.0+0x4b/0x260 [ 50.179488][ T1075] put_chars+0x1e1/0x2f0 [ 50.179491][ T1075] ? __send_to_port+0x420/0x420 [ 50.179492][ T1075] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 50.179496][ T1075] ? validate_chain+0x38b/0xc20 [ 50.179501][ T1075] hvc_console_print+0x292/0x780 [ 50.179509][ T1075] ? hvc_write+0x3a0/0x3a0 [ 50.179511][ T1075] ? rcu_is_watching+0x16/0xd0 [ 50.179513][ T1075] ? lock_acquire+0x13c/0x160 [ 50.179517][ T1075] console_emit_next_record+0x22f/0x4c0 [ 50.179522][ T1075] ? devkmsg_read+0x4b0/0x4b0 [ 50.179523][ T1075] ? console_flush_one_record+0x106/0x710 [ 50.179527][ T1075] ? rcu_is_watching+0x16/0xd0 [ 50.179529][ T1075] ? lock_acquire+0x13c/0x160 [ 50.179532][ T1075] console_flush_one_record+0x46f/0x710 [ 50.179537][ T1075] ? console_emit_next_record+0x4c0/0x4c0 [ 50.179539][ T1075] ? __lock_acquire+0x518/0xc20 [ 50.179544][ T1075] console_unlock+0xee/0x1f0 [ 50.179547][ T1075] ? console_flush_one_record+0x710/0x710 [ 50.179549][ T1075] ? rcu_is_watching+0x16/0xd0 [ 50.179550][ T1075] ? lock_acquire+0xe0/0x160 [ 50.179554][ T1075] ? __down_trylock_console_sem+0x5e/0xa0 [ 50.179556][ T1075] ? vprintk_emit+0x320/0x3e0 [ 50.179558][ T1075] vprintk_emit+0x37c/0x3e0 [ 50.179561][ T1075] ? wake_up_klogd_work_func+0x90/0x90 [ 50.179563][ T1075] ? __lock_release.isra.0+0x69/0x1a0 [ 50.179566][ T1075] ? mark_held_locks+0x40/0x70 [ 50.179569][ T1075] _printk+0xc7/0x100 [ 50.179573][ T1075] ? snapshot_read.cold+0x21/0x21 [ 50.179577][ T1075] ? br_multicast_flood+0x960/0x960 [ 50.179580][ T1075] ? do_setlink.isra.0+0x9ec/0x2a60 [ 50.179581][ T1075] ? rtnl_newlink+0x9f1/0x11b0 [ 50.179583][ T1075] ? rtnetlink_rcv_msg+0x6fd/0xbd0 [ 50.179587][ T1075] br_set_state+0x22f/0x430 [ 50.179591][ T1075] br_init_port+0xc4/0x200 [ 50.179593][ T1075] new_nbp+0x3a0/0x650 [ 50.179597][ T1075] br_add_if+0x212/0x1320 [ 50.179600][ T1075] ? is_bpf_text_address+0x72/0x110 [ 50.179603][ T1075] ? kernel_text_address+0x149/0x170 [ 50.179609][ T1075] do_set_master+0x3b2/0x780 [ 50.179613][ T1075] do_setlink.isra.0+0x9ec/0x2a60 [ 50.179616][ T1075] ? stack_trace_save+0x93/0xc0 [ 50.179619][ T1075] ? rtnl_link_get_size+0x350/0x350 [ 50.179621][ T1075] ? rcu_read_lock_any_held+0x66/0x90 [ 50.179624][ T1075] ? stack_depot_save_flags+0x38e/0x790 [ 50.179627][ T1075] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 50.179629][ T1075] ? rcu_read_lock_any_held+0x3c/0x90 [ 50.179630][ T1075] ? validate_chain+0x38b/0xc20 [ 50.179633][ T1075] ? kasan_save_stack+0x3d/0x50 [ 50.179635][ T1075] ? kasan_save_stack+0x2f/0x50 [ 50.179637][ T1075] ? kasan_save_track+0x14/0x30 [ 50.179638][ T1075] ? __kasan_kmalloc+0x7b/0x90 [ 50.179640][ T1075] ? __lock_acquire+0x518/0xc20 [ 50.179642][ T1075] ? snd_ac97_proc_read_main+0x4de/0x1f00 [ 50.179646][ T1075] ? ___sys_sendmsg+0xd0/0x1d0 [ 50.179649][ T1075] ? lock_acquire.part.0+0xd4/0x280 [ 50.179651][ T1075] ? rtnl_newlink+0x9a8/0x11b0 [ 50.179654][ T1075] ? rcu_is_watching+0x16/0xd0 [ 50.179655][ T1075] ? mark_held_locks+0x40/0x70 [ 50.179658][ T1075] ? lockdep_hardirqs_on+0x91/0x130 [ 50.179661][ T1075] ? irqentry_exit+0x21c/0x790 [ 50.179663][ T1075] ? irqentry_exit+0x21c/0x790 [ 50.179664][ T1075] ? lockdep_hardirqs_off+0x97/0xf0 [ 50.179666][ T1075] ? sysvec_apic_timer_interrupt+0xaa/0xe0 [ 50.179673][ T1075] ? __dev_get_by_index+0x4/0x140 [ 50.179677][ T1075] ? __rtnl_newlink+0x3fa/0xa50 [ 50.179683][ T1075] rtnl_newlink+0x9f1/0x11b0 [ 50.179691][ T1075] ? rtnl_bridge_getlink+0x850/0x850 [ 50.179693][ T1075] ? __lock_acquire+0x518/0xc20 [ 50.179697][ T1075] ? lock_acquire.part.0+0xd4/0x280 [ 50.179699][ T1075] ? find_held_lock+0x2b/0x80 [ 50.179701][ T1075] ? rtnl_bridge_getlink+0x850/0x850 [ 50.179703][ T1075] ? __lock_release.isra.0+0x69/0x1a0 [ 50.179707][ T1075] ? rtnl_bridge_getlink+0x850/0x850 [ 50.179709][ T1075] rtnetlink_rcv_msg+0x6fd/0xbd0 [ 50.179712][ T1075] ? rtnl_link_fill+0x920/0x920 [ 50.179713][ T1075] ? __lock_acquire+0x518/0xc20 [ 50.179718][ T1075] ? lock_acquire.part.0+0xd4/0x280 [ 50.179720][ T1075] ? find_held_lock+0x2b/0x80 [ 50.179723][ T1075] netlink_rcv_skb+0x14e/0x3a0 [ 50.179726][ T1075] ? rtnl_link_fill+0x920/0x920 [ 50.179729][ T1075] ? netlink_ack+0xcf0/0xcf0 [ 50.179736][ T1075] ? netlink_deliver_tap+0xc5/0x330 [ 50.179737][ T1075] ? netlink_deliver_tap+0x13c/0x330 [ 50.179742][ T1075] netlink_unicast+0x486/0x750 [ 50.179746][ T1075] ? netlink_attachskb+0x810/0x810 [ 50.179748][ T1075] ? find_held_lock+0x2b/0x80 [ 50.179753][ T1075] netlink_sendmsg+0x75b/0xc90 [ 50.179756][ T1075] ? netlink_unicast+0x750/0x750 [ 50.179760][ T1075] ? __lock_release.isra.0+0x69/0x1a0 [ 50.179762][ T1075] ? __import_iovec+0x36c/0x620 [ 50.179767][ T1075] __sock_sendmsg+0xce/0x190 [ 50.179770][ T1075] ____sys_sendmsg+0x61a/0x860 [ 50.179772][ T1075] ? copy_msghdr_from_user+0x279/0x420 [ 50.179774][ T1075] ? sock_write_iter+0x400/0x400 [ 50.179776][ T1075] ? move_addr_to_kernel+0x40/0x40 [ 50.179783][ T1075] ___sys_sendmsg+0x14e/0x1d0 [ 50.179786][ T1075] ? copy_msghdr_from_user+0x420/0x420 [ 50.179802][ T1075] __sys_sendmsg+0x12c/0x1d0 [ 50.179805][ T1075] ? __sys_sendmsg_sock+0x20/0x20 [ 50.179811][ T1075] ? rcu_is_watching+0x16/0xd0 [ 50.179814][ T1075] do_syscall_64+0xff/0x530 [ 50.179817][ T1075] ? exc_page_fault+0xee/0x100 [ 50.179819][ T1075] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 50.179822][ T1075] RIP: 0033:0x7fd4a703b54e [ 50.179826][ T1075] 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.179827][ T1075] RSP: 002b:00007ffc476e1360 EFLAGS: 00000202 ORIG_RAX: 000000000000002e [ 50.179830][ T1075] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd4a703b54e [ 50.179832][ T1075] RDX: 0000000000000000 RSI: 00007ffc476e1410 RDI: 0000000000000005 [ 50.179832][ T1075] RBP: 00007ffc476e1370 R08: 0000000000000000 R09: 0000000000000000 [ 50.179833][ T1075] R10: 0000000000000000 R11: 0000000000000202 R12: 000000006a91af90 [ 50.179834][ T1075] R13: 00000000004a1620 R14: 0000000000000000 R15: 00007ffc476e1ae0 [ 50.179841][ T1075] [ 50.224728][ T1075] br0: port 1(veth1) entered disabled state [ 50.225060][ T1075] veth1: entered allmulticast mode [ 50.226143][ T1075] veth1: entered promiscuous mode [ 50.444306][ T1080] br0: port 2(veth_segment) entered blocking state [ 50.444654][ T1080] br0: port 2(veth_segment) entered disabled state [ 50.444981][ T1080] veth_segment: entered allmulticast mode [ 50.446077][ T1080] veth_segment: entered promiscuous mode [ 50.479034][ T1081] br0: port 2(veth_segment) entered blocking state [ 50.479356][ T1081] br0: port 2(veth_segment) entered forwarding state [ 50.480168][ T1081] br0: port 1(veth1) entered blocking state [ 50.480460][ T1081] br0: port 1(veth1) entered forwarding state [ 52.780525][ T1094] iperf3 (1094) used greatest stack depth: 20816 bytes left [ 52.780547][ T1094] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 52.780549][ T1094] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 1094, name: iperf3 [ 52.780550][ T1094] preempt_count: 2, expected: 0 [ 52.780551][ T1094] RCU nest depth: 0, expected: 0 [ 52.780552][ T1094] locks held by iperf3/1094: 5, last CPU#1: [ 52.780554][ T1094] #0: ffffffff9d8167b8 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x887/0xdc0 [ 52.780566][ T1094] #1: ffffffff9d97ddc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 52.780571][ T1094] #2: ffffffff9d97de38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 52.780575][ T1094] #3: ffffffff9d89d760 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 52.780579][ T1094] #4: ffffffff9d89d660 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 52.780583][ T1094] irq event stamp: 1330832 [ 52.780584][ T1094] hardirqs last enabled at (1330831): [] __down_trylock_console_sem+0x86/0xa0 [ 52.780588][ T1094] hardirqs last disabled at (1330832): [] console_emit_next_record+0x3d4/0x4c0 [ 52.780590][ T1094] softirqs last enabled at (1330712): [] fpu__clear_user_states+0x104/0x290 [ 52.780594][ T1094] softirqs last disabled at (1330710): [] fpu__clear_user_states+0x6d/0x290 [ 52.780596][ T1094] Preemption disabled at: [ 52.780596][ T1094] [<0000000000000000>] 0x0 [ 52.780603][ T1094] CPU: 1 UID: 0 PID: 1094 Comm: iperf3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 52.780607][ T1094] Tainted: [W]=WARN [ 52.780608][ T1094] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 52.780610][ T1094] Call Trace: [ 52.780611][ T1094] [ 52.780613][ T1094] dump_stack_lvl+0x6f/0xa0 [ 52.780619][ T1094] __might_resched.cold+0x1fe/0x2c1 [ 52.780624][ T1094] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 52.780627][ T1094] ? __kmalloc_noprof+0xdb/0x760 [ 52.780632][ T1094] __kmalloc_noprof+0x443/0x760 [ 52.780634][ T1094] ? alloc_buf.isra.0+0x4b/0x260 [ 52.780640][ T1094] ? do_raw_spin_unlock+0x59/0x250 [ 52.780643][ T1094] alloc_buf.isra.0+0x4b/0x260 [ 52.780647][ T1094] put_chars+0x1e1/0x2f0 [ 52.780649][ T1094] ? prb_final_commit+0x50/0x50 [ 52.780651][ T1094] ? __send_to_port+0x420/0x420 [ 52.780654][ T1094] ? rcu_lockdep_current_cpu_online+0x3f/0x1b0 [ 52.780657][ T1094] ? rcu_read_lock_any_held+0x3c/0x90 [ 52.780660][ T1094] ? validate_chain+0x38b/0xc20 [ 52.780664][ T1094] hvc_console_print+0x292/0x780 [ 52.780668][ T1094] ? mark_usage+0x61/0x170 [ 52.780670][ T1094] ? __lock_acquire+0x518/0xc20 [ 52.780671][ T1094] ? __lock_acquire+0x518/0xc20 [ 52.780675][ T1094] ? hvc_write+0x3a0/0x3a0 [ 52.780678][ T1094] ? console_emit_next_record+0x1df/0x4c0 [ 52.780681][ T1094] ? rcu_is_watching+0x16/0xd0 [ 52.780683][ T1094] ? lock_acquire+0x13c/0x160 [ 52.780687][ T1094] console_emit_next_record+0x22f/0x4c0 [ 52.780691][ T1094] ? devkmsg_read+0x4b0/0x4b0 [ 52.780693][ T1094] ? console_flush_one_record+0x106/0x710 [ 52.780696][ T1094] ? rcu_is_watching+0x16/0xd0 [ 52.780698][ T1094] ? lock_acquire+0x13c/0x160 [ 52.780702][ T1094] console_flush_one_record+0x46f/0x710 [ 52.780706][ T1094] ? console_emit_next_record+0x4c0/0x4c0 [ 52.780708][ T1094] ? __lock_acquire+0x518/0xc20 [ 52.780713][ T1094] console_unlock+0xee/0x1f0 [ 52.780716][ T1094] ? console_flush_one_record+0x710/0x710 [ 52.780717][ T1094] ? rcu_is_watching+0x16/0xd0 [ 52.780719][ T1094] ? lock_acquire+0xe0/0x160 [ 52.780723][ T1094] ? __down_trylock_console_sem+0x5e/0xa0 [ 52.780724][ T1094] ? vprintk_emit+0x320/0x3e0 [ 52.780727][ T1094] vprintk_emit+0x37c/0x3e0 [ 52.780730][ T1094] ? wake_up_klogd_work_func+0x90/0x90 [ 52.780731][ T1094] ? do_raw_spin_unlock+0x59/0x250 [ 52.780734][ T1094] ? __lock_acquire+0x518/0xc20 [ 52.780738][ T1094] _printk+0xc7/0x100 [ 52.780742][ T1094] ? snapshot_read.cold+0x21/0x21 [ 52.780745][ T1094] ? do_raw_spin_lock+0x131/0x280 [ 52.780747][ T1094] ? __rwlock_init+0x150/0x150 [ 52.780751][ T1094] ? do_raw_spin_lock+0x131/0x280 [ 52.780754][ T1094] do_exit.cold+0x82/0x9c [ 52.780758][ T1094] ? exit_notify+0x890/0x890 [ 52.780763][ T1094] __x64_sys_exit+0x42/0x50 [ 52.780765][ T1094] x64_sys_call+0x156c/0x1570 [ 52.780767][ T1094] do_syscall_64+0xff/0x530 [ 52.780771][ T1094] ? exc_page_fault+0xee/0x100 [ 52.780774][ T1094] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 52.780776][ T1094] RIP: 0033:0x7f955ee89c49 [ 52.780778][ T1094] Code: Unable to access opcode bytes at 0x7f955ee89c1f. [ 52.780779][ T1094] RSP: 002b:00007f955e648e60 EFLAGS: 00000246 ORIG_RAX: 000000000000003c [ 52.780782][ T1094] RAX: ffffffffffffffda RBX: 00007f955e6496c0 RCX: 00007f955ee89c49 [ 52.780783][ T1094] RDX: 0000000000000000 RSI: 0000000000801000 RDI: 0000000000000000 [ 52.780784][ T1094] RBP: 00007f955e648f70 R08: 0000000000000001 R09: 00007f955e6496c0 [ 52.780785][ T1094] R10: 0000000000000008 R11: 0000000000000246 R12: 00007f955de49000 [ 52.780786][ T1094] R13: 00007ffff73159b0 R14: 0000000000000002 R15: 00007ffff7315ab7 [ 52.780793][ T1094] [ 52.919123][ T12] br0: port 1(veth1) entered disabled state [ 52.931679][ T12] veth1 (unregistering): left allmulticast mode [ 52.931962][ T12] veth1 (unregistering): left promiscuous mode [ 52.932220][ T12] br0: port 1(veth1) entered disabled state [ 52.962104][ T12] veth_segment: left allmulticast mode [ 52.962411][ T12] veth_segment: left promiscuous mode [ 52.962700][ T12] br0: port 2(veth_segment) entered disabled state