[ 8.604332][ T138] rpm (138) used greatest stack depth: 24760 bytes left [ 8.604361][ T138] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 8.604363][ T138] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 138, name: rpm [ 8.604364][ T138] preempt_count: 2, expected: 0 [ 8.604365][ T138] RCU nest depth: 0, expected: 0 [ 8.604366][ T138] locks held by rpm/138: 5, last CPU#1: [ 8.604368][ T138] #0: ffffffff8dc02f58 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x8e7/0xef0 [ 8.604380][ T138] #1: ffffffff8dd6a440 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 8.604385][ T138] #2: ffffffff8dd6a4b8 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 8.604388][ T138] #3: ffffffff8dc89de0 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 8.604391][ T138] #4: ffffffff8dc89ce0 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 8.604395][ T138] irq event stamp: 80082 [ 8.604396][ T138] hardirqs last enabled at (80081): [] __down_trylock_console_sem+0x86/0xa0 [ 8.604399][ T138] hardirqs last disabled at (80082): [] console_emit_next_record+0x3d4/0x4c0 [ 8.604401][ T138] softirqs last enabled at (79350): [] handle_softirqs+0x67c/0x900 [ 8.604403][ T138] softirqs last disabled at (78135): [] __irq_exit_rcu+0x145/0x1c0 [ 8.604405][ T138] Preemption disabled at: [ 8.604406][ T138] [<0000000000000000>] 0x0 [ 8.604413][ T138] CPU: 1 UID: 0 PID: 138 Comm: rpm Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.604416][ T138] Tainted: [W]=WARN [ 8.604417][ T138] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.604419][ T138] Call Trace: [ 8.604420][ T138] [ 8.604422][ T138] dump_stack_lvl+0x6f/0xa0 [ 8.604427][ T138] __might_resched.cold+0x1fe/0x2c1 [ 8.604431][ T138] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 8.604434][ T138] ? __kmalloc_noprof+0xdb/0x760 [ 8.604439][ T138] __kmalloc_noprof+0x443/0x760 [ 8.604442][ T138] ? alloc_buf.isra.0+0x4b/0x260 [ 8.604448][ T138] ? do_raw_spin_unlock+0x59/0x250 [ 8.604451][ T138] alloc_buf.isra.0+0x4b/0x260 [ 8.604454][ T138] put_chars+0x1e1/0x2f0 [ 8.604457][ T138] ? __send_to_port+0x420/0x420 [ 8.604463][ T138] hvc_console_print+0x292/0x780 [ 8.604470][ T138] ? hvc_write+0x3a0/0x3a0 [ 8.604472][ T138] ? lock_acquire+0x13c/0x160 [ 8.604477][ T138] console_emit_next_record+0x22f/0x4c0 [ 8.604480][ T138] ? devkmsg_read+0x4b0/0x4b0 [ 8.604482][ T138] ? console_flush_one_record+0x106/0x710 [ 8.604484][ T138] ? rcu_is_watching+0x16/0xd0 [ 8.604488][ T138] ? lock_acquire+0x13c/0x160 [ 8.604492][ T138] console_flush_one_record+0x46f/0x710 [ 8.604495][ T138] ? console_emit_next_record+0x4c0/0x4c0 [ 8.604496][ T138] ? __lock_acquire+0x518/0xc20 [ 8.604507][ T138] console_unlock+0xee/0x1f0 [ 8.604509][ T138] ? console_flush_one_record+0x710/0x710 [ 8.604511][ T138] ? rcu_is_watching+0x16/0xd0 [ 8.604513][ T138] ? lock_acquire+0x60/0x160 [ 8.604516][ T138] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.604518][ T138] ? vprintk_emit+0x320/0x3e0 [ 8.604521][ T138] vprintk_emit+0x37c/0x3e0 [ 8.604524][ T138] ? wake_up_klogd_work_func+0x90/0x90 [ 8.604527][ T138] ? __lock_acquire+0x518/0xc20 [ 8.604531][ T138] _printk+0xc7/0x100 [ 8.604534][ T138] ? snapshot_read.cold+0x21/0x21 [ 8.604537][ T138] ? do_raw_spin_lock+0x131/0x280 [ 8.604540][ T138] ? __rwlock_init+0x150/0x150 [ 8.604544][ T138] ? do_raw_spin_lock+0x131/0x280 [ 8.604547][ T138] do_exit.cold+0x82/0x9c [ 8.604550][ T138] ? exit_notify+0x890/0x890 [ 8.604552][ T138] ? __lock_release.isra.0+0x69/0x1a0 [ 8.604555][ T138] ? rcu_is_watching+0x16/0xd0 [ 8.604558][ T138] do_group_exit+0xb8/0x370 [ 8.604561][ T138] __x64_sys_exit_group+0x3c/0x50 [ 8.604563][ T138] x64_sys_call+0x1567/0x1570 [ 8.604566][ T138] do_syscall_64+0x10e/0x570 [ 8.604569][ T138] ? exc_page_fault+0xee/0x100 [ 8.604572][ T138] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.604574][ T138] RIP: 0033:0x7f1d398901b8 [ 8.604577][ T138] Code: Unable to access opcode bytes at 0x7f1d3989018e. [ 8.604578][ T138] RSP: 002b:00007fff4215ee48 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 8.604580][ T138] RAX: ffffffffffffffda RBX: 00007f1d399c0f88 RCX: 00007f1d398901b8 [ 8.604581][ T138] RDX: 00007f1d388cbb08 RSI: ffffffffffffff98 RDI: 0000000000000000 [ 8.604582][ T138] RBP: 00007fff4215eea0 R08: 0000000000000000 R09: 00000000000000a0 [ 8.604583][ T138] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000000000b [ 8.604584][ T138] R13: 0000000000000000 R14: 00007f1d399bf680 R15: 00007f1d399c0fa0 [ 8.604590][ T138] [ 9.036219][ T175] tun: Universal TUN/TAP device driver, 1.6 [ 10.048091][ T186] packetdrill (186) used greatest stack depth: 24456 bytes left [ 10.048105][ T186] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.048107][ T186] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 186, name: packetdrill [ 10.048108][ T186] preempt_count: 2, expected: 0 [ 10.048109][ T186] RCU nest depth: 0, expected: 0 [ 10.048110][ T186] locks held by packetdrill/186: 5, last CPU#0: [ 10.048112][ T186] #0: ffffffff8dc02f58 (low_water_lock){+.+.}-{3:3}, at: do_exit+0x8e7/0xef0 [ 10.048123][ T186] #1: ffffffff8dd6a440 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 10.048128][ T186] #2: ffffffff8dd6a4b8 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 10.048131][ T186] #3: ffffffff8dc89de0 (console_owner){....}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 10.048135][ T186] #4: ffffffff8dc89ce0 (printk_legacy_map-wait-type-override){....}-{3:3}, at: console_emit_next_record+0x1df/0x4c0 [ 10.048138][ T186] irq event stamp: 4243308 [ 10.048138][ T186] hardirqs last enabled at (4243307): [] __down_trylock_console_sem+0x86/0xa0 [ 10.048142][ T186] hardirqs last disabled at (4243308): [] console_emit_next_record+0x3d4/0x4c0 [ 10.048143][ T186] softirqs last enabled at (4243084): [] tcp_close+0x2b/0xb0 [ 10.048147][ T186] softirqs last disabled at (4243082): [] release_sock+0x21/0x240 [ 10.048150][ T186] Preemption disabled at: [ 10.048151][ T186] [<0000000000000000>] 0x0 [ 10.048157][ T186] CPU: 0 UID: 0 PID: 186 Comm: packetdrill Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.048161][ T186] Tainted: [W]=WARN [ 10.048162][ T186] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.048163][ T186] Call Trace: [ 10.048165][ T186] [ 10.048166][ T186] dump_stack_lvl+0x6f/0xa0 [ 10.048171][ T186] __might_resched.cold+0x1fe/0x2c1 [ 10.048176][ T186] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.048179][ T186] ? __kmalloc_noprof+0xdb/0x760 [ 10.048184][ T186] __kmalloc_noprof+0x443/0x760 [ 10.048186][ T186] ? alloc_buf.isra.0+0x4b/0x260 [ 10.048192][ T186] ? do_raw_spin_unlock+0x59/0x250 [ 10.048195][ T186] alloc_buf.isra.0+0x4b/0x260 [ 10.048198][ T186] put_chars+0x1e1/0x2f0 [ 10.048201][ T186] ? __send_to_port+0x420/0x420 [ 10.048207][ T186] hvc_console_print+0x292/0x780 [ 10.048214][ T186] ? hvc_write+0x3a0/0x3a0 [ 10.048217][ T186] ? lock_acquire+0x13c/0x160 [ 10.048221][ T186] console_emit_next_record+0x22f/0x4c0 [ 10.048224][ T186] ? devkmsg_read+0x4b0/0x4b0 [ 10.048226][ T186] ? console_flush_one_record+0x106/0x710 [ 10.048228][ T186] ? rcu_is_watching+0x16/0xd0 [ 10.048231][ T186] ? lock_acquire+0x13c/0x160 [ 10.048235][ T186] console_flush_one_record+0x46f/0x710 [ 10.048239][ T186] ? console_emit_next_record+0x4c0/0x4c0 [ 10.048240][ T186] ? __lock_acquire+0x518/0xc20 [ 10.048245][ T186] console_unlock+0xee/0x1f0 [ 10.048248][ T186] ? console_flush_one_record+0x710/0x710 [ 10.048249][ T186] ? rcu_is_watching+0x16/0xd0 [ 10.048250][ T186] ? lock_acquire+0x60/0x160 [ 10.048254][ T186] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.048256][ T186] ? vprintk_emit+0x320/0x3e0 [ 10.048259][ T186] vprintk_emit+0x37c/0x3e0 [ 10.048262][ T186] ? wake_up_klogd_work_func+0x90/0x90 [ 10.048265][ T186] ? __lock_acquire+0x518/0xc20 [ 10.048268][ T186] _printk+0xc7/0x100 [ 10.048272][ T186] ? snapshot_read.cold+0x21/0x21 [ 10.048275][ T186] ? do_raw_spin_lock+0x131/0x280 [ 10.048277][ T186] ? __rwlock_init+0x150/0x150 [ 10.048281][ T186] ? do_raw_spin_lock+0x131/0x280 [ 10.048284][ T186] do_exit.cold+0x82/0x9c [ 10.048288][ T186] ? exit_notify+0x890/0x890 [ 10.048289][ T186] ? __lock_release.isra.0+0x69/0x1a0 [ 10.048292][ T186] ? rcu_is_watching+0x16/0xd0 [ 10.048296][ T186] do_group_exit+0xb8/0x370 [ 10.048299][ T186] __x64_sys_exit_group+0x3c/0x50 [ 10.048301][ T186] x64_sys_call+0x1567/0x1570 [ 10.048303][ T186] do_syscall_64+0x10e/0x570 [ 10.048307][ T186] ? irq_exit_rcu+0x1a/0x30 [ 10.048310][ T186] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 10.048312][ T186] RIP: 0033:0x479678 [ 10.048314][ T186] Code: Unable to access opcode bytes at 0x47964e. [ 10.048315][ T186] RSP: 002b:00007ffe1849e948 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 [ 10.048317][ T186] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 0000000000479678 [ 10.048318][ T186] RDX: 0000000019f0a708 RSI: fffffffffffffff0 RDI: 0000000000000000 [ 10.048319][ T186] RBP: 00007ffe1849e9a0 R08: 0000000000000000 R09: 0000000019f0b450 [ 10.048320][ T186] R10: 0000000000000110 R11: 0000000000000246 R12: 00007ffe1849ead8 [ 10.048321][ T186] R13: 00007ffe1849eb18 R14: 0000000000000000 R15: 000000000054d560 [ 10.048328][ T186] [ 10.674316][ T212] packetdrill (212) used greatest stack depth: 23552 bytes left