[ 8.734417][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 8.734442][ C2] [ 8.734443][ C2] ======================================================== [ 8.734444][ C2] WARNING: possible irq lock inversion dependency detected [ 8.734446][ C2] 7.2.0-virtme #1 Tainted: G W [ 8.734447][ C2] -------------------------------------------------------- [ 8.734448][ C2] connect-deny_ip/169 just changed the state of lock: [ 8.734449][ C2] ffffffffbac99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 8.734461][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 8.734462][ C2] (fs_reclaim){+.+.}-{0:0} [ 8.734464][ C2] [ 8.734464][ C2] [ 8.734464][ C2] and interrupts could create inverse lock ordering between them. [ 8.734464][ C2] [ 8.734464][ C2] [ 8.734464][ C2] other info that might help us debug this: [ 8.734465][ C2] Possible interrupt unsafe locking scenario: [ 8.734465][ C2] [ 8.734466][ C2] CPU0 CPU1 [ 8.734466][ C2] ---- ---- [ 8.734467][ C2] lock(fs_reclaim); [ 8.734468][ C2] local_irq_disable(); [ 8.734468][ C2] lock(console_owner); [ 8.734469][ C2] lock(fs_reclaim); [ 8.734470][ C2] [ 8.734470][ C2] lock(console_owner); [ 8.734471][ C2] [ 8.734471][ C2] *** DEADLOCK *** [ 8.734471][ C2] [ 8.734471][ C2] locks held by connect-deny_ip/169: 9, last CPU#2: [ 8.734472][ C2] #0: ff1100000f919d90 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 8.734478][ C2] #1: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 8.734482][ C2] #2: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 8.734485][ C2] #3: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 8.734488][ C2] #4: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 8.734493][ C2] #5: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 8.734496][ C2] #6: ffffffffbad90b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 8.734500][ C2] #7: ffffffffbad79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 8.734503][ C2] #8: ffffffffbad79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 8.734506][ C2] [ 8.734506][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 8.734511][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 8.734513][ C2] HARDIRQ-ON-W at: [ 8.734515][ C2] __lock_acquire+0x388/0xc20 [ 8.734518][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734519][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.734522][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.734524][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.734527][ C2] workqueue_init+0x2a/0x680 [ 8.734530][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.734533][ C2] kernel_init+0x21/0x150 [ 8.734535][ C2] ret_from_fork+0x474/0x6b0 [ 8.734538][ C2] ret_from_fork_asm+0x11/0x20 [ 8.734541][ C2] SOFTIRQ-ON-W at: [ 8.734542][ C2] __lock_acquire+0x388/0xc20 [ 8.734548][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734549][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.734550][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.734552][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.734553][ C2] workqueue_init+0x2a/0x680 [ 8.734554][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.734556][ C2] kernel_init+0x21/0x150 [ 8.734557][ C2] ret_from_fork+0x474/0x6b0 [ 8.734558][ C2] ret_from_fork_asm+0x11/0x20 [ 8.734559][ C2] INITIAL USE at: [ 8.734560][ C2] __lock_acquire+0x388/0xc20 [ 8.734561][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734562][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.734563][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.734565][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.734566][ C2] workqueue_init+0x2a/0x680 [ 8.734567][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.734569][ C2] kernel_init+0x21/0x150 [ 8.734570][ C2] ret_from_fork+0x474/0x6b0 [ 8.734571][ C2] ret_from_fork_asm+0x11/0x20 [ 8.734572][ C2] } [ 8.734572][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 8.734576][ C2] ... acquired at: [ 8.734577][ C2] __lock_acquire+0x518/0xc20 [ 8.734578][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734579][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.734580][ C2] __kmalloc_noprof+0xd3/0x760 [ 8.734582][ C2] alloc_buf.isra.0+0x4b/0x260 [ 8.734585][ C2] put_chars+0x1e1/0x2f0 [ 8.734586][ C2] hvc_console_print+0x292/0x780 [ 8.734588][ C2] console_emit_next_record+0x22f/0x4c0 [ 8.734590][ C2] console_flush_one_record+0x46f/0x710 [ 8.734592][ C2] console_unlock+0xee/0x1f0 [ 8.734593][ C2] vprintk_emit+0x37c/0x3e0 [ 8.734594][ C2] _printk+0xc7/0x100 [ 8.734597][ C2] dm_interface_init+0x50/0x60 [ 8.734600][ C2] dm_init+0x51/0xd0 [ 8.734602][ C2] do_one_initcall+0x124/0x4f0 [ 8.734603][ C2] kernel_init_freeable+0x596/0x630 [ 8.734605][ C2] kernel_init+0x21/0x150 [ 8.734606][ C2] ret_from_fork+0x474/0x6b0 [ 8.734607][ C2] ret_from_fork_asm+0x11/0x20 [ 8.734609][ C2] [ 8.734609][ C2] -> (console_owner){..-.}-{0:0} { [ 8.734611][ C2] IN-SOFTIRQ-W at: [ 8.734611][ C2] __lock_acquire+0x388/0xc20 [ 8.734613][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734614][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.734615][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.734617][ C2] console_flush_one_record+0x46f/0x710 [ 8.734618][ C2] console_unlock+0xee/0x1f0 [ 8.734620][ C2] vprintk_emit+0x37c/0x3e0 [ 8.734621][ C2] _printk+0xc7/0x100 [ 8.734623][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.734625][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.734627][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.734629][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.734630][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.734632][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.734633][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.734635][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.734636][ C2] ip_local_deliver+0x184/0x4c0 [ 8.734637][ C2] ip_rcv+0xdc/0x3d0 [ 8.734639][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.734641][ C2] process_backlog+0x431/0x14c0 [ 8.734642][ C2] __napi_poll+0xa7/0x3b0 [ 8.734644][ C2] net_rx_action+0x513/0xf50 [ 8.734646][ C2] handle_softirqs+0x1d3/0x900 [ 8.734648][ C2] do_softirq+0xac/0xe0 [ 8.734649][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.734651][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.734652][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.734654][ C2] ip_output+0x1ca/0x660 [ 8.734655][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.734656][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.734658][ C2] tcp_connect+0x1024/0x1e20 [ 8.734659][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.734660][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.734661][ C2] inet_stream_connect+0x59/0xb0 [ 8.734663][ C2] __sys_connect+0x1cf/0x2e0 [ 8.734665][ C2] __x64_sys_connect+0x72/0xd0 [ 8.734667][ C2] do_syscall_64+0xff/0x530 [ 8.734669][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.734671][ C2] INITIAL USE at: [ 8.734671][ C2] } [ 8.734672][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 8.734675][ C2] ... acquired at: [ 8.734676][ C2] mark_lock+0x1d7/0xa00 [ 8.734677][ C2] mark_usage+0x42/0x170 [ 8.734678][ C2] __lock_acquire+0x388/0xc20 [ 8.734679][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734681][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.734682][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.734684][ C2] console_flush_one_record+0x46f/0x710 [ 8.734685][ C2] console_unlock+0xee/0x1f0 [ 8.734687][ C2] vprintk_emit+0x37c/0x3e0 [ 8.734688][ C2] _printk+0xc7/0x100 [ 8.734689][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.734691][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.734692][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.734694][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.734695][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.734697][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.734698][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.734699][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.734701][ C2] ip_local_deliver+0x184/0x4c0 [ 8.734702][ C2] ip_rcv+0xdc/0x3d0 [ 8.734703][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.734705][ C2] process_backlog+0x431/0x14c0 [ 8.734706][ C2] __napi_poll+0xa7/0x3b0 [ 8.734708][ C2] net_rx_action+0x513/0xf50 [ 8.734710][ C2] handle_softirqs+0x1d3/0x900 [ 8.734711][ C2] do_softirq+0xac/0xe0 [ 8.734712][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.734713][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.734715][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.734716][ C2] ip_output+0x1ca/0x660 [ 8.734717][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.734719][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.734720][ C2] tcp_connect+0x1024/0x1e20 [ 8.734721][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.734722][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.734723][ C2] inet_stream_connect+0x59/0xb0 [ 8.734724][ C2] __sys_connect+0x1cf/0x2e0 [ 8.734726][ C2] __x64_sys_connect+0x72/0xd0 [ 8.734727][ C2] do_syscall_64+0xff/0x530 [ 8.734729][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.734730][ C2] [ 8.734730][ C2] [ 8.734730][ C2] stack backtrace: [ 8.734733][ C2] CPU: 2 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.734736][ C2] Tainted: [W]=WARN [ 8.734737][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.734739][ C2] Call Trace: [ 8.734740][ C2] [ 8.734741][ C2] dump_stack_lvl+0x6f/0xa0 [ 8.734745][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 8.734747][ C2] mark_lock_irq+0x989/0x9c0 [ 8.734750][ C2] mark_lock+0x1d7/0xa00 [ 8.734752][ C2] mark_usage+0x42/0x170 [ 8.734753][ C2] __lock_acquire+0x388/0xc20 [ 8.734756][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.734757][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 8.734759][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734762][ C2] ? lock_acquire+0x13c/0x160 [ 8.734764][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.734766][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 8.734767][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.734769][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 8.734771][ C2] ? console_flush_one_record+0x106/0x710 [ 8.734773][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734775][ C2] ? lock_acquire+0x13c/0x160 [ 8.734776][ C2] console_flush_one_record+0x46f/0x710 [ 8.734779][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 8.734780][ C2] ? __lock_acquire+0x518/0xc20 [ 8.734782][ C2] console_unlock+0xee/0x1f0 [ 8.734784][ C2] ? console_flush_one_record+0x710/0x710 [ 8.734786][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734787][ C2] ? lock_acquire+0x60/0x160 [ 8.734789][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.734791][ C2] ? vprintk_emit+0x320/0x3e0 [ 8.734793][ C2] vprintk_emit+0x37c/0x3e0 [ 8.734795][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 8.734797][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.734799][ C2] _printk+0xc7/0x100 [ 8.734801][ C2] ? snapshot_read.cold+0x21/0x21 [ 8.734802][ C2] ? ___ratelimit+0x4e7/0xa00 [ 8.734805][ C2] ? idr_get_free+0x830/0x830 [ 8.734807][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.734809][ C2] ? tcp_send_synack+0x1570/0x1570 [ 8.734811][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 8.734812][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 8.734815][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.734817][ C2] ? add_timer_on+0x580/0x580 [ 8.734820][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.734822][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 8.734824][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 8.734827][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 8.734829][ C2] ? inet_csk_route_req+0x747/0xc30 [ 8.734831][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 8.734832][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.734834][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.734838][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.734840][ C2] ? __lock_acquire+0x518/0xc20 [ 8.734842][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.734844][ C2] ? __lock_acquire+0x518/0xc20 [ 8.734845][ C2] ? down_read_nested+0xe7/0x500 [ 8.734848][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734850][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.734852][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.734854][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.734856][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 8.734857][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.734860][ C2] ? mark_usage+0x61/0x170 [ 8.734861][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 8.734863][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.734865][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 8.734867][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.734869][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.734871][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.734872][ C2] ip_local_deliver+0x184/0x4c0 [ 8.734874][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 8.734876][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 8.734878][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.734880][ C2] ip_rcv+0xdc/0x3d0 [ 8.734881][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 8.734883][ C2] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.734884][ C2] ? validate_chain+0x38b/0xc20 [ 8.734886][ C2] ? mark_usage+0x61/0x170 [ 8.734887][ C2] ? __lock_acquire+0x518/0xc20 [ 8.734889][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.734891][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.734893][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.734894][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.734896][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.734898][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734900][ C2] process_backlog+0x431/0x14c0 [ 8.734903][ C2] __napi_poll+0xa7/0x3b0 [ 8.734905][ C2] net_rx_action+0x513/0xf50 [ 8.734907][ C2] ? __napi_poll+0x3b0/0x3b0 [ 8.734909][ C2] ? find_held_lock+0x2b/0x80 [ 8.734912][ C2] ? mark_held_locks+0x40/0x70 [ 8.734914][ C2] handle_softirqs+0x1d3/0x900 [ 8.734916][ C2] ? _local_bh_enable+0xc0/0xc0 [ 8.734917][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734919][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 8.734921][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 8.734923][ C2] do_softirq+0xac/0xe0 [ 8.734925][ C2] [ 8.734925][ C2] [ 8.734926][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.734927][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.734929][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.734932][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.734934][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.734935][ C2] ? find_held_lock+0x2b/0x80 [ 8.734937][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.734938][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.734940][ C2] ? mark_held_locks+0x40/0x70 [ 8.734941][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.734942][ C2] ? neigh_hh_output+0x152/0x4c0 [ 8.734945][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.734946][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 8.734948][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.734950][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 8.734952][ C2] ip_output+0x1ca/0x660 [ 8.734954][ C2] ? ip_finish_output+0x460/0x460 [ 8.734955][ C2] ? find_held_lock+0x2b/0x80 [ 8.734957][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.734959][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 8.734961][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.734963][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.734965][ C2] ? __tcp_select_window+0xf20/0xf20 [ 8.734967][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.734969][ C2] ? ktime_get+0x18e/0x2d0 [ 8.734971][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 8.734974][ C2] ? ktime_get+0x1dd/0x2d0 [ 8.734975][ C2] tcp_connect+0x1024/0x1e20 [ 8.734977][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.734980][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 8.734982][ C2] ? do_raw_spin_lock+0x131/0x280 [ 8.734983][ C2] ? find_held_lock+0x2b/0x80 [ 8.734985][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.734987][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.734988][ C2] inet_stream_connect+0x59/0xb0 [ 8.734990][ C2] __sys_connect+0x1cf/0x2e0 [ 8.734991][ C2] ? do_fcntl+0x36f/0xc50 [ 8.734994][ C2] ? __sys_connect_file+0x250/0x250 [ 8.734997][ C2] ? fput+0x1f/0xa0 [ 8.734999][ C2] __x64_sys_connect+0x72/0xd0 [ 8.735000][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.735002][ C2] ? do_syscall_64+0xa6/0x530 [ 8.735003][ C2] do_syscall_64+0xff/0x530 [ 8.735005][ C2] ? exc_page_fault+0xee/0x100 [ 8.735006][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.735007][ C2] RIP: 0033:0x7f1d502af312 [ 8.735010][ 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 [ 8.735012][ C2] RSP: 002b:00007f1d4fa2c988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.735014][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007f1d502af312 [ 8.735016][ C2] RDX: 0000000000000010 RSI: 00007f1d4fa2cc40 RDI: 000000000000000a [ 8.735017][ C2] RBP: 00007f1d4fa2c9b0 R08: 0000000000000000 R09: 0000000000000000 [ 8.735017][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1d4fa2cc40 [ 8.735018][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 8.735020][ C2] [ 8.735024][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 8.735025][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 8.735026][ C2] preempt_count: 302, expected: 0 [ 8.735027][ C2] RCU nest depth: 6, expected: 0 [ 8.735028][ C2] INFO: lockdep is turned off. [ 8.735028][ C2] irq event stamp: 9887 [ 8.735029][ C2] hardirqs last enabled at (9886): [] __down_trylock_console_sem+0x86/0xa0 [ 8.735031][ C2] hardirqs last disabled at (9887): [] console_emit_next_record+0x3d4/0x4c0 [ 8.735033][ C2] softirqs last enabled at (9716): [] __dev_queue_xmit+0x964/0x1b80 [ 8.735035][ C2] softirqs last disabled at (9717): [] do_softirq+0xac/0xe0 [ 8.735036][ C2] Preemption disabled at: [ 8.735037][ C2] [] __dev_queue_xmit+0x204/0x1b80 [ 8.735040][ C2] CPU: 2 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.735042][ C2] Tainted: [W]=WARN [ 8.735043][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.735043][ C2] Call Trace: [ 8.735044][ C2] [ 8.735044][ C2] dump_stack_lvl+0x6f/0xa0 [ 8.735046][ C2] ? __dev_queue_xmit+0x204/0x1b80 [ 8.735048][ C2] __might_resched.cold+0x1fe/0x2c1 [ 8.735051][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 8.735054][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735056][ C2] __kmalloc_noprof+0x443/0x760 [ 8.735057][ C2] ? __rwlock_init+0x150/0x150 [ 8.735059][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 8.735061][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.735062][ C2] alloc_buf.isra.0+0x4b/0x260 [ 8.735064][ C2] put_chars+0x1e1/0x2f0 [ 8.735066][ C2] ? __send_to_port+0x420/0x420 [ 8.735068][ C2] hvc_console_print+0x292/0x780 [ 8.735070][ C2] ? __lock_acquire+0x388/0xc20 [ 8.735072][ C2] ? hvc_write+0x3a0/0x3a0 [ 8.735074][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735076][ C2] ? lock_acquire+0x13c/0x160 [ 8.735077][ C2] console_emit_next_record+0x22f/0x4c0 [ 8.735080][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 8.735081][ C2] ? console_flush_one_record+0x106/0x710 [ 8.735083][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735085][ C2] ? lock_acquire+0x13c/0x160 [ 8.735086][ C2] console_flush_one_record+0x46f/0x710 [ 8.735089][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 8.735090][ C2] ? __lock_acquire+0x518/0xc20 [ 8.735092][ C2] console_unlock+0xee/0x1f0 [ 8.735094][ C2] ? console_flush_one_record+0x710/0x710 [ 8.735096][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735097][ C2] ? lock_acquire+0x60/0x160 [ 8.735099][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.735101][ C2] ? vprintk_emit+0x320/0x3e0 [ 8.735103][ C2] vprintk_emit+0x37c/0x3e0 [ 8.735104][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 8.735106][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.735108][ C2] _printk+0xc7/0x100 [ 8.735110][ C2] ? snapshot_read.cold+0x21/0x21 [ 8.735111][ C2] ? ___ratelimit+0x4e7/0xa00 [ 8.735113][ C2] ? idr_get_free+0x830/0x830 [ 8.735115][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.735118][ C2] ? tcp_send_synack+0x1570/0x1570 [ 8.735119][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 8.735121][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 8.735123][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.735124][ C2] ? add_timer_on+0x580/0x580 [ 8.735126][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.735128][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 8.735130][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 8.735132][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 8.735134][ C2] ? inet_csk_route_req+0x747/0xc30 [ 8.735136][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 8.735137][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.735139][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.735141][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.735143][ C2] ? __lock_acquire+0x518/0xc20 [ 8.735145][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.735147][ C2] ? __lock_acquire+0x518/0xc20 [ 8.735148][ C2] ? down_read_nested+0xe7/0x500 [ 8.735150][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735152][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.735154][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.735156][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.735158][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 8.735159][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.735162][ C2] ? mark_usage+0x61/0x170 [ 8.735163][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 8.735165][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.735167][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 8.735168][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.735170][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.735172][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.735174][ C2] ip_local_deliver+0x184/0x4c0 [ 8.735175][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 8.735177][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 8.735179][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.735181][ C2] ip_rcv+0xdc/0x3d0 [ 8.735182][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 8.735184][ C2] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.735185][ C2] ? validate_chain+0x38b/0xc20 [ 8.735187][ C2] ? mark_usage+0x61/0x170 [ 8.735188][ C2] ? __lock_acquire+0x518/0xc20 [ 8.735189][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.735191][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.735193][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.735194][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.735196][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.735198][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735200][ C2] process_backlog+0x431/0x14c0 [ 8.735203][ C2] __napi_poll+0xa7/0x3b0 [ 8.735205][ C2] net_rx_action+0x513/0xf50 [ 8.735208][ C2] ? __napi_poll+0x3b0/0x3b0 [ 8.735210][ C2] ? find_held_lock+0x2b/0x80 [ 8.735213][ C2] ? mark_held_locks+0x40/0x70 [ 8.735214][ C2] handle_softirqs+0x1d3/0x900 [ 8.735216][ C2] ? _local_bh_enable+0xc0/0xc0 [ 8.735217][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735219][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 8.735220][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 8.735222][ C2] do_softirq+0xac/0xe0 [ 8.735224][ C2] [ 8.735224][ C2] [ 8.735225][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.735226][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.735228][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.735230][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.735232][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.735233][ C2] ? find_held_lock+0x2b/0x80 [ 8.735235][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.735236][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.735238][ C2] ? mark_held_locks+0x40/0x70 [ 8.735239][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.735240][ C2] ? neigh_hh_output+0x152/0x4c0 [ 8.735242][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.735244][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 8.735246][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.735247][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 8.735250][ C2] ip_output+0x1ca/0x660 [ 8.735251][ C2] ? ip_finish_output+0x460/0x460 [ 8.735253][ C2] ? find_held_lock+0x2b/0x80 [ 8.735254][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.735256][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 8.735258][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.735260][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.735263][ C2] ? __tcp_select_window+0xf20/0xf20 [ 8.735265][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.735266][ C2] ? ktime_get+0x18e/0x2d0 [ 8.735267][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 8.735269][ C2] ? ktime_get+0x1dd/0x2d0 [ 8.735270][ C2] tcp_connect+0x1024/0x1e20 [ 8.735273][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.735275][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 8.735277][ C2] ? do_raw_spin_lock+0x131/0x280 [ 8.735278][ C2] ? find_held_lock+0x2b/0x80 [ 8.735280][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.735281][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.735283][ C2] inet_stream_connect+0x59/0xb0 [ 8.735284][ C2] __sys_connect+0x1cf/0x2e0 [ 8.735286][ C2] ? do_fcntl+0x36f/0xc50 [ 8.735288][ C2] ? __sys_connect_file+0x250/0x250 [ 8.735291][ C2] ? fput+0x1f/0xa0 [ 8.735292][ C2] __x64_sys_connect+0x72/0xd0 [ 8.735294][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.735295][ C2] ? do_syscall_64+0xa6/0x530 [ 8.735296][ C2] do_syscall_64+0xff/0x530 [ 8.735298][ C2] ? exc_page_fault+0xee/0x100 [ 8.735299][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.735300][ C2] RIP: 0033:0x7f1d502af312 [ 8.735302][ 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 [ 8.735303][ C2] RSP: 002b:00007f1d4fa2c988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.735304][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007f1d502af312 [ 8.735305][ C2] RDX: 0000000000000010 RSI: 00007f1d4fa2cc40 RDI: 000000000000000a [ 8.735306][ C2] RBP: 00007f1d4fa2c9b0 R08: 0000000000000000 R09: 0000000000000000 [ 8.735306][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1d4fa2cc40 [ 8.735307][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 8.735309][ C2] [ 9.771390][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.771397][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.771398][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 9.771399][ C2] preempt_count: 102, expected: 0 [ 9.771400][ C2] RCU nest depth: 0, expected: 0 [ 9.771401][ C2] INFO: lockdep is turned off. [ 9.771402][ C2] irq event stamp: 261914 [ 9.771402][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 9.771408][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 9.771410][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 9.771413][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 9.771415][ C2] Preemption disabled at: [ 9.771416][ C2] [<0000000000000000>] 0x0 [ 9.771420][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.771423][ C2] Tainted: [W]=WARN [ 9.771424][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.771425][ C2] Call Trace: [ 9.771426][ C2] [ 9.771428][ C2] dump_stack_lvl+0x6f/0xa0 [ 9.771432][ C2] __might_resched.cold+0x1fe/0x2c1 [ 9.771435][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.771438][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771442][ C2] __kmalloc_noprof+0x443/0x760 [ 9.771445][ C2] ? __rwlock_init+0x150/0x150 [ 9.771447][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 9.771450][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.771452][ C2] alloc_buf.isra.0+0x4b/0x260 [ 9.771453][ C2] put_chars+0x1e1/0x2f0 [ 9.771455][ C2] ? __send_to_port+0x420/0x420 [ 9.771457][ C2] ? printk_get_next_message+0x240/0x650 [ 9.771460][ C2] hvc_console_print+0x292/0x780 [ 9.771463][ C2] ? hvc_write+0x3a0/0x3a0 [ 9.771465][ C2] ? __rwlock_init+0x150/0x150 [ 9.771466][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771468][ C2] ? lock_acquire+0x13c/0x160 [ 9.771470][ C2] console_emit_next_record+0x22f/0x4c0 [ 9.771472][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 9.771474][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771476][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771477][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771479][ C2] ? lock_acquire+0x13c/0x160 [ 9.771481][ C2] ? console_flush_one_record+0x111/0x710 [ 9.771482][ C2] console_flush_one_record+0x46f/0x710 [ 9.771484][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 9.771487][ C2] console_unlock+0xee/0x1f0 [ 9.771489][ C2] ? lock_acquire+0x13c/0x160 [ 9.771490][ C2] ? console_flush_one_record+0x710/0x710 [ 9.771492][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771493][ C2] ? lock_release+0x184/0x1f0 [ 9.771494][ C2] ? lock_acquire+0x60/0x160 [ 9.771496][ C2] ? __rcu_read_lock+0x30/0x70 [ 9.771498][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.771500][ C2] ? vprintk_emit+0x320/0x3e0 [ 9.771501][ C2] vprintk_emit+0x37c/0x3e0 [ 9.771504][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 9.771505][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 9.771507][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771509][ C2] ? lock_acquire+0x13c/0x160 [ 9.771510][ C2] _printk+0xc7/0x100 [ 9.771512][ C2] ? snapshot_read.cold+0x21/0x21 [ 9.771514][ C2] ? ___ratelimit+0x4e7/0xa00 [ 9.771516][ C2] ? trace_hardirqs_on+0x36/0x40 [ 9.771519][ C2] ? idr_get_free+0x830/0x830 [ 9.771520][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 9.771522][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.771525][ C2] ? tcp_send_synack+0x1570/0x1570 [ 9.771528][ C2] ? lock_release+0x184/0x1f0 [ 9.771529][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771531][ C2] ? inet_csk_route_req+0x747/0xc30 [ 9.771534][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.771536][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.771538][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 9.771541][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.771542][ C2] ? trace_hardirqs_on+0x36/0x40 [ 9.771543][ C2] ? get_random_u16+0x740/0x740 [ 9.771546][ C2] tcp_rtx_synack+0x150/0x440 [ 9.771547][ C2] ? tcp_send_probe0+0x590/0x590 [ 9.771549][ C2] ? sched_balance_rq+0x324/0x1e30 [ 9.771556][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.771557][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 9.771559][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.771561][ C2] ? lock_acquire+0x6a/0x160 [ 9.771562][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.771564][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.771565][ C2] call_timer_fn+0x160/0x4d0 [ 9.771568][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 9.771570][ C2] ? debug_object_active_state+0x430/0x430 [ 9.771574][ C2] ? __rwlock_init+0x150/0x150 [ 9.771575][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 9.771577][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771579][ C2] __run_timers+0x68f/0xaa0 [ 9.771581][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.771583][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 9.771585][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.771587][ C2] ? __rwlock_init+0x150/0x150 [ 9.771589][ C2] run_timer_softirq+0xf0/0x160 [ 9.771591][ C2] ? __run_timers+0xaa0/0xaa0 [ 9.771593][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.771594][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771596][ C2] handle_softirqs+0x1d3/0x900 [ 9.771598][ C2] ? _local_bh_enable+0xc0/0xc0 [ 9.771599][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771601][ C2] ? lock_release+0x184/0x1f0 [ 9.771602][ C2] __irq_exit_rcu+0x145/0x1c0 [ 9.771604][ C2] irq_exit_rcu+0xe/0x30 [ 9.771605][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 9.771607][ C2] [ 9.771608][ C2] [ 9.771608][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 9.771610][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 9.771612][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 9.771614][ 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 [ 9.771615][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 9.771617][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 9.771618][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 9.771619][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 9.771620][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 9.771621][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 9.771622][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 9.771624][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.771626][ C2] default_idle+0x9/0x10 [ 9.771627][ C2] default_idle_call+0x6e/0xb0 [ 9.771629][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.771630][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 9.771632][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 9.771635][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.771637][ C2] do_idle+0xd8/0x190 [ 9.771638][ C2] cpu_startup_entry+0x53/0x70 [ 9.771639][ C2] start_secondary+0x204/0x2b0 [ 9.771641][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 9.771643][ C2] common_startup_64+0x13e/0x148 [ 9.771647][ C2] [ 9.898429][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.922370][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.922376][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.922378][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 10.922379][ C2] preempt_count: 102, expected: 0 [ 10.922380][ C2] RCU nest depth: 0, expected: 0 [ 10.922381][ C2] INFO: lockdep is turned off. [ 10.922381][ C2] irq event stamp: 261914 [ 10.922382][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 10.922388][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 10.922390][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 10.922393][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 10.922395][ C2] Preemption disabled at: [ 10.922396][ C2] [<0000000000000000>] 0x0 [ 10.922400][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.922403][ C2] Tainted: [W]=WARN [ 10.922404][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.922405][ C2] Call Trace: [ 10.922406][ C2] [ 10.922407][ C2] dump_stack_lvl+0x6f/0xa0 [ 10.922411][ C2] __might_resched.cold+0x1fe/0x2c1 [ 10.922414][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.922418][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922421][ C2] __kmalloc_noprof+0x443/0x760 [ 10.922424][ C2] ? __rwlock_init+0x150/0x150 [ 10.922426][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 10.922429][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 10.922431][ C2] alloc_buf.isra.0+0x4b/0x260 [ 10.922433][ C2] put_chars+0x1e1/0x2f0 [ 10.922435][ C2] ? __send_to_port+0x420/0x420 [ 10.922436][ C2] ? printk_get_next_message+0x240/0x650 [ 10.922439][ C2] hvc_console_print+0x292/0x780 [ 10.922443][ C2] ? hvc_write+0x3a0/0x3a0 [ 10.922444][ C2] ? __rwlock_init+0x150/0x150 [ 10.922446][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922448][ C2] ? lock_acquire+0x13c/0x160 [ 10.922450][ C2] console_emit_next_record+0x22f/0x4c0 [ 10.922452][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 10.922454][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922455][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922457][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922458][ C2] ? lock_acquire+0x13c/0x160 [ 10.922460][ C2] ? console_flush_one_record+0x111/0x710 [ 10.922462][ C2] console_flush_one_record+0x46f/0x710 [ 10.922464][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 10.922466][ C2] console_unlock+0xee/0x1f0 [ 10.922468][ C2] ? lock_acquire+0x13c/0x160 [ 10.922470][ C2] ? console_flush_one_record+0x710/0x710 [ 10.922471][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922473][ C2] ? lock_release+0x184/0x1f0 [ 10.922474][ C2] ? lock_acquire+0x60/0x160 [ 10.922475][ C2] ? __rcu_read_lock+0x30/0x70 [ 10.922478][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.922479][ C2] ? vprintk_emit+0x320/0x3e0 [ 10.922481][ C2] vprintk_emit+0x37c/0x3e0 [ 10.922483][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 10.922485][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 10.922486][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922488][ C2] ? lock_acquire+0x13c/0x160 [ 10.922490][ C2] _printk+0xc7/0x100 [ 10.922492][ C2] ? snapshot_read.cold+0x21/0x21 [ 10.922494][ C2] ? ___ratelimit+0x4e7/0xa00 [ 10.922496][ C2] ? trace_hardirqs_on+0x36/0x40 [ 10.922498][ C2] ? idr_get_free+0x830/0x830 [ 10.922500][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.922501][ C2] tcp_make_synack.cold+0x36/0xb6 [ 10.922505][ C2] ? tcp_send_synack+0x1570/0x1570 [ 10.922507][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922509][ C2] ? inet_csk_route_req+0x747/0xc30 [ 10.922512][ C2] tcp_v4_send_synack+0x103/0xb20 [ 10.922514][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 10.922516][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 10.922518][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.922520][ C2] ? trace_hardirqs_on+0x36/0x40 [ 10.922521][ C2] ? get_random_u16+0x740/0x740 [ 10.922523][ C2] tcp_rtx_synack+0x150/0x440 [ 10.922525][ C2] ? trace_pelt_cfs_tp+0x9b/0x190 [ 10.922527][ C2] ? tcp_send_probe0+0x590/0x590 [ 10.922528][ C2] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 10.922531][ C2] ? update_cfs_rq_load_avg+0x4b/0x660 [ 10.922533][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 10.922535][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.922536][ C2] ? lock_acquire+0x6a/0x160 [ 10.922537][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 10.922539][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.922540][ C2] call_timer_fn+0x160/0x4d0 [ 10.922543][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 10.922545][ C2] ? debug_object_active_state+0x430/0x430 [ 10.922549][ C2] ? trace_sched_wakeup+0x9b/0x160 [ 10.922551][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.922552][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922554][ C2] __run_timers+0x68f/0xaa0 [ 10.922556][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.922558][ C2] ? debug_object_deactivate+0x2f7/0x440 [ 10.922563][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.922565][ C2] ? do_raw_spin_lock+0x131/0x280 [ 10.922568][ C2] ? __rwlock_init+0x150/0x150 [ 10.922570][ C2] run_timer_softirq+0xf0/0x160 [ 10.922572][ C2] ? __run_timers+0xaa0/0xaa0 [ 10.922573][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.922575][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922576][ C2] handle_softirqs+0x1d3/0x900 [ 10.922578][ C2] ? _local_bh_enable+0xc0/0xc0 [ 10.922580][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922581][ C2] ? lock_release+0x184/0x1f0 [ 10.922583][ C2] __irq_exit_rcu+0x145/0x1c0 [ 10.922585][ C2] irq_exit_rcu+0xe/0x30 [ 10.922586][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.922588][ C2] [ 10.922588][ C2] [ 10.922589][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 10.922591][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.922593][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.922595][ 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.922596][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 10.922598][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 10.922599][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 10.922600][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 10.922601][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 10.922602][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.922603][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.922605][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.922607][ C2] default_idle+0x9/0x10 [ 10.922608][ C2] default_idle_call+0x6e/0xb0 [ 10.922609][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.922611][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 10.922612][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 10.922615][ C2] ? rcu_is_watching+0x16/0xd0 [ 10.922617][ C2] do_idle+0xd8/0x190 [ 10.922618][ C2] cpu_startup_entry+0x53/0x70 [ 10.922619][ C2] start_secondary+0x204/0x2b0 [ 10.922621][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.922623][ C2] common_startup_64+0x13e/0x148 [ 10.922627][ C2] [ 10.948358][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.011367][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.011372][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.011374][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 12.011375][ C2] preempt_count: 102, expected: 0 [ 12.011376][ C2] RCU nest depth: 0, expected: 0 [ 12.011376][ C2] INFO: lockdep is turned off. [ 12.011377][ C2] irq event stamp: 261914 [ 12.011378][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 12.011382][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 12.011384][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 12.011387][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 12.011389][ C2] Preemption disabled at: [ 12.011390][ C2] [<0000000000000000>] 0x0 [ 12.011394][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.011397][ C2] Tainted: [W]=WARN [ 12.011397][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.011398][ C2] Call Trace: [ 12.011399][ C2] [ 12.011401][ C2] dump_stack_lvl+0x6f/0xa0 [ 12.011405][ C2] __might_resched.cold+0x1fe/0x2c1 [ 12.011407][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.011410][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011413][ C2] __kmalloc_noprof+0x443/0x760 [ 12.011416][ C2] ? __rwlock_init+0x150/0x150 [ 12.011417][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 12.011420][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 12.011422][ C2] alloc_buf.isra.0+0x4b/0x260 [ 12.011423][ C2] put_chars+0x1e1/0x2f0 [ 12.011425][ C2] ? __send_to_port+0x420/0x420 [ 12.011427][ C2] ? printk_get_next_message+0x240/0x650 [ 12.011429][ C2] hvc_console_print+0x292/0x780 [ 12.011432][ C2] ? hvc_write+0x3a0/0x3a0 [ 12.011434][ C2] ? __rwlock_init+0x150/0x150 [ 12.011435][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011437][ C2] ? lock_acquire+0x13c/0x160 [ 12.011439][ C2] console_emit_next_record+0x22f/0x4c0 [ 12.011441][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 12.011443][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011445][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011447][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011448][ C2] ? lock_acquire+0x13c/0x160 [ 12.011450][ C2] ? console_flush_one_record+0x111/0x710 [ 12.011452][ C2] console_flush_one_record+0x46f/0x710 [ 12.011454][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 12.011456][ C2] console_unlock+0xee/0x1f0 [ 12.011458][ C2] ? lock_acquire+0x13c/0x160 [ 12.011459][ C2] ? console_flush_one_record+0x710/0x710 [ 12.011461][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011463][ C2] ? lock_release+0x184/0x1f0 [ 12.011464][ C2] ? lock_acquire+0x60/0x160 [ 12.011465][ C2] ? __rcu_read_lock+0x30/0x70 [ 12.011467][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.011469][ C2] ? vprintk_emit+0x320/0x3e0 [ 12.011471][ C2] vprintk_emit+0x37c/0x3e0 [ 12.011473][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 12.011474][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 12.011476][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011478][ C2] ? lock_acquire+0x13c/0x160 [ 12.011479][ C2] _printk+0xc7/0x100 [ 12.011481][ C2] ? snapshot_read.cold+0x21/0x21 [ 12.011483][ C2] ? ___ratelimit+0x4e7/0xa00 [ 12.011485][ C2] ? trace_hardirqs_on+0x36/0x40 [ 12.011487][ C2] ? idr_get_free+0x830/0x830 [ 12.011488][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.011490][ C2] tcp_make_synack.cold+0x36/0xb6 [ 12.011493][ C2] ? tcp_send_synack+0x1570/0x1570 [ 12.011495][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011497][ C2] ? inet_csk_route_req+0x747/0xc30 [ 12.011500][ C2] tcp_v4_send_synack+0x103/0xb20 [ 12.011502][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.011504][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 12.011506][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.011507][ C2] ? trace_hardirqs_on+0x36/0x40 [ 12.011509][ C2] ? get_random_u16+0x740/0x740 [ 12.011511][ C2] tcp_rtx_synack+0x150/0x440 [ 12.011512][ C2] ? tcp_send_probe0+0x590/0x590 [ 12.011515][ C2] ? sched_balance_rq+0x324/0x1e30 [ 12.011516][ C2] ? do_raw_spin_lock+0x131/0x280 [ 12.011518][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 12.011520][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.011521][ C2] ? lock_acquire+0x6a/0x160 [ 12.011523][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 12.011524][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.011526][ C2] call_timer_fn+0x160/0x4d0 [ 12.011528][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 12.011529][ C2] ? debug_object_active_state+0x430/0x430 [ 12.011533][ C2] ? __rwlock_init+0x150/0x150 [ 12.011534][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.011536][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011538][ C2] __run_timers+0x68f/0xaa0 [ 12.011540][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.011541][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.011544][ C2] ? do_raw_spin_lock+0x131/0x280 [ 12.011546][ C2] ? __rwlock_init+0x150/0x150 [ 12.011548][ C2] run_timer_softirq+0xf0/0x160 [ 12.011550][ C2] ? __run_timers+0xaa0/0xaa0 [ 12.011551][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.011553][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011554][ C2] handle_softirqs+0x1d3/0x900 [ 12.011556][ C2] ? _local_bh_enable+0xc0/0xc0 [ 12.011558][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011559][ C2] ? lock_release+0x184/0x1f0 [ 12.011561][ C2] __irq_exit_rcu+0x145/0x1c0 [ 12.011562][ C2] irq_exit_rcu+0xe/0x30 [ 12.011564][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.011565][ C2] [ 12.011566][ C2] [ 12.011566][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 12.011568][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.011573][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.011575][ 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.011576][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 12.011578][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 12.011580][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 12.011580][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 12.011581][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 12.011582][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.011583][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.011585][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.011587][ C2] default_idle+0x9/0x10 [ 12.011588][ C2] default_idle_call+0x6e/0xb0 [ 12.011589][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.011591][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 12.011592][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 12.011594][ C2] ? rcu_is_watching+0x16/0xd0 [ 12.011596][ C2] do_idle+0xd8/0x190 [ 12.011598][ C2] cpu_startup_entry+0x53/0x70 [ 12.011599][ C2] start_secondary+0x204/0x2b0 [ 12.011601][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.011603][ C2] common_startup_64+0x13e/0x148 [ 12.011606][ C2] [ 12.039053][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.098367][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.098372][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.098374][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 13.098375][ C2] preempt_count: 102, expected: 0 [ 13.098376][ C2] RCU nest depth: 0, expected: 0 [ 13.098376][ C2] INFO: lockdep is turned off. [ 13.098377][ C2] irq event stamp: 261914 [ 13.098378][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 13.098381][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 13.098383][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 13.098385][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 13.098387][ C2] Preemption disabled at: [ 13.098387][ C2] [<0000000000000000>] 0x0 [ 13.098391][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.098394][ C2] Tainted: [W]=WARN [ 13.098394][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.098395][ C2] Call Trace: [ 13.098396][ C2] [ 13.098397][ C2] dump_stack_lvl+0x6f/0xa0 [ 13.098400][ C2] __might_resched.cold+0x1fe/0x2c1 [ 13.098402][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.098405][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098408][ C2] __kmalloc_noprof+0x443/0x760 [ 13.098410][ C2] ? __rwlock_init+0x150/0x150 [ 13.098412][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 13.098414][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 13.098415][ C2] alloc_buf.isra.0+0x4b/0x260 [ 13.098417][ C2] put_chars+0x1e1/0x2f0 [ 13.098419][ C2] ? __send_to_port+0x420/0x420 [ 13.098421][ C2] ? printk_get_next_message+0x240/0x650 [ 13.098423][ C2] hvc_console_print+0x292/0x780 [ 13.098426][ C2] ? hvc_write+0x3a0/0x3a0 [ 13.098427][ C2] ? __rwlock_init+0x150/0x150 [ 13.098429][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098430][ C2] ? lock_acquire+0x13c/0x160 [ 13.098432][ C2] console_emit_next_record+0x22f/0x4c0 [ 13.098434][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 13.098436][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098438][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098440][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098441][ C2] ? lock_acquire+0x13c/0x160 [ 13.098443][ C2] ? console_flush_one_record+0x111/0x710 [ 13.098445][ C2] console_flush_one_record+0x46f/0x710 [ 13.098447][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 13.098450][ C2] console_unlock+0xee/0x1f0 [ 13.098452][ C2] ? lock_acquire+0x13c/0x160 [ 13.098453][ C2] ? console_flush_one_record+0x710/0x710 [ 13.098455][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098456][ C2] ? lock_release+0x184/0x1f0 [ 13.098457][ C2] ? lock_acquire+0x60/0x160 [ 13.098459][ C2] ? __rcu_read_lock+0x30/0x70 [ 13.098461][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.098462][ C2] ? vprintk_emit+0x320/0x3e0 [ 13.098464][ C2] vprintk_emit+0x37c/0x3e0 [ 13.098466][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 13.098468][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 13.098470][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098471][ C2] ? lock_acquire+0x13c/0x160 [ 13.098473][ C2] _printk+0xc7/0x100 [ 13.098475][ C2] ? snapshot_read.cold+0x21/0x21 [ 13.098476][ C2] ? ___ratelimit+0x4e7/0xa00 [ 13.098478][ C2] ? trace_hardirqs_on+0x36/0x40 [ 13.098479][ C2] ? idr_get_free+0x830/0x830 [ 13.098481][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.098482][ C2] tcp_make_synack.cold+0x36/0xb6 [ 13.098485][ C2] ? tcp_send_synack+0x1570/0x1570 [ 13.098488][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098490][ C2] ? inet_csk_route_req+0x747/0xc30 [ 13.098492][ C2] tcp_v4_send_synack+0x103/0xb20 [ 13.098493][ C2] ? enqueue_task_fair+0x44a/0xa50 [ 13.098496][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.098497][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.098499][ C2] ? trace_hardirqs_on+0x36/0x40 [ 13.098500][ C2] ? lock_release+0x184/0x1f0 [ 13.098501][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 13.098503][ C2] ? get_random_u16+0x740/0x740 [ 13.098505][ C2] tcp_rtx_synack+0x150/0x440 [ 13.098506][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098508][ C2] ? tcp_send_probe0+0x590/0x590 [ 13.098510][ C2] ? lock_release+0x184/0x1f0 [ 13.098512][ C2] ? __queue_work+0x3ab/0xd30 [ 13.098514][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 13.098516][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.098517][ C2] ? lock_acquire+0x6a/0x160 [ 13.098519][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 13.098520][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.098521][ C2] call_timer_fn+0x160/0x4d0 [ 13.098524][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 13.098525][ C2] ? debug_object_active_state+0x430/0x430 [ 13.098528][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098531][ C2] __run_timers+0x68f/0xaa0 [ 13.098532][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.098534][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.098536][ C2] ? do_raw_spin_lock+0x131/0x280 [ 13.098538][ C2] ? __rwlock_init+0x150/0x150 [ 13.098540][ C2] run_timer_softirq+0xf0/0x160 [ 13.098542][ C2] ? __run_timers+0xaa0/0xaa0 [ 13.098544][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.098545][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098547][ C2] handle_softirqs+0x1d3/0x900 [ 13.098549][ C2] ? _local_bh_enable+0xc0/0xc0 [ 13.098550][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098552][ C2] ? lock_release+0x184/0x1f0 [ 13.098553][ C2] __irq_exit_rcu+0x145/0x1c0 [ 13.098555][ C2] irq_exit_rcu+0xe/0x30 [ 13.098556][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.098558][ C2] [ 13.098558][ C2] [ 13.098559][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 13.098560][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.098562][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.098563][ 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.098565][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 13.098567][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 13.098568][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 13.098568][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 13.098569][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 13.098570][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.098571][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.098573][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.098575][ C2] default_idle+0x9/0x10 [ 13.098576][ C2] default_idle_call+0x6e/0xb0 [ 13.098582][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.098583][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 13.098585][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 13.098587][ C2] ? rcu_is_watching+0x16/0xd0 [ 13.098589][ C2] do_idle+0xd8/0x190 [ 13.098590][ C2] cpu_startup_entry+0x53/0x70 [ 13.098591][ C2] start_secondary+0x204/0x2b0 [ 13.098593][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.098595][ C2] common_startup_64+0x13e/0x148 [ 13.098598][ C2] [ 13.125029][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.186367][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.186372][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.186373][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 14.186375][ C2] preempt_count: 102, expected: 0 [ 14.186375][ C2] RCU nest depth: 0, expected: 0 [ 14.186376][ C2] INFO: lockdep is turned off. [ 14.186377][ C2] irq event stamp: 261914 [ 14.186377][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 14.186381][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 14.186383][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 14.186385][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 14.186387][ C2] Preemption disabled at: [ 14.186387][ C2] [<0000000000000000>] 0x0 [ 14.186391][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.186393][ C2] Tainted: [W]=WARN [ 14.186394][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.186394][ C2] Call Trace: [ 14.186395][ C2] [ 14.186396][ C2] dump_stack_lvl+0x6f/0xa0 [ 14.186399][ C2] __might_resched.cold+0x1fe/0x2c1 [ 14.186401][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.186404][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186406][ C2] __kmalloc_noprof+0x443/0x760 [ 14.186408][ C2] ? __rwlock_init+0x150/0x150 [ 14.186410][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 14.186412][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 14.186414][ C2] alloc_buf.isra.0+0x4b/0x260 [ 14.186416][ C2] put_chars+0x1e1/0x2f0 [ 14.186417][ C2] ? __send_to_port+0x420/0x420 [ 14.186419][ C2] ? printk_get_next_message+0x240/0x650 [ 14.186422][ C2] hvc_console_print+0x292/0x780 [ 14.186424][ C2] ? hvc_write+0x3a0/0x3a0 [ 14.186426][ C2] ? __rwlock_init+0x150/0x150 [ 14.186427][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186429][ C2] ? lock_acquire+0x13c/0x160 [ 14.186431][ C2] console_emit_next_record+0x22f/0x4c0 [ 14.186433][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 14.186435][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186437][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186439][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186440][ C2] ? lock_acquire+0x13c/0x160 [ 14.186442][ C2] ? console_flush_one_record+0x111/0x710 [ 14.186444][ C2] console_flush_one_record+0x46f/0x710 [ 14.186447][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 14.186449][ C2] console_unlock+0xee/0x1f0 [ 14.186451][ C2] ? lock_acquire+0x13c/0x160 [ 14.186452][ C2] ? console_flush_one_record+0x710/0x710 [ 14.186454][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186455][ C2] ? lock_release+0x184/0x1f0 [ 14.186457][ C2] ? lock_acquire+0x60/0x160 [ 14.186458][ C2] ? __rcu_read_lock+0x30/0x70 [ 14.186460][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.186462][ C2] ? vprintk_emit+0x320/0x3e0 [ 14.186464][ C2] vprintk_emit+0x37c/0x3e0 [ 14.186466][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 14.186467][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 14.186469][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186471][ C2] ? lock_acquire+0x13c/0x160 [ 14.186473][ C2] _printk+0xc7/0x100 [ 14.186474][ C2] ? snapshot_read.cold+0x21/0x21 [ 14.186476][ C2] ? ___ratelimit+0x4e7/0xa00 [ 14.186478][ C2] ? idr_get_free+0x830/0x830 [ 14.186480][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.186481][ C2] tcp_make_synack.cold+0x36/0xb6 [ 14.186484][ C2] ? tcp_send_synack+0x1570/0x1570 [ 14.186486][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186488][ C2] ? inet_csk_route_req+0x747/0xc30 [ 14.186490][ C2] tcp_v4_send_synack+0x103/0xb20 [ 14.186492][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 14.186494][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.186496][ C2] ? trace_hardirqs_on+0x36/0x40 [ 14.186497][ C2] ? get_random_u16+0x740/0x740 [ 14.186499][ C2] tcp_rtx_synack+0x150/0x440 [ 14.186501][ C2] ? tcp_send_probe0+0x590/0x590 [ 14.186503][ C2] ? sched_balance_rq+0x324/0x1e30 [ 14.186505][ C2] ? do_raw_spin_lock+0x131/0x280 [ 14.186507][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 14.186508][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.186510][ C2] ? lock_acquire+0x6a/0x160 [ 14.186511][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 14.186513][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.186514][ C2] call_timer_fn+0x160/0x4d0 [ 14.186516][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 14.186518][ C2] ? debug_object_active_state+0x430/0x430 [ 14.186521][ C2] ? __rwlock_init+0x150/0x150 [ 14.186522][ C2] ? timer_recalc_next_expiry+0x71/0x210 [ 14.186524][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186526][ C2] __run_timers+0x68f/0xaa0 [ 14.186528][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.186530][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.186532][ C2] ? do_raw_spin_lock+0x131/0x280 [ 14.186534][ C2] ? __rwlock_init+0x150/0x150 [ 14.186536][ C2] run_timer_softirq+0xf0/0x160 [ 14.186538][ C2] ? __run_timers+0xaa0/0xaa0 [ 14.186540][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.186541][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186543][ C2] handle_softirqs+0x1d3/0x900 [ 14.186545][ C2] ? _local_bh_enable+0xc0/0xc0 [ 14.186546][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186548][ C2] ? lock_release+0x184/0x1f0 [ 14.186549][ C2] __irq_exit_rcu+0x145/0x1c0 [ 14.186551][ C2] irq_exit_rcu+0xe/0x30 [ 14.186552][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.186554][ C2] [ 14.186554][ C2] [ 14.186555][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 14.186556][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.186558][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.186559][ 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 [ 14.186561][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 14.186563][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 14.186564][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 14.186564][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 14.186565][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 14.186566][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.186567][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.186569][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.186571][ C2] default_idle+0x9/0x10 [ 14.186572][ C2] default_idle_call+0x6e/0xb0 [ 14.186573][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.186575][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 14.186577][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 14.186578][ C2] ? rcu_is_watching+0x16/0xd0 [ 14.186580][ C2] do_idle+0xd8/0x190 [ 14.186582][ C2] cpu_startup_entry+0x53/0x70 [ 14.186583][ C2] start_secondary+0x204/0x2b0 [ 14.186585][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.186591][ C2] common_startup_64+0x13e/0x148 [ 14.186594][ C2] [ 14.208795][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.210373][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.210379][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.210380][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 15.210381][ C2] preempt_count: 102, expected: 0 [ 15.210382][ C2] RCU nest depth: 0, expected: 0 [ 15.210383][ C2] INFO: lockdep is turned off. [ 15.210383][ C2] irq event stamp: 261914 [ 15.210384][ C2] hardirqs last enabled at (261913): [] default_idle_call+0x98/0xb0 [ 15.210387][ C2] hardirqs last disabled at (261914): [] __schedule+0x1246/0x20e0 [ 15.210389][ C2] softirqs last enabled at (261892): [] handle_softirqs+0x67c/0x900 [ 15.210391][ C2] softirqs last disabled at (261525): [] __irq_exit_rcu+0x145/0x1c0 [ 15.210393][ C2] Preemption disabled at: [ 15.210394][ C2] [<0000000000000000>] 0x0 [ 15.210397][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.210400][ C2] Tainted: [W]=WARN [ 15.210401][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.210402][ C2] Call Trace: [ 15.210402][ C2] [ 15.210404][ C2] dump_stack_lvl+0x6f/0xa0 [ 15.210406][ C2] __might_resched.cold+0x1fe/0x2c1 [ 15.210408][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.210411][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210413][ C2] __kmalloc_noprof+0x443/0x760 [ 15.210415][ C2] ? __rwlock_init+0x150/0x150 [ 15.210417][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 15.210419][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 15.210421][ C2] alloc_buf.isra.0+0x4b/0x260 [ 15.210422][ C2] put_chars+0x1e1/0x2f0 [ 15.210424][ C2] ? __send_to_port+0x420/0x420 [ 15.210426][ C2] ? printk_get_next_message+0x240/0x650 [ 15.210428][ C2] hvc_console_print+0x292/0x780 [ 15.210431][ C2] ? hvc_write+0x3a0/0x3a0 [ 15.210432][ C2] ? __rwlock_init+0x150/0x150 [ 15.210434][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210436][ C2] ? lock_acquire+0x13c/0x160 [ 15.210438][ C2] console_emit_next_record+0x22f/0x4c0 [ 15.210440][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 15.210442][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210444][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210445][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210447][ C2] ? lock_acquire+0x13c/0x160 [ 15.210449][ C2] ? console_flush_one_record+0x111/0x710 [ 15.210450][ C2] console_flush_one_record+0x46f/0x710 [ 15.210452][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 15.210455][ C2] console_unlock+0xee/0x1f0 [ 15.210457][ C2] ? lock_acquire+0x13c/0x160 [ 15.210458][ C2] ? console_flush_one_record+0x710/0x710 [ 15.210460][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210461][ C2] ? lock_release+0x184/0x1f0 [ 15.210463][ C2] ? lock_acquire+0x60/0x160 [ 15.210464][ C2] ? __rcu_read_lock+0x30/0x70 [ 15.210466][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.210467][ C2] ? vprintk_emit+0x320/0x3e0 [ 15.210469][ C2] vprintk_emit+0x37c/0x3e0 [ 15.210471][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 15.210473][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 15.210475][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210476][ C2] ? lock_acquire+0x13c/0x160 [ 15.210478][ C2] _printk+0xc7/0x100 [ 15.210480][ C2] ? snapshot_read.cold+0x21/0x21 [ 15.210481][ C2] ? ___ratelimit+0x4e7/0xa00 [ 15.210483][ C2] ? trace_hardirqs_on+0x36/0x40 [ 15.210485][ C2] ? idr_get_free+0x830/0x830 [ 15.210486][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.210488][ C2] tcp_make_synack.cold+0x36/0xb6 [ 15.210490][ C2] ? tcp_send_synack+0x1570/0x1570 [ 15.210492][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210494][ C2] ? inet_csk_route_req+0x747/0xc30 [ 15.210496][ C2] tcp_v4_send_synack+0x103/0xb20 [ 15.210498][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.210500][ C2] ? sched_balance_find_src_group+0xda/0x760 [ 15.210502][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.210503][ C2] ? trace_hardirqs_on+0x36/0x40 [ 15.210505][ C2] ? get_random_u16+0x740/0x740 [ 15.210507][ C2] tcp_rtx_synack+0x150/0x440 [ 15.210508][ C2] ? tcp_send_probe0+0x590/0x590 [ 15.210511][ C2] ? sched_balance_rq+0x324/0x1e30 [ 15.210512][ C2] ? do_raw_spin_lock+0x131/0x280 [ 15.210514][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 15.210516][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.210517][ C2] ? lock_acquire+0x6a/0x160 [ 15.210519][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 15.210520][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.210521][ C2] call_timer_fn+0x160/0x4d0 [ 15.210524][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 15.210525][ C2] ? debug_object_active_state+0x430/0x430 [ 15.210528][ C2] ? __rwlock_init+0x150/0x150 [ 15.210529][ C2] ? timer_recalc_next_expiry+0x71/0x210 [ 15.210531][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210533][ C2] __run_timers+0x68f/0xaa0 [ 15.210535][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.210537][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.210539][ C2] ? do_raw_spin_lock+0x131/0x280 [ 15.210541][ C2] ? __rwlock_init+0x150/0x150 [ 15.210543][ C2] run_timer_softirq+0xf0/0x160 [ 15.210545][ C2] ? __run_timers+0xaa0/0xaa0 [ 15.210547][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.210548][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210549][ C2] handle_softirqs+0x1d3/0x900 [ 15.210552][ C2] ? _local_bh_enable+0xc0/0xc0 [ 15.210553][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210555][ C2] ? lock_release+0x184/0x1f0 [ 15.210556][ C2] __irq_exit_rcu+0x145/0x1c0 [ 15.210558][ C2] irq_exit_rcu+0xe/0x30 [ 15.210559][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.210560][ C2] [ 15.210561][ C2] [ 15.210561][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 15.210563][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.210564][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.210566][ 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.210567][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 15.210569][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 15.210570][ C2] RDX: 0000000000000002 RSI: ffffffffba28dc60 RDI: ffffffffb78fa307 [ 15.210571][ C2] RBP: 0000000000000000 R08: ffffffffb9f1f421 R09: 1fe2200006a663a2 [ 15.210572][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 15.210572][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.210574][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.210575][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.210577][ C2] default_idle+0x9/0x10 [ 15.210578][ C2] default_idle_call+0x6e/0xb0 [ 15.210580][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.210581][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 15.210583][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 15.210585][ C2] ? rcu_is_watching+0x16/0xd0 [ 15.210587][ C2] do_idle+0xd8/0x190 [ 15.210588][ C2] cpu_startup_entry+0x53/0x70 [ 15.210589][ C2] start_secondary+0x204/0x2b0 [ 15.210591][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.210593][ C2] common_startup_64+0x13e/0x148 [ 15.210600][ C2]