[ 9.696253][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.696279][ C2] [ 9.696280][ C2] ======================================================== [ 9.696281][ C2] WARNING: possible irq lock inversion dependency detected [ 9.696283][ C2] 7.2.0-virtme #1 Tainted: G W [ 9.696284][ C2] -------------------------------------------------------- [ 9.696285][ C2] connect-deny_ip/170 just changed the state of lock: [ 9.696286][ C2] ffffffff86e99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.696299][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 9.696300][ C2] (fs_reclaim){+.+.}-{0:0} [ 9.696302][ C2] [ 9.696302][ C2] [ 9.696302][ C2] and interrupts could create inverse lock ordering between them. [ 9.696302][ C2] [ 9.696302][ C2] [ 9.696302][ C2] other info that might help us debug this: [ 9.696303][ C2] Possible interrupt unsafe locking scenario: [ 9.696303][ C2] [ 9.696304][ C2] CPU0 CPU1 [ 9.696304][ C2] ---- ---- [ 9.696304][ C2] lock(fs_reclaim); [ 9.696305][ C2] local_irq_disable(); [ 9.696306][ C2] lock(console_owner); [ 9.696307][ C2] lock(fs_reclaim); [ 9.696308][ C2] [ 9.696308][ C2] lock(console_owner); [ 9.696309][ C2] [ 9.696309][ C2] *** DEADLOCK *** [ 9.696309][ C2] [ 9.696309][ C2] locks held by connect-deny_ip/170: 9, last CPU#2: [ 9.696310][ C2] #0: ff11000016581d90 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 9.696316][ C2] #1: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 9.696320][ C2] #2: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 9.696323][ C2] #3: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 9.696326][ C2] #4: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 9.696331][ C2] #5: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 9.696334][ C2] #6: ffffffff86f90b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 9.696339][ C2] #7: ffffffff86f79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.696342][ C2] #8: ffffffff86f79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.696345][ C2] [ 9.696345][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 9.696350][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 9.696352][ C2] HARDIRQ-ON-W at: [ 9.696354][ C2] __lock_acquire+0x388/0xc20 [ 9.696357][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696358][ C2] fs_reclaim_acquire+0xd5/0x120 [ 9.696361][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 9.696363][ C2] kthread_create_worker_on_node+0xea/0x210 [ 9.696366][ C2] workqueue_init+0x2a/0x680 [ 9.696369][ C2] kernel_init_freeable+0x2fe/0x630 [ 9.696372][ C2] kernel_init+0x21/0x150 [ 9.696375][ C2] ret_from_fork+0x474/0x6b0 [ 9.696378][ C2] ret_from_fork_asm+0x11/0x20 [ 9.696381][ C2] SOFTIRQ-ON-W at: [ 9.696381][ C2] __lock_acquire+0x388/0xc20 [ 9.696383][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696384][ C2] fs_reclaim_acquire+0xd5/0x120 [ 9.696385][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 9.696387][ C2] kthread_create_worker_on_node+0xea/0x210 [ 9.696388][ C2] workqueue_init+0x2a/0x680 [ 9.696389][ C2] kernel_init_freeable+0x2fe/0x630 [ 9.696391][ C2] kernel_init+0x21/0x150 [ 9.696392][ C2] ret_from_fork+0x474/0x6b0 [ 9.696393][ C2] ret_from_fork_asm+0x11/0x20 [ 9.696394][ C2] INITIAL USE at: [ 9.696395][ C2] __lock_acquire+0x388/0xc20 [ 9.696396][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696398][ C2] fs_reclaim_acquire+0xd5/0x120 [ 9.696399][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 9.696400][ C2] kthread_create_worker_on_node+0xea/0x210 [ 9.696402][ C2] workqueue_init+0x2a/0x680 [ 9.696403][ C2] kernel_init_freeable+0x2fe/0x630 [ 9.696404][ C2] kernel_init+0x21/0x150 [ 9.696406][ C2] ret_from_fork+0x474/0x6b0 [ 9.696407][ C2] ret_from_fork_asm+0x11/0x20 [ 9.696408][ C2] } [ 9.696408][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 9.696412][ C2] ... acquired at: [ 9.696413][ C2] __lock_acquire+0x518/0xc20 [ 9.696415][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696416][ C2] fs_reclaim_acquire+0xd5/0x120 [ 9.696417][ C2] __kmalloc_noprof+0xd3/0x760 [ 9.696418][ C2] alloc_buf.isra.0+0x4b/0x260 [ 9.696421][ C2] put_chars+0x1e1/0x2f0 [ 9.696423][ C2] hvc_console_print+0x292/0x780 [ 9.696425][ C2] console_emit_next_record+0x22f/0x4c0 [ 9.696427][ C2] console_flush_one_record+0x46f/0x710 [ 9.696429][ C2] console_unlock+0xee/0x1f0 [ 9.696430][ C2] vprintk_emit+0x37c/0x3e0 [ 9.696432][ C2] dev_vprintk_emit+0x27f/0x2c0 [ 9.696436][ C2] dev_printk_emit+0xb9/0xee [ 9.696437][ C2] _dev_info+0xe2/0x116 [ 9.696439][ C2] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 9.696441][ C2] cmos_do_probe+0x73b/0x98a [ 9.696442][ C2] platform_probe+0xfe/0x1f0 [ 9.696445][ C2] call_driver_probe+0x61/0x1c0 [ 9.696448][ C2] really_probe+0x199/0x760 [ 9.696449][ C2] __driver_probe_device+0x24f/0x440 [ 9.696451][ C2] driver_probe_device+0x4a/0xf0 [ 9.696452][ C2] __driver_attach+0x1b8/0x540 [ 9.696454][ C2] bus_for_each_dev+0x130/0x1e0 [ 9.696455][ C2] bus_add_driver+0x2c8/0x530 [ 9.696456][ C2] driver_register+0x1a3/0x390 [ 9.696458][ C2] __platform_driver_probe+0x13f/0x270 [ 9.696459][ C2] cmos_init+0x31/0x40 [ 9.696462][ C2] do_one_initcall+0x124/0x4f0 [ 9.696464][ C2] kernel_init_freeable+0x596/0x630 [ 9.696465][ C2] kernel_init+0x21/0x150 [ 9.696466][ C2] ret_from_fork+0x474/0x6b0 [ 9.696467][ C2] ret_from_fork_asm+0x11/0x20 [ 9.696469][ C2] [ 9.696469][ C2] -> (console_owner){..-.}-{0:0} { [ 9.696471][ C2] IN-SOFTIRQ-W at: [ 9.696472][ C2] __lock_acquire+0x388/0xc20 [ 9.696473][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696475][ C2] console_lock_spinning_enable+0x5c/0x60 [ 9.696476][ C2] console_emit_next_record+0x1d1/0x4c0 [ 9.696478][ C2] console_flush_one_record+0x46f/0x710 [ 9.696479][ C2] console_unlock+0xee/0x1f0 [ 9.696481][ C2] vprintk_emit+0x37c/0x3e0 [ 9.696482][ C2] _printk+0xc7/0x100 [ 9.696485][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.696488][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.696490][ C2] tcp_conn_request+0x1f15/0x2d20 [ 9.696492][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.696494][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.696495][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 9.696497][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 9.696498][ C2] ip_local_deliver_finish+0x36f/0x610 [ 9.696499][ C2] ip_local_deliver+0x184/0x4c0 [ 9.696501][ C2] ip_rcv+0xdc/0x3d0 [ 9.696502][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 9.696504][ C2] process_backlog+0x431/0x14c0 [ 9.696506][ C2] __napi_poll+0xa7/0x3b0 [ 9.696507][ C2] net_rx_action+0x513/0xf50 [ 9.696509][ C2] handle_softirqs+0x1d3/0x900 [ 9.696512][ C2] do_softirq+0xac/0xe0 [ 9.696513][ C2] __local_bh_enable_ip+0x118/0x150 [ 9.696514][ C2] __dev_queue_xmit+0x979/0x1b80 [ 9.696516][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 9.696517][ C2] ip_output+0x1ca/0x660 [ 9.696519][ C2] __ip_queue_xmit+0x774/0x1650 [ 9.696520][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.696522][ C2] tcp_connect+0x1024/0x1e20 [ 9.696523][ C2] tcp_v4_connect+0x12bd/0x1960 [ 9.696524][ C2] __inet_stream_connect+0x2ed/0xd00 [ 9.696525][ C2] inet_stream_connect+0x59/0xb0 [ 9.696527][ C2] __sys_connect+0x1cf/0x2e0 [ 9.696529][ C2] __x64_sys_connect+0x72/0xd0 [ 9.696531][ C2] do_syscall_64+0xff/0x530 [ 9.696534][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.696536][ C2] INITIAL USE at: [ 9.696537][ C2] } [ 9.696537][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 9.696541][ C2] ... acquired at: [ 9.696541][ C2] mark_lock+0x1d7/0xa00 [ 9.696543][ C2] mark_usage+0x42/0x170 [ 9.696544][ C2] __lock_acquire+0x388/0xc20 [ 9.696545][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696547][ C2] console_lock_spinning_enable+0x5c/0x60 [ 9.696548][ C2] console_emit_next_record+0x1d1/0x4c0 [ 9.696550][ C2] console_flush_one_record+0x46f/0x710 [ 9.696551][ C2] console_unlock+0xee/0x1f0 [ 9.696553][ C2] vprintk_emit+0x37c/0x3e0 [ 9.696554][ C2] _printk+0xc7/0x100 [ 9.696556][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.696557][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.696558][ C2] tcp_conn_request+0x1f15/0x2d20 [ 9.696560][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.696562][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.696563][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 9.696565][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 9.696566][ C2] ip_local_deliver_finish+0x36f/0x610 [ 9.696567][ C2] ip_local_deliver+0x184/0x4c0 [ 9.696568][ C2] ip_rcv+0xdc/0x3d0 [ 9.696570][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 9.696571][ C2] process_backlog+0x431/0x14c0 [ 9.696573][ C2] __napi_poll+0xa7/0x3b0 [ 9.696575][ C2] net_rx_action+0x513/0xf50 [ 9.696577][ C2] handle_softirqs+0x1d3/0x900 [ 9.696578][ C2] do_softirq+0xac/0xe0 [ 9.696579][ C2] __local_bh_enable_ip+0x118/0x150 [ 9.696580][ C2] __dev_queue_xmit+0x979/0x1b80 [ 9.696582][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 9.696583][ C2] ip_output+0x1ca/0x660 [ 9.696585][ C2] __ip_queue_xmit+0x774/0x1650 [ 9.696586][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.696587][ C2] tcp_connect+0x1024/0x1e20 [ 9.696588][ C2] tcp_v4_connect+0x12bd/0x1960 [ 9.696590][ C2] __inet_stream_connect+0x2ed/0xd00 [ 9.696591][ C2] inet_stream_connect+0x59/0xb0 [ 9.696592][ C2] __sys_connect+0x1cf/0x2e0 [ 9.696594][ C2] __x64_sys_connect+0x72/0xd0 [ 9.696595][ C2] do_syscall_64+0xff/0x530 [ 9.696596][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.696597][ C2] [ 9.696598][ C2] [ 9.696598][ C2] stack backtrace: [ 9.696601][ C2] CPU: 2 UID: 0 PID: 170 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.696604][ C2] Tainted: [W]=WARN [ 9.696605][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.696607][ C2] Call Trace: [ 9.696608][ C2] [ 9.696609][ C2] dump_stack_lvl+0x6f/0xa0 [ 9.696613][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 9.696616][ C2] mark_lock_irq+0x989/0x9c0 [ 9.696619][ C2] mark_lock+0x1d7/0xa00 [ 9.696621][ C2] mark_usage+0x42/0x170 [ 9.696622][ C2] __lock_acquire+0x388/0xc20 [ 9.696624][ C2] lock_acquire.part.0+0xd4/0x280 [ 9.696626][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 9.696628][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696632][ C2] ? lock_acquire+0x13c/0x160 [ 9.696633][ C2] console_lock_spinning_enable+0x5c/0x60 [ 9.696635][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 9.696637][ C2] console_emit_next_record+0x1d1/0x4c0 [ 9.696639][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 9.696640][ C2] ? console_flush_one_record+0x106/0x710 [ 9.696642][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696644][ C2] ? lock_acquire+0x13c/0x160 [ 9.696646][ C2] console_flush_one_record+0x46f/0x710 [ 9.696648][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 9.696650][ C2] ? __lock_acquire+0x518/0xc20 [ 9.696652][ C2] console_unlock+0xee/0x1f0 [ 9.696654][ C2] ? console_flush_one_record+0x710/0x710 [ 9.696655][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696657][ C2] ? lock_acquire+0x60/0x160 [ 9.696659][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.696661][ C2] ? vprintk_emit+0x320/0x3e0 [ 9.696662][ C2] vprintk_emit+0x37c/0x3e0 [ 9.696664][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 9.696666][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.696669][ C2] _printk+0xc7/0x100 [ 9.696670][ C2] ? snapshot_read.cold+0x21/0x21 [ 9.696672][ C2] ? ___ratelimit+0x4e7/0xa00 [ 9.696675][ C2] ? idr_get_free+0x830/0x830 [ 9.696677][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.696679][ C2] ? tcp_send_synack+0x1570/0x1570 [ 9.696680][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 9.696682][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 9.696685][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.696687][ C2] ? add_timer_on+0x580/0x580 [ 9.696690][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.696692][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.696694][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 9.696697][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 9.696699][ C2] ? inet_csk_route_req+0x747/0xc30 [ 9.696701][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 9.696702][ C2] tcp_conn_request+0x1f15/0x2d20 [ 9.696704][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.696708][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.696710][ C2] ? __lock_acquire+0x518/0xc20 [ 9.696712][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.696714][ C2] ? __lock_acquire+0x518/0xc20 [ 9.696715][ C2] ? down_read_nested+0xe7/0x500 [ 9.696718][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696720][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.696722][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.696724][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.696726][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 9.696727][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 9.696730][ C2] ? mark_usage+0x61/0x170 [ 9.696731][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 9.696734][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.696735][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 9.696738][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 9.696740][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.696741][ C2] ip_local_deliver_finish+0x36f/0x610 [ 9.696743][ C2] ip_local_deliver+0x184/0x4c0 [ 9.696745][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 9.696746][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 9.696749][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.696751][ C2] ip_rcv+0xdc/0x3d0 [ 9.696752][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 9.696754][ C2] ? mark_usage+0x61/0x170 [ 9.696755][ C2] ? __lock_acquire+0x518/0xc20 [ 9.696757][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 9.696759][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.696761][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.696763][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.696765][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696767][ C2] process_backlog+0x431/0x14c0 [ 9.696770][ C2] __napi_poll+0xa7/0x3b0 [ 9.696772][ C2] net_rx_action+0x513/0xf50 [ 9.696775][ C2] ? __napi_poll+0x3b0/0x3b0 [ 9.696777][ C2] ? find_held_lock+0x2b/0x80 [ 9.696780][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696781][ C2] ? mark_held_locks+0x40/0x70 [ 9.696783][ C2] handle_softirqs+0x1d3/0x900 [ 9.696785][ C2] ? _local_bh_enable+0xc0/0xc0 [ 9.696786][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696788][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 9.696791][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 9.696793][ C2] do_softirq+0xac/0xe0 [ 9.696795][ C2] [ 9.696795][ C2] [ 9.696796][ C2] __local_bh_enable_ip+0x118/0x150 [ 9.696797][ C2] __dev_queue_xmit+0x979/0x1b80 [ 9.696799][ C2] ? __asan_memcpy+0x3c/0x60 [ 9.696802][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.696804][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.696805][ C2] ? find_held_lock+0x2b/0x80 [ 9.696807][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.696808][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696810][ C2] ? mark_held_locks+0x40/0x70 [ 9.696812][ C2] ? __asan_memcpy+0x3c/0x60 [ 9.696813][ C2] ? neigh_hh_output+0x152/0x4c0 [ 9.696815][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 9.696817][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 9.696819][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.696820][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 9.696823][ C2] ip_output+0x1ca/0x660 [ 9.696824][ C2] ? ip_finish_output+0x460/0x460 [ 9.696826][ C2] ? find_held_lock+0x2b/0x80 [ 9.696827][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.696829][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 9.696831][ C2] __ip_queue_xmit+0x774/0x1650 [ 9.696834][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.696836][ C2] ? __tcp_select_window+0xf20/0xf20 [ 9.696838][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.696840][ C2] ? ktime_get+0x18e/0x2d0 [ 9.696842][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 9.696845][ C2] ? ktime_get+0x1dd/0x2d0 [ 9.696847][ C2] tcp_connect+0x1024/0x1e20 [ 9.696849][ C2] tcp_v4_connect+0x12bd/0x1960 [ 9.696851][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 9.696853][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.696855][ C2] ? find_held_lock+0x2b/0x80 [ 9.696856][ C2] __inet_stream_connect+0x2ed/0xd00 [ 9.696858][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.696859][ C2] inet_stream_connect+0x59/0xb0 [ 9.696861][ C2] __sys_connect+0x1cf/0x2e0 [ 9.696863][ C2] ? do_fcntl+0x36f/0xc50 [ 9.696865][ C2] ? __sys_connect_file+0x250/0x250 [ 9.696868][ C2] ? fput+0x1f/0xa0 [ 9.696871][ C2] __x64_sys_connect+0x72/0xd0 [ 9.696872][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.696873][ C2] ? do_syscall_64+0xa6/0x530 [ 9.696875][ C2] do_syscall_64+0xff/0x530 [ 9.696876][ C2] ? irq_exit_rcu+0x1a/0x30 [ 9.696878][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.696879][ C2] RIP: 0033:0x7fae01a24312 [ 9.696882][ C2] Code: 08 0f 85 71 41 ff ff 49 89 fb 48 89 f0 48 89 d7 48 89 ce 4c 89 c2 4d 89 ca 4c 8b 44 24 08 4c 8b 4c 24 10 4c 89 5c 24 08 0f 05 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f 1e fa 55 bf 01 00 [ 9.696884][ C2] RSP: 002b:00007fae011a1988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.696887][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007fae01a24312 [ 9.696888][ C2] RDX: 0000000000000010 RSI: 00007fae011a1c40 RDI: 000000000000000a [ 9.696889][ C2] RBP: 00007fae011a19b0 R08: 0000000000000000 R09: 0000000000000000 [ 9.696890][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fae011a1c40 [ 9.696891][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 9.696893][ C2] [ 9.696897][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.696898][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 170, name: connect-deny_ip [ 9.696900][ C2] preempt_count: 302, expected: 0 [ 9.696900][ C2] RCU nest depth: 6, expected: 0 [ 9.696901][ C2] INFO: lockdep is turned off. [ 9.696902][ C2] irq event stamp: 17621 [ 9.696902][ C2] hardirqs last enabled at (17620): [] __down_trylock_console_sem+0x86/0xa0 [ 9.696905][ C2] hardirqs last disabled at (17621): [] console_emit_next_record+0x3d4/0x4c0 [ 9.696907][ C2] softirqs last enabled at (17450): [] __dev_queue_xmit+0x964/0x1b80 [ 9.696909][ C2] softirqs last disabled at (17451): [] do_softirq+0xac/0xe0 [ 9.696910][ C2] Preemption disabled at: [ 9.696911][ C2] [] __dev_queue_xmit+0x204/0x1b80 [ 9.696921][ C2] CPU: 2 UID: 0 PID: 170 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.696925][ C2] Tainted: [W]=WARN [ 9.696926][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.696927][ C2] Call Trace: [ 9.696927][ C2] [ 9.696928][ C2] dump_stack_lvl+0x6f/0xa0 [ 9.696930][ C2] ? __dev_queue_xmit+0x204/0x1b80 [ 9.696932][ C2] __might_resched.cold+0x1fe/0x2c1 [ 9.696935][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.696938][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696940][ C2] __kmalloc_noprof+0x443/0x760 [ 9.696942][ C2] ? __rwlock_init+0x150/0x150 [ 9.696943][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 9.696945][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.696947][ C2] alloc_buf.isra.0+0x4b/0x260 [ 9.696949][ C2] put_chars+0x1e1/0x2f0 [ 9.696950][ C2] ? __send_to_port+0x420/0x420 [ 9.696953][ C2] hvc_console_print+0x292/0x780 [ 9.696955][ C2] ? __lock_acquire+0x388/0xc20 [ 9.696957][ C2] ? hvc_write+0x3a0/0x3a0 [ 9.696958][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696960][ C2] ? lock_acquire+0x13c/0x160 [ 9.696962][ C2] console_emit_next_record+0x22f/0x4c0 [ 9.696964][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 9.696966][ C2] ? console_flush_one_record+0x106/0x710 [ 9.696968][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696970][ C2] ? lock_acquire+0x13c/0x160 [ 9.696972][ C2] console_flush_one_record+0x46f/0x710 [ 9.696974][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 9.696977][ C2] ? __lock_acquire+0x518/0xc20 [ 9.696979][ C2] console_unlock+0xee/0x1f0 [ 9.696981][ C2] ? console_flush_one_record+0x710/0x710 [ 9.696983][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.696984][ C2] ? lock_acquire+0x60/0x160 [ 9.696986][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.696988][ C2] ? vprintk_emit+0x320/0x3e0 [ 9.696990][ C2] vprintk_emit+0x37c/0x3e0 [ 9.696992][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 9.696994][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.696996][ C2] _printk+0xc7/0x100 [ 9.696997][ C2] ? snapshot_read.cold+0x21/0x21 [ 9.696999][ C2] ? ___ratelimit+0x4e7/0xa00 [ 9.697001][ C2] ? idr_get_free+0x830/0x830 [ 9.697003][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.697005][ C2] ? tcp_send_synack+0x1570/0x1570 [ 9.697007][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 9.697008][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 9.697010][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.697012][ C2] ? add_timer_on+0x580/0x580 [ 9.697014][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.697016][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.697018][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 9.697020][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 9.697022][ C2] ? inet_csk_route_req+0x747/0xc30 [ 9.697024][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 9.697025][ C2] tcp_conn_request+0x1f15/0x2d20 [ 9.697027][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.697029][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.697031][ C2] ? __lock_acquire+0x518/0xc20 [ 9.697033][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.697035][ C2] ? __lock_acquire+0x518/0xc20 [ 9.697036][ C2] ? down_read_nested+0xe7/0x500 [ 9.697038][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.697041][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.697043][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.697045][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.697046][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 9.697048][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 9.697050][ C2] ? mark_usage+0x61/0x170 [ 9.697052][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 9.697054][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.697056][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 9.697057][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 9.697059][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.697061][ C2] ip_local_deliver_finish+0x36f/0x610 [ 9.697063][ C2] ip_local_deliver+0x184/0x4c0 [ 9.697065][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 9.697066][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 9.697069][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.697070][ C2] ip_rcv+0xdc/0x3d0 [ 9.697072][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 9.697074][ C2] ? mark_usage+0x61/0x170 [ 9.697075][ C2] ? __lock_acquire+0x518/0xc20 [ 9.697077][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 9.697079][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.697080][ C2] ? process_backlog+0x3f1/0x14c0 [ 9.697082][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.697084][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.697087][ C2] process_backlog+0x431/0x14c0 [ 9.697089][ C2] __napi_poll+0xa7/0x3b0 [ 9.697091][ C2] net_rx_action+0x513/0xf50 [ 9.697094][ C2] ? __napi_poll+0x3b0/0x3b0 [ 9.697096][ C2] ? find_held_lock+0x2b/0x80 [ 9.697099][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.697101][ C2] ? mark_held_locks+0x40/0x70 [ 9.697102][ C2] handle_softirqs+0x1d3/0x900 [ 9.697104][ C2] ? _local_bh_enable+0xc0/0xc0 [ 9.697105][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.697107][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 9.697109][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 9.697111][ C2] do_softirq+0xac/0xe0 [ 9.697112][ C2] [ 9.697112][ C2] [ 9.697113][ C2] __local_bh_enable_ip+0x118/0x150 [ 9.697114][ C2] __dev_queue_xmit+0x979/0x1b80 [ 9.697116][ C2] ? __asan_memcpy+0x3c/0x60 [ 9.697118][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.697120][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.697122][ C2] ? find_held_lock+0x2b/0x80 [ 9.697123][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.697124][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.697126][ C2] ? mark_held_locks+0x40/0x70 [ 9.697128][ C2] ? __asan_memcpy+0x3c/0x60 [ 9.697129][ C2] ? neigh_hh_output+0x152/0x4c0 [ 9.697131][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 9.697133][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 9.697135][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 9.697136][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 9.697139][ C2] ip_output+0x1ca/0x660 [ 9.697140][ C2] ? ip_finish_output+0x460/0x460 [ 9.697142][ C2] ? find_held_lock+0x2b/0x80 [ 9.697143][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 9.697145][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 9.697147][ C2] __ip_queue_xmit+0x774/0x1650 [ 9.697149][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.697152][ C2] ? __tcp_select_window+0xf20/0xf20 [ 9.697154][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.697155][ C2] ? ktime_get+0x18e/0x2d0 [ 9.697156][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 9.697158][ C2] ? ktime_get+0x1dd/0x2d0 [ 9.697160][ C2] tcp_connect+0x1024/0x1e20 [ 9.697162][ C2] tcp_v4_connect+0x12bd/0x1960 [ 9.697164][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 9.697166][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.697168][ C2] ? find_held_lock+0x2b/0x80 [ 9.697169][ C2] __inet_stream_connect+0x2ed/0xd00 [ 9.697171][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.697172][ C2] inet_stream_connect+0x59/0xb0 [ 9.697174][ C2] __sys_connect+0x1cf/0x2e0 [ 9.697175][ C2] ? do_fcntl+0x36f/0xc50 [ 9.697177][ C2] ? __sys_connect_file+0x250/0x250 [ 9.697180][ C2] ? fput+0x1f/0xa0 [ 9.697181][ C2] __x64_sys_connect+0x72/0xd0 [ 9.697183][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 9.697184][ C2] ? do_syscall_64+0xa6/0x530 [ 9.697186][ C2] do_syscall_64+0xff/0x530 [ 9.697187][ C2] ? irq_exit_rcu+0x1a/0x30 [ 9.697189][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.697190][ C2] RIP: 0033:0x7fae01a24312 [ 9.697192][ C2] Code: 08 0f 85 71 41 ff ff 49 89 fb 48 89 f0 48 89 d7 48 89 ce 4c 89 c2 4d 89 ca 4c 8b 44 24 08 4c 8b 4c 24 10 4c 89 5c 24 08 0f 05 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f 1e fa 55 bf 01 00 [ 9.697193][ C2] RSP: 002b:00007fae011a1988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.697194][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007fae01a24312 [ 9.697195][ C2] RDX: 0000000000000010 RSI: 00007fae011a1c40 RDI: 000000000000000a [ 9.697196][ C2] RBP: 00007fae011a19b0 R08: 0000000000000000 R09: 0000000000000000 [ 9.697196][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fae011a1c40 [ 9.697197][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 9.697199][ C2] [ 10.732097][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.732115][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.732117][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 10.732119][ C2] preempt_count: 102, expected: 0 [ 10.732120][ C2] RCU nest depth: 0, expected: 0 [ 10.732121][ C2] INFO: lockdep is turned off. [ 10.732123][ C2] irq event stamp: 337798 [ 10.732124][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 10.732133][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 10.732135][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 10.732139][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 10.732141][ C2] Preemption disabled at: [ 10.732142][ C2] [<0000000000000000>] 0x0 [ 10.732148][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.732152][ C2] Tainted: [W]=WARN [ 10.732153][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.732156][ C2] Call Trace: [ 10.732157][ C2] [ 10.732158][ C2] dump_stack_lvl+0x6f/0xa0 [ 10.732164][ C2] __might_resched.cold+0x1fe/0x2c1 [ 10.732168][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.732171][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732175][ C2] __kmalloc_noprof+0x443/0x760 [ 10.732179][ C2] ? __rwlock_init+0x150/0x150 [ 10.732181][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 10.732185][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 10.732187][ C2] alloc_buf.isra.0+0x4b/0x260 [ 10.732189][ C2] put_chars+0x1e1/0x2f0 [ 10.732191][ C2] ? __send_to_port+0x420/0x420 [ 10.732193][ C2] ? printk_get_next_message+0x240/0x650 [ 10.732196][ C2] hvc_console_print+0x292/0x780 [ 10.732200][ C2] ? hvc_write+0x3a0/0x3a0 [ 10.732201][ C2] ? __rwlock_init+0x150/0x150 [ 10.732203][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732205][ C2] ? lock_acquire+0x13c/0x160 [ 10.732207][ C2] console_emit_next_record+0x22f/0x4c0 [ 10.732210][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 10.732212][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732214][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732215][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732217][ C2] ? lock_acquire+0x13c/0x160 [ 10.732219][ C2] ? console_flush_one_record+0x111/0x710 [ 10.732220][ C2] console_flush_one_record+0x46f/0x710 [ 10.732223][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 10.732225][ C2] console_unlock+0xee/0x1f0 [ 10.732227][ C2] ? lock_acquire+0x13c/0x160 [ 10.732228][ C2] ? console_flush_one_record+0x710/0x710 [ 10.732230][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732232][ C2] ? lock_release+0x184/0x1f0 [ 10.732233][ C2] ? lock_acquire+0x60/0x160 [ 10.732235][ C2] ? __rcu_read_lock+0x30/0x70 [ 10.732237][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.732239][ C2] ? vprintk_emit+0x320/0x3e0 [ 10.732241][ C2] vprintk_emit+0x37c/0x3e0 [ 10.732243][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 10.732245][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 10.732246][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732248][ C2] ? lock_acquire+0x13c/0x160 [ 10.732250][ C2] _printk+0xc7/0x100 [ 10.732253][ C2] ? snapshot_read.cold+0x21/0x21 [ 10.732254][ C2] ? ___ratelimit+0x4e7/0xa00 [ 10.732257][ C2] ? trace_hardirqs_on+0x36/0x40 [ 10.732260][ C2] ? idr_get_free+0x830/0x830 [ 10.732262][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.732263][ C2] tcp_make_synack.cold+0x36/0xb6 [ 10.732267][ C2] ? tcp_send_synack+0x1570/0x1570 [ 10.732270][ C2] ? lock_release+0x184/0x1f0 [ 10.732272][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732274][ C2] ? inet_csk_route_req+0x747/0xc30 [ 10.732277][ C2] tcp_v4_send_synack+0x103/0xb20 [ 10.732280][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 10.732281][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 10.732284][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.732285][ C2] ? trace_hardirqs_on+0x36/0x40 [ 10.732287][ C2] ? get_random_u16+0x740/0x740 [ 10.732289][ C2] tcp_rtx_synack+0x150/0x440 [ 10.732291][ C2] ? tcp_send_probe0+0x590/0x590 [ 10.732293][ C2] ? sched_balance_rq+0x324/0x1e30 [ 10.732295][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 10.732297][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.732299][ C2] ? lock_acquire+0x6a/0x160 [ 10.732300][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 10.732302][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.732303][ C2] call_timer_fn+0x160/0x4d0 [ 10.732306][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 10.732308][ C2] ? debug_object_active_state+0x430/0x430 [ 10.732312][ C2] ? __rwlock_init+0x150/0x150 [ 10.732314][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.732316][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732318][ C2] __run_timers+0x68f/0xaa0 [ 10.732320][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.732322][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.732324][ C2] ? do_raw_spin_lock+0x131/0x280 [ 10.732326][ C2] ? __rwlock_init+0x150/0x150 [ 10.732329][ C2] run_timer_softirq+0xf0/0x160 [ 10.732331][ C2] ? __run_timers+0xaa0/0xaa0 [ 10.732332][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.732333][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732335][ C2] handle_softirqs+0x1d3/0x900 [ 10.732337][ C2] ? _local_bh_enable+0xc0/0xc0 [ 10.732339][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732341][ C2] ? lock_release+0x184/0x1f0 [ 10.732342][ C2] __irq_exit_rcu+0x145/0x1c0 [ 10.732344][ C2] irq_exit_rcu+0xe/0x30 [ 10.732345][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.732347][ C2] [ 10.732348][ C2] [ 10.732349][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 10.732350][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.732353][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.732355][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 10.732357][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 10.732361][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 10.732362][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 10.732363][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 10.732364][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 10.732364][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.732366][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.732368][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.732370][ C2] default_idle+0x9/0x10 [ 10.732371][ C2] default_idle_call+0x6e/0xb0 [ 10.732373][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.732374][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 10.732376][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 10.732378][ C2] ? default_idle_call+0x98/0xb0 [ 10.732379][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.732382][ C2] do_idle+0xd8/0x190 [ 10.732383][ C2] cpu_startup_entry+0x53/0x70 [ 10.732385][ C2] start_secondary+0x204/0x2b0 [ 10.732386][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.732388][ C2] common_startup_64+0x13e/0x148 [ 10.732393][ C2] [ 10.860175][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.885080][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.885097][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.885100][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 11.885102][ C2] preempt_count: 102, expected: 0 [ 11.885103][ C2] RCU nest depth: 0, expected: 0 [ 11.885103][ C2] INFO: lockdep is turned off. [ 11.885105][ C2] irq event stamp: 337798 [ 11.885106][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 11.885114][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 11.885116][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 11.885121][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 11.885123][ C2] Preemption disabled at: [ 11.885124][ C2] [<0000000000000000>] 0x0 [ 11.885131][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.885135][ C2] Tainted: [W]=WARN [ 11.885136][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.885138][ C2] Call Trace: [ 11.885139][ C2] [ 11.885142][ C2] dump_stack_lvl+0x6f/0xa0 [ 11.885147][ C2] __might_resched.cold+0x1fe/0x2c1 [ 11.885151][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.885154][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885159][ C2] __kmalloc_noprof+0x443/0x760 [ 11.885162][ C2] ? __rwlock_init+0x150/0x150 [ 11.885165][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 11.885169][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 11.885170][ C2] alloc_buf.isra.0+0x4b/0x260 [ 11.885172][ C2] put_chars+0x1e1/0x2f0 [ 11.885175][ C2] ? __send_to_port+0x420/0x420 [ 11.885176][ C2] ? printk_get_next_message+0x240/0x650 [ 11.885180][ C2] hvc_console_print+0x292/0x780 [ 11.885184][ C2] ? hvc_write+0x3a0/0x3a0 [ 11.885185][ C2] ? __rwlock_init+0x150/0x150 [ 11.885187][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885189][ C2] ? lock_acquire+0x13c/0x160 [ 11.885191][ C2] console_emit_next_record+0x22f/0x4c0 [ 11.885194][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 11.885195][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885197][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885199][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885200][ C2] ? lock_acquire+0x13c/0x160 [ 11.885202][ C2] ? console_flush_one_record+0x111/0x710 [ 11.885204][ C2] console_flush_one_record+0x46f/0x710 [ 11.885206][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 11.885209][ C2] console_unlock+0xee/0x1f0 [ 11.885210][ C2] ? lock_acquire+0x13c/0x160 [ 11.885212][ C2] ? console_flush_one_record+0x710/0x710 [ 11.885213][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885215][ C2] ? lock_release+0x184/0x1f0 [ 11.885216][ C2] ? lock_acquire+0x60/0x160 [ 11.885218][ C2] ? __rcu_read_lock+0x30/0x70 [ 11.885220][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.885221][ C2] ? vprintk_emit+0x320/0x3e0 [ 11.885223][ C2] vprintk_emit+0x37c/0x3e0 [ 11.885226][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 11.885227][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 11.885229][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885231][ C2] ? lock_acquire+0x13c/0x160 [ 11.885232][ C2] _printk+0xc7/0x100 [ 11.885235][ C2] ? snapshot_read.cold+0x21/0x21 [ 11.885237][ C2] ? ___ratelimit+0x4e7/0xa00 [ 11.885240][ C2] ? trace_hardirqs_on+0x36/0x40 [ 11.885242][ C2] ? idr_get_free+0x830/0x830 [ 11.885244][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 11.885245][ C2] tcp_make_synack.cold+0x36/0xb6 [ 11.885250][ C2] ? tcp_send_synack+0x1570/0x1570 [ 11.885253][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885256][ C2] ? inet_csk_route_req+0x747/0xc30 [ 11.885258][ C2] tcp_v4_send_synack+0x103/0xb20 [ 11.885261][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.885262][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 11.885265][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.885266][ C2] ? trace_hardirqs_on+0x36/0x40 [ 11.885268][ C2] ? get_random_u16+0x740/0x740 [ 11.885270][ C2] tcp_rtx_synack+0x150/0x440 [ 11.885271][ C2] ? trace_pelt_cfs_tp+0x9b/0x190 [ 11.885273][ C2] ? tcp_send_probe0+0x590/0x590 [ 11.885275][ C2] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 11.885277][ C2] ? update_cfs_rq_load_avg+0x4b/0x660 [ 11.885280][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 11.885281][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.885283][ C2] ? lock_acquire+0x6a/0x160 [ 11.885284][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 11.885286][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.885287][ C2] call_timer_fn+0x160/0x4d0 [ 11.885290][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 11.885292][ C2] ? debug_object_active_state+0x430/0x430 [ 11.885296][ C2] ? trace_sched_wakeup+0x9b/0x160 [ 11.885298][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 11.885299][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885302][ C2] __run_timers+0x68f/0xaa0 [ 11.885303][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.885305][ C2] ? debug_object_deactivate+0x2f7/0x440 [ 11.885307][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.885309][ C2] ? do_raw_spin_lock+0x131/0x280 [ 11.885311][ C2] ? __rwlock_init+0x150/0x150 [ 11.885314][ C2] run_timer_softirq+0xf0/0x160 [ 11.885316][ C2] ? __run_timers+0xaa0/0xaa0 [ 11.885317][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.885318][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885320][ C2] handle_softirqs+0x1d3/0x900 [ 11.885322][ C2] ? _local_bh_enable+0xc0/0xc0 [ 11.885324][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885325][ C2] ? lock_release+0x184/0x1f0 [ 11.885327][ C2] __irq_exit_rcu+0x145/0x1c0 [ 11.885329][ C2] irq_exit_rcu+0xe/0x30 [ 11.885330][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.885332][ C2] [ 11.885333][ C2] [ 11.885333][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 11.885335][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.885338][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 11.885340][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 11.885342][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 11.885346][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 11.885347][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 11.885348][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 11.885349][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 11.885350][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 11.885351][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 11.885353][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.885355][ C2] default_idle+0x9/0x10 [ 11.885356][ C2] default_idle_call+0x6e/0xb0 [ 11.885357][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.885359][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 11.885360][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 11.885363][ C2] ? default_idle_call+0x98/0xb0 [ 11.885364][ C2] ? rcu_is_watching+0x16/0xd0 [ 11.885366][ C2] do_idle+0xd8/0x190 [ 11.885368][ C2] cpu_startup_entry+0x53/0x70 [ 11.885369][ C2] start_secondary+0x204/0x2b0 [ 11.885371][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 11.885373][ C2] common_startup_64+0x13e/0x148 [ 11.885377][ C2] [ 11.907035][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.908132][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.908150][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.908153][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 12.908155][ C2] preempt_count: 102, expected: 0 [ 12.908157][ C2] RCU nest depth: 0, expected: 0 [ 12.908158][ C2] INFO: lockdep is turned off. [ 12.908160][ C2] irq event stamp: 337798 [ 12.908161][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 12.908171][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 12.908174][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 12.908179][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 12.908183][ C2] Preemption disabled at: [ 12.908184][ C2] [<0000000000000000>] 0x0 [ 12.908193][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.908198][ C2] Tainted: [W]=WARN [ 12.908199][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.908202][ C2] Call Trace: [ 12.908204][ C2] [ 12.908208][ C2] dump_stack_lvl+0x6f/0xa0 [ 12.908214][ C2] __might_resched.cold+0x1fe/0x2c1 [ 12.908219][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.908223][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908228][ C2] __kmalloc_noprof+0x443/0x760 [ 12.908232][ C2] ? __rwlock_init+0x150/0x150 [ 12.908236][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 12.908241][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 12.908243][ C2] alloc_buf.isra.0+0x4b/0x260 [ 12.908247][ C2] put_chars+0x1e1/0x2f0 [ 12.908250][ C2] ? __send_to_port+0x420/0x420 [ 12.908253][ C2] ? printk_get_next_message+0x240/0x650 [ 12.908257][ C2] hvc_console_print+0x292/0x780 [ 12.908262][ C2] ? hvc_write+0x3a0/0x3a0 [ 12.908265][ C2] ? __rwlock_init+0x150/0x150 [ 12.908267][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908270][ C2] ? lock_acquire+0x13c/0x160 [ 12.908273][ C2] console_emit_next_record+0x22f/0x4c0 [ 12.908277][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 12.908280][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908282][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908285][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908287][ C2] ? lock_acquire+0x13c/0x160 [ 12.908290][ C2] ? console_flush_one_record+0x111/0x710 [ 12.908292][ C2] console_flush_one_record+0x46f/0x710 [ 12.908296][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 12.908300][ C2] console_unlock+0xee/0x1f0 [ 12.908303][ C2] ? lock_acquire+0x13c/0x160 [ 12.908305][ C2] ? console_flush_one_record+0x710/0x710 [ 12.908307][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908310][ C2] ? lock_release+0x184/0x1f0 [ 12.908312][ C2] ? lock_acquire+0x60/0x160 [ 12.908314][ C2] ? __rcu_read_lock+0x30/0x70 [ 12.908317][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.908320][ C2] ? vprintk_emit+0x320/0x3e0 [ 12.908323][ C2] vprintk_emit+0x37c/0x3e0 [ 12.908326][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 12.908329][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 12.908331][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908333][ C2] ? lock_acquire+0x13c/0x160 [ 12.908336][ C2] _printk+0xc7/0x100 [ 12.908340][ C2] ? snapshot_read.cold+0x21/0x21 [ 12.908342][ C2] ? ___ratelimit+0x4e7/0xa00 [ 12.908346][ C2] ? trace_hardirqs_on+0x36/0x40 [ 12.908349][ C2] ? idr_get_free+0x830/0x830 [ 12.908352][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.908354][ C2] tcp_make_synack.cold+0x36/0xb6 [ 12.908360][ C2] ? tcp_send_synack+0x1570/0x1570 [ 12.908365][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908368][ C2] ? inet_csk_route_req+0x747/0xc30 [ 12.908372][ C2] tcp_v4_send_synack+0x103/0xb20 [ 12.908376][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.908378][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 12.908382][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.908385][ C2] ? trace_hardirqs_on+0x36/0x40 [ 12.908387][ C2] ? get_random_u16+0x740/0x740 [ 12.908390][ C2] tcp_rtx_synack+0x150/0x440 [ 12.908393][ C2] ? tcp_send_probe0+0x590/0x590 [ 12.908397][ C2] ? sched_balance_rq+0x324/0x1e30 [ 12.908400][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 12.908403][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.908405][ C2] ? lock_acquire+0x6a/0x160 [ 12.908407][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 12.908410][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.908412][ C2] call_timer_fn+0x160/0x4d0 [ 12.908416][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 12.908418][ C2] ? debug_object_active_state+0x430/0x430 [ 12.908424][ C2] ? __rwlock_init+0x150/0x150 [ 12.908426][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.908428][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908432][ C2] __run_timers+0x68f/0xaa0 [ 12.908435][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.908438][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.908441][ C2] ? do_raw_spin_lock+0x131/0x280 [ 12.908445][ C2] ? __rwlock_init+0x150/0x150 [ 12.908448][ C2] run_timer_softirq+0xf0/0x160 [ 12.908451][ C2] ? __run_timers+0xaa0/0xaa0 [ 12.908453][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.908455][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908458][ C2] handle_softirqs+0x1d3/0x900 [ 12.908461][ C2] ? _local_bh_enable+0xc0/0xc0 [ 12.908463][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908466][ C2] ? lock_release+0x184/0x1f0 [ 12.908469][ C2] __irq_exit_rcu+0x145/0x1c0 [ 12.908471][ C2] irq_exit_rcu+0xe/0x30 [ 12.908473][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.908476][ C2] [ 12.908477][ C2] [ 12.908478][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 12.908480][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.908484][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.908487][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 12.908490][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 12.908494][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 12.908496][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 12.908497][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 12.908499][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 12.908500][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.908502][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.908505][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.908508][ C2] default_idle+0x9/0x10 [ 12.908510][ C2] default_idle_call+0x6e/0xb0 [ 12.908512][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.908515][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 12.908517][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 12.908520][ C2] ? default_idle_call+0x98/0xb0 [ 12.908522][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.908525][ C2] do_idle+0xd8/0x190 [ 12.908527][ C2] cpu_startup_entry+0x53/0x70 [ 12.908530][ C2] start_secondary+0x204/0x2b0 [ 12.908532][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.908535][ C2] common_startup_64+0x13e/0x148 [ 12.908542][ C2] [ 12.940075][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.996123][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.996142][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.996146][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 13.996148][ C2] preempt_count: 102, expected: 0 [ 13.996149][ C2] RCU nest depth: 0, expected: 0 [ 13.996151][ C2] INFO: lockdep is turned off. [ 13.996153][ C2] irq event stamp: 337798 [ 13.996154][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 13.996163][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 13.996166][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 13.996171][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 13.996174][ C2] Preemption disabled at: [ 13.996176][ C2] [<0000000000000000>] 0x0 [ 13.996184][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.996189][ C2] Tainted: [W]=WARN [ 13.996190][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.996192][ C2] Call Trace: [ 13.996194][ C2] [ 13.996197][ C2] dump_stack_lvl+0x6f/0xa0 [ 13.996204][ C2] __might_resched.cold+0x1fe/0x2c1 [ 13.996208][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.996212][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996217][ C2] __kmalloc_noprof+0x443/0x760 [ 13.996222][ C2] ? __rwlock_init+0x150/0x150 [ 13.996225][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 13.996230][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 13.996232][ C2] alloc_buf.isra.0+0x4b/0x260 [ 13.996236][ C2] put_chars+0x1e1/0x2f0 [ 13.996239][ C2] ? __send_to_port+0x420/0x420 [ 13.996241][ C2] ? printk_get_next_message+0x240/0x650 [ 13.996246][ C2] hvc_console_print+0x292/0x780 [ 13.996251][ C2] ? hvc_write+0x3a0/0x3a0 [ 13.996254][ C2] ? __rwlock_init+0x150/0x150 [ 13.996256][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996259][ C2] ? lock_acquire+0x13c/0x160 [ 13.996262][ C2] console_emit_next_record+0x22f/0x4c0 [ 13.996266][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 13.996269][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996271][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996273][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996276][ C2] ? lock_acquire+0x13c/0x160 [ 13.996279][ C2] ? console_flush_one_record+0x111/0x710 [ 13.996281][ C2] console_flush_one_record+0x46f/0x710 [ 13.996285][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 13.996289][ C2] console_unlock+0xee/0x1f0 [ 13.996291][ C2] ? lock_acquire+0x13c/0x160 [ 13.996294][ C2] ? console_flush_one_record+0x710/0x710 [ 13.996296][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996298][ C2] ? lock_release+0x184/0x1f0 [ 13.996301][ C2] ? lock_acquire+0x60/0x160 [ 13.996303][ C2] ? __rcu_read_lock+0x30/0x70 [ 13.996306][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.996308][ C2] ? vprintk_emit+0x320/0x3e0 [ 13.996311][ C2] vprintk_emit+0x37c/0x3e0 [ 13.996315][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 13.996317][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 13.996320][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996323][ C2] ? lock_acquire+0x13c/0x160 [ 13.996325][ C2] _printk+0xc7/0x100 [ 13.996329][ C2] ? snapshot_read.cold+0x21/0x21 [ 13.996331][ C2] ? ___ratelimit+0x4e7/0xa00 [ 13.996335][ C2] ? trace_hardirqs_on+0x36/0x40 [ 13.996339][ C2] ? idr_get_free+0x830/0x830 [ 13.996341][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.996344][ C2] tcp_make_synack.cold+0x36/0xb6 [ 13.996349][ C2] ? tcp_send_synack+0x1570/0x1570 [ 13.996354][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996357][ C2] ? inet_csk_route_req+0x747/0xc30 [ 13.996361][ C2] tcp_v4_send_synack+0x103/0xb20 [ 13.996364][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.996368][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.996370][ C2] ? trace_hardirqs_on+0x36/0x40 [ 13.996372][ C2] ? get_random_u16+0x740/0x740 [ 13.996376][ C2] tcp_rtx_synack+0x150/0x440 [ 13.996378][ C2] ? tcp_send_probe0+0x590/0x590 [ 13.996382][ C2] ? sched_balance_rq+0x324/0x1e30 [ 13.996386][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 13.996389][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.996391][ C2] ? lock_acquire+0x6a/0x160 [ 13.996394][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 13.996396][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.996399][ C2] call_timer_fn+0x160/0x4d0 [ 13.996403][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 13.996405][ C2] ? debug_object_active_state+0x430/0x430 [ 13.996410][ C2] ? __rwlock_init+0x150/0x150 [ 13.996413][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.996415][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996418][ C2] __run_timers+0x68f/0xaa0 [ 13.996421][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.996424][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.996427][ C2] ? do_raw_spin_lock+0x131/0x280 [ 13.996431][ C2] ? __rwlock_init+0x150/0x150 [ 13.996435][ C2] run_timer_softirq+0xf0/0x160 [ 13.996438][ C2] ? __run_timers+0xaa0/0xaa0 [ 13.996440][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.996442][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996444][ C2] handle_softirqs+0x1d3/0x900 [ 13.996448][ C2] ? _local_bh_enable+0xc0/0xc0 [ 13.996450][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996452][ C2] ? lock_release+0x184/0x1f0 [ 13.996455][ C2] __irq_exit_rcu+0x145/0x1c0 [ 13.996457][ C2] irq_exit_rcu+0xe/0x30 [ 13.996459][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.996462][ C2] [ 13.996463][ C2] [ 13.996464][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 13.996466][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.996470][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.996473][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.996475][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 13.996479][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 13.996481][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 13.996482][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 13.996484][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 13.996485][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.996487][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.996490][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.996493][ C2] default_idle+0x9/0x10 [ 13.996495][ C2] default_idle_call+0x6e/0xb0 [ 13.996497][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.996500][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 13.996502][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 13.996505][ C2] ? default_idle_call+0x98/0xb0 [ 13.996507][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.996510][ C2] do_idle+0xd8/0x190 [ 13.996513][ C2] cpu_startup_entry+0x53/0x70 [ 13.996515][ C2] start_secondary+0x204/0x2b0 [ 13.996517][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.996520][ C2] common_startup_64+0x13e/0x148 [ 13.996526][ C2] [ 14.035781][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.084122][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.084142][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.084145][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 15.084147][ C2] preempt_count: 102, expected: 0 [ 15.084148][ C2] RCU nest depth: 0, expected: 0 [ 15.084150][ C2] INFO: lockdep is turned off. [ 15.084152][ C2] irq event stamp: 337798 [ 15.084153][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 15.084163][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 15.084166][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 15.084171][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 15.084174][ C2] Preemption disabled at: [ 15.084175][ C2] [<0000000000000000>] 0x0 [ 15.084183][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.084187][ C2] Tainted: [W]=WARN [ 15.084188][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.084191][ C2] Call Trace: [ 15.084193][ C2] [ 15.084196][ C2] dump_stack_lvl+0x6f/0xa0 [ 15.084202][ C2] __might_resched.cold+0x1fe/0x2c1 [ 15.084206][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.084210][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084215][ C2] __kmalloc_noprof+0x443/0x760 [ 15.084220][ C2] ? __rwlock_init+0x150/0x150 [ 15.084223][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 15.084228][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 15.084231][ C2] alloc_buf.isra.0+0x4b/0x260 [ 15.084234][ C2] put_chars+0x1e1/0x2f0 [ 15.084237][ C2] ? __send_to_port+0x420/0x420 [ 15.084239][ C2] ? printk_get_next_message+0x240/0x650 [ 15.084244][ C2] hvc_console_print+0x292/0x780 [ 15.084249][ C2] ? hvc_write+0x3a0/0x3a0 [ 15.084251][ C2] ? __rwlock_init+0x150/0x150 [ 15.084254][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084256][ C2] ? lock_acquire+0x13c/0x160 [ 15.084260][ C2] console_emit_next_record+0x22f/0x4c0 [ 15.084263][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 15.084266][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084268][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084270][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084273][ C2] ? lock_acquire+0x13c/0x160 [ 15.084275][ C2] ? console_flush_one_record+0x111/0x710 [ 15.084278][ C2] console_flush_one_record+0x46f/0x710 [ 15.084281][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 15.084285][ C2] console_unlock+0xee/0x1f0 [ 15.084287][ C2] ? lock_acquire+0x13c/0x160 [ 15.084289][ C2] ? console_flush_one_record+0x710/0x710 [ 15.084292][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084294][ C2] ? lock_release+0x184/0x1f0 [ 15.084296][ C2] ? lock_acquire+0x60/0x160 [ 15.084298][ C2] ? __rcu_read_lock+0x30/0x70 [ 15.084301][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.084303][ C2] ? vprintk_emit+0x320/0x3e0 [ 15.084306][ C2] vprintk_emit+0x37c/0x3e0 [ 15.084310][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 15.084312][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 15.084315][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084317][ C2] ? lock_acquire+0x13c/0x160 [ 15.084320][ C2] _printk+0xc7/0x100 [ 15.084324][ C2] ? snapshot_read.cold+0x21/0x21 [ 15.084326][ C2] ? ___ratelimit+0x4e7/0xa00 [ 15.084330][ C2] ? idr_get_free+0x830/0x830 [ 15.084333][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.084336][ C2] tcp_make_synack.cold+0x36/0xb6 [ 15.084341][ C2] ? tcp_send_synack+0x1570/0x1570 [ 15.084346][ C2] ? lock_release+0x184/0x1f0 [ 15.084348][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084351][ C2] ? inet_csk_route_req+0x747/0xc30 [ 15.084355][ C2] tcp_v4_send_synack+0x103/0xb20 [ 15.084359][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.084361][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 15.084365][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.084367][ C2] ? trace_hardirqs_on+0x36/0x40 [ 15.084369][ C2] ? get_random_u16+0x740/0x740 [ 15.084373][ C2] tcp_rtx_synack+0x150/0x440 [ 15.084376][ C2] ? tcp_send_probe0+0x590/0x590 [ 15.084379][ C2] ? sched_balance_rq+0x324/0x1e30 [ 15.084382][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 15.084385][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.084387][ C2] ? lock_acquire+0x6a/0x160 [ 15.084389][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 15.084392][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.084394][ C2] call_timer_fn+0x160/0x4d0 [ 15.084398][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 15.084401][ C2] ? debug_object_active_state+0x430/0x430 [ 15.084406][ C2] ? __rwlock_init+0x150/0x150 [ 15.084408][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 15.084411][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084414][ C2] __run_timers+0x68f/0xaa0 [ 15.084416][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.084420][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.084423][ C2] ? do_raw_spin_lock+0x131/0x280 [ 15.084426][ C2] ? __rwlock_init+0x150/0x150 [ 15.084430][ C2] run_timer_softirq+0xf0/0x160 [ 15.084432][ C2] ? __run_timers+0xaa0/0xaa0 [ 15.084435][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.084436][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084439][ C2] handle_softirqs+0x1d3/0x900 [ 15.084442][ C2] ? _local_bh_enable+0xc0/0xc0 [ 15.084444][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084446][ C2] ? lock_release+0x184/0x1f0 [ 15.084449][ C2] __irq_exit_rcu+0x145/0x1c0 [ 15.084451][ C2] irq_exit_rcu+0xe/0x30 [ 15.084453][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.084457][ C2] [ 15.084458][ C2] [ 15.084459][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 15.084461][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.084465][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.084468][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 15.084470][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 15.084475][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 15.084477][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 15.084478][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 15.084479][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 15.084480][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.084483][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.084485][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.084489][ C2] default_idle+0x9/0x10 [ 15.084491][ C2] default_idle_call+0x6e/0xb0 [ 15.084493][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.084496][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 15.084498][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 15.084501][ C2] ? default_idle_call+0x98/0xb0 [ 15.084503][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.084506][ C2] do_idle+0xd8/0x190 [ 15.084508][ C2] cpu_startup_entry+0x53/0x70 [ 15.084510][ C2] start_secondary+0x204/0x2b0 [ 15.084513][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.084516][ C2] common_startup_64+0x13e/0x148 [ 15.084522][ C2] [ 15.128042][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.172099][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.172115][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.172118][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 16.172119][ C2] preempt_count: 102, expected: 0 [ 16.172120][ C2] RCU nest depth: 0, expected: 0 [ 16.172121][ C2] INFO: lockdep is turned off. [ 16.172123][ C2] irq event stamp: 337798 [ 16.172124][ C2] hardirqs last enabled at (337797): [] default_idle_call+0x98/0xb0 [ 16.172131][ C2] hardirqs last disabled at (337798): [] __schedule+0x1246/0x20e0 [ 16.172134][ C2] softirqs last enabled at (337694): [] handle_softirqs+0x67c/0x900 [ 16.172138][ C2] softirqs last disabled at (337689): [] __irq_exit_rcu+0x145/0x1c0 [ 16.172140][ C2] Preemption disabled at: [ 16.172141][ C2] [<0000000000000000>] 0x0 [ 16.172148][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.172152][ C2] Tainted: [W]=WARN [ 16.172153][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.172154][ C2] Call Trace: [ 16.172156][ C2] [ 16.172158][ C2] dump_stack_lvl+0x6f/0xa0 [ 16.172164][ C2] __might_resched.cold+0x1fe/0x2c1 [ 16.172168][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.172171][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172175][ C2] __kmalloc_noprof+0x443/0x760 [ 16.172179][ C2] ? __rwlock_init+0x150/0x150 [ 16.172182][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 16.172185][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 16.172187][ C2] alloc_buf.isra.0+0x4b/0x260 [ 16.172189][ C2] put_chars+0x1e1/0x2f0 [ 16.172192][ C2] ? __send_to_port+0x420/0x420 [ 16.172193][ C2] ? printk_get_next_message+0x240/0x650 [ 16.172197][ C2] hvc_console_print+0x292/0x780 [ 16.172200][ C2] ? hvc_write+0x3a0/0x3a0 [ 16.172202][ C2] ? __rwlock_init+0x150/0x150 [ 16.172203][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172205][ C2] ? lock_acquire+0x13c/0x160 [ 16.172207][ C2] console_emit_next_record+0x22f/0x4c0 [ 16.172210][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 16.172212][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172213][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172215][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172216][ C2] ? lock_acquire+0x13c/0x160 [ 16.172218][ C2] ? console_flush_one_record+0x111/0x710 [ 16.172220][ C2] console_flush_one_record+0x46f/0x710 [ 16.172222][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 16.172225][ C2] console_unlock+0xee/0x1f0 [ 16.172226][ C2] ? lock_acquire+0x13c/0x160 [ 16.172228][ C2] ? console_flush_one_record+0x710/0x710 [ 16.172229][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172231][ C2] ? lock_release+0x184/0x1f0 [ 16.172232][ C2] ? lock_acquire+0x60/0x160 [ 16.172234][ C2] ? __rcu_read_lock+0x30/0x70 [ 16.172236][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.172238][ C2] ? vprintk_emit+0x320/0x3e0 [ 16.172240][ C2] vprintk_emit+0x37c/0x3e0 [ 16.172242][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 16.172244][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 16.172245][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172247][ C2] ? lock_acquire+0x13c/0x160 [ 16.172249][ C2] _printk+0xc7/0x100 [ 16.172252][ C2] ? snapshot_read.cold+0x21/0x21 [ 16.172253][ C2] ? ___ratelimit+0x4e7/0xa00 [ 16.172256][ C2] ? trace_hardirqs_on+0x36/0x40 [ 16.172259][ C2] ? idr_get_free+0x830/0x830 [ 16.172260][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 16.172262][ C2] tcp_make_synack.cold+0x36/0xb6 [ 16.172266][ C2] ? tcp_send_synack+0x1570/0x1570 [ 16.172269][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172272][ C2] ? inet_csk_route_req+0x747/0xc30 [ 16.172274][ C2] tcp_v4_send_synack+0x103/0xb20 [ 16.172277][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 16.172278][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 16.172281][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.172282][ C2] ? trace_hardirqs_on+0x36/0x40 [ 16.172284][ C2] ? get_random_u16+0x740/0x740 [ 16.172286][ C2] tcp_rtx_synack+0x150/0x440 [ 16.172288][ C2] ? tcp_send_probe0+0x590/0x590 [ 16.172290][ C2] ? sched_balance_rq+0x324/0x1e30 [ 16.172292][ C2] ? do_raw_spin_lock+0x131/0x280 [ 16.172293][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 16.172295][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.172297][ C2] ? lock_acquire+0x6a/0x160 [ 16.172298][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 16.172300][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.172301][ C2] call_timer_fn+0x160/0x4d0 [ 16.172304][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 16.172306][ C2] ? debug_object_active_state+0x430/0x430 [ 16.172310][ C2] ? __rwlock_init+0x150/0x150 [ 16.172311][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 16.172313][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172315][ C2] __run_timers+0x68f/0xaa0 [ 16.172317][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.172319][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 16.172321][ C2] ? do_raw_spin_lock+0x131/0x280 [ 16.172323][ C2] ? __rwlock_init+0x150/0x150 [ 16.172325][ C2] run_timer_softirq+0xf0/0x160 [ 16.172327][ C2] ? __run_timers+0xaa0/0xaa0 [ 16.172329][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.172330][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172332][ C2] handle_softirqs+0x1d3/0x900 [ 16.172334][ C2] ? _local_bh_enable+0xc0/0xc0 [ 16.172335][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172337][ C2] ? lock_release+0x184/0x1f0 [ 16.172339][ C2] __irq_exit_rcu+0x145/0x1c0 [ 16.172340][ C2] irq_exit_rcu+0xe/0x30 [ 16.172342][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 16.172344][ C2] [ 16.172344][ C2] [ 16.172345][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 16.172346][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.172349][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 16.172351][ C2] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 16.172353][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 16.172356][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 16.172358][ C2] RDX: 0000000000000002 RSI: ffffffff8648dc60 RDI: ffffffff83afa307 [ 16.172359][ C2] RBP: 0000000000000000 R08: ffffffff8611f421 R09: 1fe2200006a663a2 [ 16.172360][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 16.172360][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 16.172362][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 16.172364][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.172366][ C2] default_idle+0x9/0x10 [ 16.172367][ C2] default_idle_call+0x6e/0xb0 [ 16.172369][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.172370][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 16.172372][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 16.172374][ C2] ? default_idle_call+0x98/0xb0 [ 16.172376][ C2] ? rcu_is_watching+0x16/0xd0 [ 16.172378][ C2] do_idle+0xd8/0x190 [ 16.172379][ C2] cpu_startup_entry+0x53/0x70 [ 16.172381][ C2] start_secondary+0x204/0x2b0 [ 16.172382][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 16.172384][ C2] common_startup_64+0x13e/0x148 [ 16.172388][ C2]