[ 9.543578][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.543606][ C1] [ 9.543608][ C1] ======================================================== [ 9.543609][ C1] WARNING: possible irq lock inversion dependency detected [ 9.543611][ C1] 7.2.0-virtme #1 Tainted: G W [ 9.543612][ C1] -------------------------------------------------------- [ 9.543613][ C1] connect-deny_ip/169 just changed the state of lock: [ 9.543614][ C1] ffffffffb5499660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.543628][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 9.543629][ C1] (fs_reclaim){+.+.}-{0:0} [ 9.543630][ C1] [ 9.543630][ C1] [ 9.543630][ C1] and interrupts could create inverse lock ordering between them. [ 9.543630][ C1] [ 9.543631][ C1] [ 9.543631][ C1] other info that might help us debug this: [ 9.543632][ C1] Possible interrupt unsafe locking scenario: [ 9.543632][ C1] [ 9.543632][ C1] CPU0 CPU1 [ 9.543633][ C1] ---- ---- [ 9.543633][ C1] lock(fs_reclaim); [ 9.543634][ C1] local_irq_disable(); [ 9.543635][ C1] lock(console_owner); [ 9.543636][ C1] lock(fs_reclaim); [ 9.543636][ C1] [ 9.543637][ C1] lock(console_owner); [ 9.543638][ C1] [ 9.543638][ C1] *** DEADLOCK *** [ 9.543638][ C1] [ 9.543638][ C1] locks held by connect-deny_ip/169: 9, last CPU#1: [ 9.543639][ C1] #0: ff1100000fb02b10 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 9.543645][ C1] #1: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 9.543649][ C1] #2: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 9.543652][ C1] #3: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 9.543655][ C1] #4: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 9.543660][ C1] #5: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 9.543663][ C1] #6: ffffffffb5590b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 9.543668][ C1] #7: ffffffffb5579cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.543671][ C1] #8: ffffffffb5579d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.543674][ C1] [ 9.543674][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 9.543679][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 9.543681][ C1] HARDIRQ-ON-W at: [ 9.543683][ C1] __lock_acquire+0x388/0xc20 [ 9.543686][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543687][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.543690][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.543692][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.543695][ C1] workqueue_init+0x2a/0x680 [ 9.543698][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.543701][ C1] kernel_init+0x21/0x150 [ 9.543704][ C1] ret_from_fork+0x474/0x6b0 [ 9.543707][ C1] ret_from_fork_asm+0x11/0x20 [ 9.543710][ C1] SOFTIRQ-ON-W at: [ 9.543711][ C1] __lock_acquire+0x388/0xc20 [ 9.543712][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543714][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.543715][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.543716][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.543717][ C1] workqueue_init+0x2a/0x680 [ 9.543718][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.543720][ C1] kernel_init+0x21/0x150 [ 9.543721][ C1] ret_from_fork+0x474/0x6b0 [ 9.543722][ C1] ret_from_fork_asm+0x11/0x20 [ 9.543724][ C1] INITIAL USE at: [ 9.543724][ C1] __lock_acquire+0x388/0xc20 [ 9.543726][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543727][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.543728][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.543730][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.543731][ C1] workqueue_init+0x2a/0x680 [ 9.543732][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.543734][ C1] kernel_init+0x21/0x150 [ 9.543735][ C1] ret_from_fork+0x474/0x6b0 [ 9.543736][ C1] ret_from_fork_asm+0x11/0x20 [ 9.543737][ C1] } [ 9.543738][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 9.543742][ C1] ... acquired at: [ 9.543742][ C1] __lock_acquire+0x518/0xc20 [ 9.543744][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543745][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.543746][ C1] __kmalloc_noprof+0xd3/0x760 [ 9.543748][ C1] alloc_buf.isra.0+0x4b/0x260 [ 9.543751][ C1] put_chars+0x1e1/0x2f0 [ 9.543753][ C1] hvc_console_print+0x292/0x780 [ 9.543755][ C1] console_emit_next_record+0x22f/0x4c0 [ 9.543757][ C1] console_flush_one_record+0x46f/0x710 [ 9.543759][ C1] console_unlock+0xee/0x1f0 [ 9.543760][ C1] vprintk_emit+0x37c/0x3e0 [ 9.543762][ C1] _printk+0xc7/0x100 [ 9.543765][ C1] register_key_type.cold+0x6d/0xeb [ 9.543767][ C1] init_dns_resolver+0x6f/0x160 [ 9.543769][ C1] do_one_initcall+0x124/0x4f0 [ 9.543771][ C1] kernel_init_freeable+0x596/0x630 [ 9.543773][ C1] kernel_init+0x21/0x150 [ 9.543774][ C1] ret_from_fork+0x474/0x6b0 [ 9.543775][ C1] ret_from_fork_asm+0x11/0x20 [ 9.543776][ C1] [ 9.543777][ C1] -> (console_owner){..-.}-{0:0} { [ 9.543778][ C1] IN-SOFTIRQ-W at: [ 9.543779][ C1] __lock_acquire+0x388/0xc20 [ 9.543780][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543782][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.543784][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.543785][ C1] console_flush_one_record+0x46f/0x710 [ 9.543787][ C1] console_unlock+0xee/0x1f0 [ 9.543788][ C1] vprintk_emit+0x37c/0x3e0 [ 9.543790][ C1] _printk+0xc7/0x100 [ 9.543791][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.543794][ C1] tcp_v4_send_synack+0x103/0xb20 [ 9.543796][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.543798][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.543799][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.543801][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 9.543802][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 9.543804][ C1] ip_local_deliver_finish+0x36f/0x610 [ 9.543805][ C1] ip_local_deliver+0x184/0x4c0 [ 9.543806][ C1] ip_rcv+0xdc/0x3d0 [ 9.543808][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.543809][ C1] process_backlog+0x431/0x14c0 [ 9.543811][ C1] __napi_poll+0xa7/0x3b0 [ 9.543813][ C1] net_rx_action+0x513/0xf50 [ 9.543815][ C1] handle_softirqs+0x1d3/0x900 [ 9.543817][ C1] do_softirq+0xac/0xe0 [ 9.543818][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.543820][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.543821][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 9.543823][ C1] ip_output+0x1ca/0x660 [ 9.543824][ C1] __ip_queue_xmit+0x774/0x1650 [ 9.543826][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.543827][ C1] tcp_connect+0x1024/0x1e20 [ 9.543828][ C1] tcp_v4_connect+0x12bd/0x1960 [ 9.543829][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.543831][ C1] inet_stream_connect+0x59/0xb0 [ 9.543832][ C1] __sys_connect+0x1cf/0x2e0 [ 9.543835][ C1] __x64_sys_connect+0x72/0xd0 [ 9.543836][ C1] do_syscall_64+0xff/0x530 [ 9.543839][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.543840][ C1] INITIAL USE at: [ 9.543841][ C1] } [ 9.543842][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 9.543845][ C1] ... acquired at: [ 9.543846][ C1] mark_lock+0x1d7/0xa00 [ 9.543847][ C1] mark_usage+0x42/0x170 [ 9.543848][ C1] __lock_acquire+0x388/0xc20 [ 9.543850][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543851][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.543852][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.543854][ C1] console_flush_one_record+0x46f/0x710 [ 9.543856][ C1] console_unlock+0xee/0x1f0 [ 9.543857][ C1] vprintk_emit+0x37c/0x3e0 [ 9.543859][ C1] _printk+0xc7/0x100 [ 9.543860][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.543861][ C1] tcp_v4_send_synack+0x103/0xb20 [ 9.543863][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.543864][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.543866][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.543868][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 9.543869][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 9.543870][ C1] ip_local_deliver_finish+0x36f/0x610 [ 9.543872][ C1] ip_local_deliver+0x184/0x4c0 [ 9.543873][ C1] ip_rcv+0xdc/0x3d0 [ 9.543874][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.543876][ C1] process_backlog+0x431/0x14c0 [ 9.543878][ C1] __napi_poll+0xa7/0x3b0 [ 9.543879][ C1] net_rx_action+0x513/0xf50 [ 9.543881][ C1] handle_softirqs+0x1d3/0x900 [ 9.543882][ C1] do_softirq+0xac/0xe0 [ 9.543883][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.543884][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.543886][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 9.543887][ C1] ip_output+0x1ca/0x660 [ 9.543889][ C1] __ip_queue_xmit+0x774/0x1650 [ 9.543890][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.543891][ C1] tcp_connect+0x1024/0x1e20 [ 9.543892][ C1] tcp_v4_connect+0x12bd/0x1960 [ 9.543894][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.543895][ C1] inet_stream_connect+0x59/0xb0 [ 9.543896][ C1] __sys_connect+0x1cf/0x2e0 [ 9.543897][ C1] __x64_sys_connect+0x72/0xd0 [ 9.543899][ C1] do_syscall_64+0xff/0x530 [ 9.543900][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.543901][ C1] [ 9.543902][ C1] [ 9.543902][ C1] stack backtrace: [ 9.543905][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.543908][ C1] Tainted: [W]=WARN [ 9.543909][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.543912][ C1] Call Trace: [ 9.543913][ C1] [ 9.543914][ C1] dump_stack_lvl+0x6f/0xa0 [ 9.543918][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 9.543921][ C1] mark_lock_irq+0x989/0x9c0 [ 9.543923][ C1] mark_lock+0x1d7/0xa00 [ 9.543925][ C1] mark_usage+0x42/0x170 [ 9.543927][ C1] __lock_acquire+0x388/0xc20 [ 9.543929][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.543931][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 9.543933][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.543936][ C1] ? lock_acquire+0x13c/0x160 [ 9.543938][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.543940][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 9.543942][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.543944][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 9.543946][ C1] ? console_flush_one_record+0x106/0x710 [ 9.543948][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.543949][ C1] ? lock_acquire+0x13c/0x160 [ 9.543951][ C1] console_flush_one_record+0x46f/0x710 [ 9.543953][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 9.543955][ C1] ? __lock_acquire+0x518/0xc20 [ 9.543957][ C1] console_unlock+0xee/0x1f0 [ 9.543959][ C1] ? console_flush_one_record+0x710/0x710 [ 9.543961][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.543963][ C1] ? lock_acquire+0x60/0x160 [ 9.543964][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.543966][ C1] ? vprintk_emit+0x320/0x3e0 [ 9.543968][ C1] vprintk_emit+0x37c/0x3e0 [ 9.543970][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 9.543972][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.543974][ C1] _printk+0xc7/0x100 [ 9.543976][ C1] ? snapshot_read.cold+0x21/0x21 [ 9.543978][ C1] ? ___ratelimit+0x4e7/0xa00 [ 9.543981][ C1] ? idr_get_free+0x830/0x830 [ 9.543983][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.543985][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 9.543987][ C1] ? tcp_send_synack+0x1570/0x1570 [ 9.543988][ C1] ? _raw_spin_unlock_irqrestore+0x36/0x80 [ 9.543990][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.543992][ C1] ? add_timer_on+0x580/0x580 [ 9.543996][ C1] tcp_v4_send_synack+0x103/0xb20 [ 9.543998][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.544000][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 9.544003][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 9.544005][ C1] ? inet_csk_route_req+0x747/0xc30 [ 9.544007][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 9.544009][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.544011][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.544015][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.544017][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544019][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544021][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544022][ C1] ? down_read_nested+0xe7/0x500 [ 9.544024][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544026][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.544028][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.544030][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.544032][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 9.544034][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 9.544036][ C1] ? mark_usage+0x61/0x170 [ 9.544038][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 9.544040][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544042][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 9.544044][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 9.544045][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544047][ C1] ip_local_deliver_finish+0x36f/0x610 [ 9.544049][ C1] ip_local_deliver+0x184/0x4c0 [ 9.544051][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 9.544052][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 9.544055][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544056][ C1] ip_rcv+0xdc/0x3d0 [ 9.544058][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 9.544060][ C1] ? mark_usage+0x61/0x170 [ 9.544062][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544064][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.544066][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544067][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544069][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.544071][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544073][ C1] process_backlog+0x431/0x14c0 [ 9.544076][ C1] __napi_poll+0xa7/0x3b0 [ 9.544078][ C1] net_rx_action+0x513/0xf50 [ 9.544081][ C1] ? __napi_poll+0x3b0/0x3b0 [ 9.544083][ C1] ? find_held_lock+0x2b/0x80 [ 9.544086][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544087][ C1] ? mark_held_locks+0x40/0x70 [ 9.544089][ C1] handle_softirqs+0x1d3/0x900 [ 9.544091][ C1] ? _local_bh_enable+0xc0/0xc0 [ 9.544093][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544094][ C1] ? trace_csd_function_exit+0xb3/0x180 [ 9.544097][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 9.544099][ C1] do_softirq+0xac/0xe0 [ 9.544100][ C1] [ 9.544101][ C1] [ 9.544102][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.544103][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.544105][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.544108][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.544110][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544112][ C1] ? find_held_lock+0x2b/0x80 [ 9.544113][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.544114][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544116][ C1] ? mark_held_locks+0x40/0x70 [ 9.544118][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.544119][ C1] ? neigh_hh_output+0x152/0x4c0 [ 9.544121][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 9.544123][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 9.544125][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544127][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 9.544129][ C1] ip_output+0x1ca/0x660 [ 9.544131][ C1] ? ip_finish_output+0x460/0x460 [ 9.544133][ C1] ? find_held_lock+0x2b/0x80 [ 9.544134][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.544136][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 9.544138][ C1] __ip_queue_xmit+0x774/0x1650 [ 9.544140][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.544143][ C1] ? __tcp_select_window+0xf20/0xf20 [ 9.544145][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544146][ C1] ? ktime_get+0x18e/0x2d0 [ 9.544148][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 9.544151][ C1] ? ktime_get+0x1dd/0x2d0 [ 9.544153][ C1] tcp_connect+0x1024/0x1e20 [ 9.544155][ C1] tcp_v4_connect+0x12bd/0x1960 [ 9.544158][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 9.544160][ C1] ? do_raw_spin_lock+0x131/0x280 [ 9.544161][ C1] ? find_held_lock+0x2b/0x80 [ 9.544163][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.544165][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544166][ C1] inet_stream_connect+0x59/0xb0 [ 9.544168][ C1] __sys_connect+0x1cf/0x2e0 [ 9.544169][ C1] ? do_fcntl+0x36f/0xc50 [ 9.544172][ C1] ? __sys_connect_file+0x250/0x250 [ 9.544175][ C1] ? fput+0x1f/0xa0 [ 9.544177][ C1] __x64_sys_connect+0x72/0xd0 [ 9.544179][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544180][ C1] ? do_syscall_64+0xa6/0x530 [ 9.544182][ C1] do_syscall_64+0xff/0x530 [ 9.544183][ C1] ? exc_page_fault+0xee/0x100 [ 9.544185][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.544187][ C1] RIP: 0033:0x7fc8e97d6312 [ 9.544191][ C1] 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.544192][ C1] RSP: 002b:00007fc8e8f53988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.544195][ C1] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007fc8e97d6312 [ 9.544196][ C1] RDX: 0000000000000010 RSI: 00007fc8e8f53c40 RDI: 000000000000000a [ 9.544197][ C1] RBP: 00007fc8e8f539b0 R08: 0000000000000000 R09: 0000000000000000 [ 9.544198][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fc8e8f53c40 [ 9.544199][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 9.544201][ C1] [ 9.544206][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.544207][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 9.544208][ C1] preempt_count: 302, expected: 0 [ 9.544209][ C1] RCU nest depth: 6, expected: 0 [ 9.544210][ C1] INFO: lockdep is turned off. [ 9.544211][ C1] irq event stamp: 18065 [ 9.544211][ C1] hardirqs last enabled at (18064): [] __down_trylock_console_sem+0x86/0xa0 [ 9.544214][ C1] hardirqs last disabled at (18065): [] console_emit_next_record+0x3d4/0x4c0 [ 9.544215][ C1] softirqs last enabled at (17898): [] __dev_queue_xmit+0x964/0x1b80 [ 9.544221][ C1] softirqs last disabled at (17899): [] do_softirq+0xac/0xe0 [ 9.544222][ C1] Preemption disabled at: [ 9.544223][ C1] [] __dev_queue_xmit+0x204/0x1b80 [ 9.544226][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.544228][ C1] Tainted: [W]=WARN [ 9.544229][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.544229][ C1] Call Trace: [ 9.544230][ C1] [ 9.544230][ C1] dump_stack_lvl+0x6f/0xa0 [ 9.544233][ C1] ? __dev_queue_xmit+0x204/0x1b80 [ 9.544235][ C1] __might_resched.cold+0x1fe/0x2c1 [ 9.544237][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.544240][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544242][ C1] __kmalloc_noprof+0x443/0x760 [ 9.544244][ C1] ? __rwlock_init+0x150/0x150 [ 9.544246][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 9.544248][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.544249][ C1] alloc_buf.isra.0+0x4b/0x260 [ 9.544251][ C1] put_chars+0x1e1/0x2f0 [ 9.544253][ C1] ? __send_to_port+0x420/0x420 [ 9.544256][ C1] hvc_console_print+0x292/0x780 [ 9.544257][ C1] ? __lock_acquire+0x388/0xc20 [ 9.544260][ C1] ? hvc_write+0x3a0/0x3a0 [ 9.544261][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544263][ C1] ? lock_acquire+0x13c/0x160 [ 9.544265][ C1] console_emit_next_record+0x22f/0x4c0 [ 9.544267][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 9.544269][ C1] ? console_flush_one_record+0x106/0x710 [ 9.544271][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544272][ C1] ? lock_acquire+0x13c/0x160 [ 9.544274][ C1] console_flush_one_record+0x46f/0x710 [ 9.544277][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 9.544278][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544280][ C1] console_unlock+0xee/0x1f0 [ 9.544282][ C1] ? console_flush_one_record+0x710/0x710 [ 9.544284][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544286][ C1] ? lock_acquire+0x60/0x160 [ 9.544288][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.544289][ C1] ? vprintk_emit+0x320/0x3e0 [ 9.544291][ C1] vprintk_emit+0x37c/0x3e0 [ 9.544293][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 9.544295][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.544297][ C1] _printk+0xc7/0x100 [ 9.544299][ C1] ? snapshot_read.cold+0x21/0x21 [ 9.544300][ C1] ? ___ratelimit+0x4e7/0xa00 [ 9.544302][ C1] ? idr_get_free+0x830/0x830 [ 9.544304][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.544306][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 9.544308][ C1] ? tcp_send_synack+0x1570/0x1570 [ 9.544309][ C1] ? _raw_spin_unlock_irqrestore+0x36/0x80 [ 9.544311][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.544313][ C1] ? add_timer_on+0x580/0x580 [ 9.544315][ C1] tcp_v4_send_synack+0x103/0xb20 [ 9.544317][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.544319][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 9.544322][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 9.544323][ C1] ? inet_csk_route_req+0x747/0xc30 [ 9.544325][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 9.544327][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.544329][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.544331][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.544333][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544335][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544337][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544338][ C1] ? down_read_nested+0xe7/0x500 [ 9.544340][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544343][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.544345][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.544347][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.544349][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 9.544350][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 9.544353][ C1] ? mark_usage+0x61/0x170 [ 9.544354][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 9.544356][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544358][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 9.544360][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 9.544362][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544364][ C1] ip_local_deliver_finish+0x36f/0x610 [ 9.544365][ C1] ip_local_deliver+0x184/0x4c0 [ 9.544367][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 9.544369][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 9.544371][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544373][ C1] ip_rcv+0xdc/0x3d0 [ 9.544374][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 9.544376][ C1] ? mark_usage+0x61/0x170 [ 9.544378][ C1] ? __lock_acquire+0x518/0xc20 [ 9.544380][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.544382][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544383][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.544385][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.544387][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544389][ C1] process_backlog+0x431/0x14c0 [ 9.544392][ C1] __napi_poll+0xa7/0x3b0 [ 9.544394][ C1] net_rx_action+0x513/0xf50 [ 9.544397][ C1] ? __napi_poll+0x3b0/0x3b0 [ 9.544399][ C1] ? find_held_lock+0x2b/0x80 [ 9.544402][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544403][ C1] ? mark_held_locks+0x40/0x70 [ 9.544405][ C1] handle_softirqs+0x1d3/0x900 [ 9.544407][ C1] ? _local_bh_enable+0xc0/0xc0 [ 9.544409][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544410][ C1] ? trace_csd_function_exit+0xb3/0x180 [ 9.544412][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 9.544414][ C1] do_softirq+0xac/0xe0 [ 9.544415][ C1] [ 9.544416][ C1] [ 9.544416][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.544418][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.544420][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.544422][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.544424][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544425][ C1] ? find_held_lock+0x2b/0x80 [ 9.544426][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.544428][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.544430][ C1] ? mark_held_locks+0x40/0x70 [ 9.544431][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.544433][ C1] ? neigh_hh_output+0x152/0x4c0 [ 9.544435][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 9.544437][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 9.544438][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.544440][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 9.544442][ C1] ip_output+0x1ca/0x660 [ 9.544444][ C1] ? ip_finish_output+0x460/0x460 [ 9.544446][ C1] ? find_held_lock+0x2b/0x80 [ 9.544447][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.544449][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 9.544451][ C1] __ip_queue_xmit+0x774/0x1650 [ 9.544453][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.544456][ C1] ? __tcp_select_window+0xf20/0xf20 [ 9.544458][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544459][ C1] ? ktime_get+0x18e/0x2d0 [ 9.544460][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 9.544462][ C1] ? ktime_get+0x1dd/0x2d0 [ 9.544464][ C1] tcp_connect+0x1024/0x1e20 [ 9.544466][ C1] tcp_v4_connect+0x12bd/0x1960 [ 9.544469][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 9.544470][ C1] ? do_raw_spin_lock+0x131/0x280 [ 9.544472][ C1] ? find_held_lock+0x2b/0x80 [ 9.544474][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.544475][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544477][ C1] inet_stream_connect+0x59/0xb0 [ 9.544478][ C1] __sys_connect+0x1cf/0x2e0 [ 9.544480][ C1] ? do_fcntl+0x36f/0xc50 [ 9.544482][ C1] ? __sys_connect_file+0x250/0x250 [ 9.544484][ C1] ? fput+0x1f/0xa0 [ 9.544486][ C1] __x64_sys_connect+0x72/0xd0 [ 9.544488][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.544489][ C1] ? do_syscall_64+0xa6/0x530 [ 9.544490][ C1] do_syscall_64+0xff/0x530 [ 9.544492][ C1] ? exc_page_fault+0xee/0x100 [ 9.544493][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.544495][ C1] RIP: 0033:0x7fc8e97d6312 [ 9.544496][ C1] 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.544497][ C1] RSP: 002b:00007fc8e8f53988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.544498][ C1] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007fc8e97d6312 [ 9.544499][ C1] RDX: 0000000000000010 RSI: 00007fc8e8f53c40 RDI: 000000000000000a [ 9.544500][ C1] RBP: 00007fc8e8f539b0 R08: 0000000000000000 R09: 0000000000000000 [ 9.544501][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fc8e8f53c40 [ 9.544502][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 9.544504][ C1] [ 10.551347][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.551360][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.551362][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 10.551364][ C1] preempt_count: 102, expected: 0 [ 10.551365][ C1] RCU nest depth: 0, expected: 0 [ 10.551366][ C1] INFO: lockdep is turned off. [ 10.551367][ C1] irq event stamp: 301438 [ 10.551368][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 10.551377][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 10.551379][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 10.551382][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 10.551384][ C1] Preemption disabled at: [ 10.551385][ C1] [<0000000000000000>] 0x0 [ 10.551391][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.551394][ C1] Tainted: [W]=WARN [ 10.551395][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.551396][ C1] Call Trace: [ 10.551398][ C1] [ 10.551400][ C1] dump_stack_lvl+0x6f/0xa0 [ 10.551405][ C1] __might_resched.cold+0x1fe/0x2c1 [ 10.551409][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.551413][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551417][ C1] __kmalloc_noprof+0x443/0x760 [ 10.551420][ C1] ? __rwlock_init+0x150/0x150 [ 10.551423][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 10.551426][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.551428][ C1] alloc_buf.isra.0+0x4b/0x260 [ 10.551430][ C1] put_chars+0x1e1/0x2f0 [ 10.551433][ C1] ? __send_to_port+0x420/0x420 [ 10.551434][ C1] ? printk_get_next_message+0x240/0x650 [ 10.551438][ C1] hvc_console_print+0x292/0x780 [ 10.551442][ C1] ? hvc_write+0x3a0/0x3a0 [ 10.551443][ C1] ? __rwlock_init+0x150/0x150 [ 10.551445][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551447][ C1] ? lock_acquire+0x13c/0x160 [ 10.551449][ C1] console_emit_next_record+0x22f/0x4c0 [ 10.551452][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 10.551454][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551455][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551457][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551459][ C1] ? lock_acquire+0x13c/0x160 [ 10.551460][ C1] ? console_flush_one_record+0x111/0x710 [ 10.551462][ C1] console_flush_one_record+0x46f/0x710 [ 10.551464][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 10.551467][ C1] console_unlock+0xee/0x1f0 [ 10.551469][ C1] ? lock_acquire+0x13c/0x160 [ 10.551470][ C1] ? console_flush_one_record+0x710/0x710 [ 10.551472][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551474][ C1] ? lock_release+0x184/0x1f0 [ 10.551475][ C1] ? lock_acquire+0x60/0x160 [ 10.551476][ C1] ? __rcu_read_lock+0x30/0x70 [ 10.551478][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.551480][ C1] ? vprintk_emit+0x320/0x3e0 [ 10.551482][ C1] vprintk_emit+0x37c/0x3e0 [ 10.551485][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 10.551486][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 10.551488][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551490][ C1] ? lock_acquire+0x13c/0x160 [ 10.551492][ C1] _printk+0xc7/0x100 [ 10.551495][ C1] ? snapshot_read.cold+0x21/0x21 [ 10.551496][ C1] ? ___ratelimit+0x4e7/0xa00 [ 10.551499][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.551502][ C1] ? idr_get_free+0x830/0x830 [ 10.551504][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.551505][ C1] tcp_make_synack.cold+0x36/0xb6 [ 10.551509][ C1] ? tcp_send_synack+0x1570/0x1570 [ 10.551513][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551515][ C1] ? inet_csk_route_req+0x747/0xc30 [ 10.551517][ C1] tcp_v4_send_synack+0x103/0xb20 [ 10.551520][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 10.551522][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.551523][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.551525][ C1] ? get_random_u16+0x740/0x740 [ 10.551527][ C1] tcp_rtx_synack+0x150/0x440 [ 10.551529][ C1] ? tcp_send_probe0+0x590/0x590 [ 10.551531][ C1] ? sched_balance_rq+0x324/0x1e30 [ 10.551534][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 10.551536][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.551537][ C1] ? lock_acquire+0x6a/0x160 [ 10.551538][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.551540][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.551546][ C1] call_timer_fn+0x160/0x4d0 [ 10.551549][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 10.551551][ C1] ? debug_object_active_state+0x430/0x430 [ 10.551555][ C1] ? __rwlock_init+0x150/0x150 [ 10.551556][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.551558][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551560][ C1] __run_timers+0x68f/0xaa0 [ 10.551562][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.551564][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.551567][ C1] ? do_raw_spin_lock+0x131/0x280 [ 10.551569][ C1] ? __rwlock_init+0x150/0x150 [ 10.551571][ C1] run_timer_softirq+0xf0/0x160 [ 10.551573][ C1] ? __run_timers+0xaa0/0xaa0 [ 10.551575][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.551576][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551578][ C1] handle_softirqs+0x1d3/0x900 [ 10.551580][ C1] ? _local_bh_enable+0xc0/0xc0 [ 10.551581][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551583][ C1] ? lock_release+0x184/0x1f0 [ 10.551584][ C1] __irq_exit_rcu+0x145/0x1c0 [ 10.551586][ C1] irq_exit_rcu+0xe/0x30 [ 10.551588][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.551590][ C1] [ 10.551590][ C1] [ 10.551591][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 10.551592][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.551594][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.551597][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.551598][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 10.551602][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 10.551603][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 10.551604][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 10.551605][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 10.551605][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.551607][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.551608][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.551611][ C1] default_idle+0x9/0x10 [ 10.551612][ C1] default_idle_call+0x6e/0xb0 [ 10.551613][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.551615][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 10.551617][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 10.551619][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.551621][ C1] do_idle+0xd8/0x190 [ 10.551622][ C1] cpu_startup_entry+0x53/0x70 [ 10.551624][ C1] start_secondary+0x204/0x2b0 [ 10.551626][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.551627][ C1] common_startup_64+0x13e/0x148 [ 10.551632][ C1] [ 10.679418][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.702316][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.702331][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.702334][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 11.702335][ C1] preempt_count: 102, expected: 0 [ 11.702336][ C1] RCU nest depth: 0, expected: 0 [ 11.702337][ C1] INFO: lockdep is turned off. [ 11.702339][ C1] irq event stamp: 301438 [ 11.702339][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 11.702348][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 11.702350][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 11.702354][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 11.702357][ C1] Preemption disabled at: [ 11.702357][ C1] [<0000000000000000>] 0x0 [ 11.702365][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.702368][ C1] Tainted: [W]=WARN [ 11.702369][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.702371][ C1] Call Trace: [ 11.702372][ C1] [ 11.702374][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.702380][ C1] __might_resched.cold+0x1fe/0x2c1 [ 11.702384][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.702387][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702391][ C1] __kmalloc_noprof+0x443/0x760 [ 11.702395][ C1] ? __rwlock_init+0x150/0x150 [ 11.702397][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 11.702401][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.702403][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.702405][ C1] put_chars+0x1e1/0x2f0 [ 11.702408][ C1] ? __send_to_port+0x420/0x420 [ 11.702409][ C1] ? printk_get_next_message+0x240/0x650 [ 11.702413][ C1] hvc_console_print+0x292/0x780 [ 11.702416][ C1] ? hvc_write+0x3a0/0x3a0 [ 11.702418][ C1] ? __rwlock_init+0x150/0x150 [ 11.702419][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702421][ C1] ? lock_acquire+0x13c/0x160 [ 11.702423][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.702426][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.702428][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702430][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702431][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702433][ C1] ? lock_acquire+0x13c/0x160 [ 11.702435][ C1] ? console_flush_one_record+0x111/0x710 [ 11.702436][ C1] console_flush_one_record+0x46f/0x710 [ 11.702439][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.702441][ C1] console_unlock+0xee/0x1f0 [ 11.702443][ C1] ? lock_acquire+0x13c/0x160 [ 11.702444][ C1] ? console_flush_one_record+0x710/0x710 [ 11.702446][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702448][ C1] ? lock_release+0x184/0x1f0 [ 11.702449][ C1] ? lock_acquire+0x60/0x160 [ 11.702450][ C1] ? __rcu_read_lock+0x30/0x70 [ 11.702452][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.702454][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.702456][ C1] vprintk_emit+0x37c/0x3e0 [ 11.702458][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.702460][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 11.702462][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702463][ C1] ? lock_acquire+0x13c/0x160 [ 11.702465][ C1] _printk+0xc7/0x100 [ 11.702468][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.702470][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.702472][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.702475][ C1] ? idr_get_free+0x830/0x830 [ 11.702477][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 11.702478][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.702482][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.702486][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702488][ C1] ? inet_csk_route_req+0x747/0xc30 [ 11.702490][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.702493][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.702494][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 11.702497][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.702498][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.702500][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702502][ C1] ? get_random_u16+0x740/0x740 [ 11.702503][ C1] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 11.702505][ C1] ? debug_object_activate+0x345/0x4a0 [ 11.702509][ C1] tcp_rtx_synack+0x150/0x440 [ 11.702511][ C1] ? tcp_send_probe0+0x590/0x590 [ 11.702513][ C1] ? remove_and_enqueue_same_base+0x200/0x730 [ 11.702516][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.702518][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 11.702520][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.702521][ C1] ? lock_acquire+0x6a/0x160 [ 11.702522][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.702524][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.702525][ C1] call_timer_fn+0x160/0x4d0 [ 11.702527][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 11.702529][ C1] ? debug_object_active_state+0x430/0x430 [ 11.702532][ C1] ? __rwlock_init+0x150/0x150 [ 11.702533][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 11.702535][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702537][ C1] __run_timers+0x68f/0xaa0 [ 11.702539][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.702541][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.702543][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.702552][ C1] ? __rwlock_init+0x150/0x150 [ 11.702554][ C1] run_timer_softirq+0xf0/0x160 [ 11.702556][ C1] ? __run_timers+0xaa0/0xaa0 [ 11.702558][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.702559][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702561][ C1] handle_softirqs+0x1d3/0x900 [ 11.702563][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.702564][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702566][ C1] ? lock_release+0x184/0x1f0 [ 11.702568][ C1] __irq_exit_rcu+0x145/0x1c0 [ 11.702569][ C1] irq_exit_rcu+0xe/0x30 [ 11.702571][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.702573][ C1] [ 11.702573][ C1] [ 11.702574][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 11.702575][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.702578][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 11.702580][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.702582][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 11.702585][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 11.702587][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 11.702587][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 11.702588][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 11.702589][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 11.702590][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 11.702592][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.702594][ C1] default_idle+0x9/0x10 [ 11.702596][ C1] default_idle_call+0x6e/0xb0 [ 11.702597][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.702599][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 11.702600][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 11.702603][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.702605][ C1] do_idle+0xd8/0x190 [ 11.702606][ C1] cpu_startup_entry+0x53/0x70 [ 11.702608][ C1] start_secondary+0x204/0x2b0 [ 11.702609][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 11.702611][ C1] common_startup_64+0x13e/0x148 [ 11.702616][ C1] [ 11.723550][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.727334][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.727349][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.727352][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 12.727354][ C1] preempt_count: 102, expected: 0 [ 12.727355][ C1] RCU nest depth: 0, expected: 0 [ 12.727356][ C1] INFO: lockdep is turned off. [ 12.727357][ C1] irq event stamp: 301438 [ 12.727358][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 12.727366][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 12.727368][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 12.727372][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 12.727374][ C1] Preemption disabled at: [ 12.727375][ C1] [<0000000000000000>] 0x0 [ 12.727383][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.727386][ C1] Tainted: [W]=WARN [ 12.727387][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.727389][ C1] Call Trace: [ 12.727390][ C1] [ 12.727392][ C1] dump_stack_lvl+0x6f/0xa0 [ 12.727398][ C1] __might_resched.cold+0x1fe/0x2c1 [ 12.727402][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.727405][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727409][ C1] __kmalloc_noprof+0x443/0x760 [ 12.727412][ C1] ? __rwlock_init+0x150/0x150 [ 12.727415][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 12.727419][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.727420][ C1] alloc_buf.isra.0+0x4b/0x260 [ 12.727422][ C1] put_chars+0x1e1/0x2f0 [ 12.727424][ C1] ? __send_to_port+0x420/0x420 [ 12.727426][ C1] ? printk_get_next_message+0x240/0x650 [ 12.727430][ C1] hvc_console_print+0x292/0x780 [ 12.727434][ C1] ? hvc_write+0x3a0/0x3a0 [ 12.727435][ C1] ? __rwlock_init+0x150/0x150 [ 12.727437][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727439][ C1] ? lock_acquire+0x13c/0x160 [ 12.727441][ C1] console_emit_next_record+0x22f/0x4c0 [ 12.727443][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 12.727445][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727447][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727449][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727450][ C1] ? lock_acquire+0x13c/0x160 [ 12.727452][ C1] ? console_flush_one_record+0x111/0x710 [ 12.727454][ C1] console_flush_one_record+0x46f/0x710 [ 12.727456][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 12.727459][ C1] console_unlock+0xee/0x1f0 [ 12.727461][ C1] ? lock_acquire+0x13c/0x160 [ 12.727462][ C1] ? console_flush_one_record+0x710/0x710 [ 12.727464][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727466][ C1] ? lock_release+0x184/0x1f0 [ 12.727467][ C1] ? lock_acquire+0x60/0x160 [ 12.727469][ C1] ? __rcu_read_lock+0x30/0x70 [ 12.727471][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.727473][ C1] ? vprintk_emit+0x320/0x3e0 [ 12.727475][ C1] vprintk_emit+0x37c/0x3e0 [ 12.727477][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 12.727479][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 12.727480][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727482][ C1] ? lock_acquire+0x13c/0x160 [ 12.727484][ C1] _printk+0xc7/0x100 [ 12.727487][ C1] ? snapshot_read.cold+0x21/0x21 [ 12.727489][ C1] ? ___ratelimit+0x4e7/0xa00 [ 12.727491][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.727494][ C1] ? idr_get_free+0x830/0x830 [ 12.727496][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.727497][ C1] tcp_make_synack.cold+0x36/0xb6 [ 12.727501][ C1] ? tcp_send_synack+0x1570/0x1570 [ 12.727505][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727507][ C1] ? inet_csk_route_req+0x747/0xc30 [ 12.727510][ C1] tcp_v4_send_synack+0x103/0xb20 [ 12.727512][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.727513][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 12.727516][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.727518][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.727519][ C1] ? get_random_u16+0x740/0x740 [ 12.727521][ C1] tcp_rtx_synack+0x150/0x440 [ 12.727523][ C1] ? tcp_send_probe0+0x590/0x590 [ 12.727525][ C1] ? sched_balance_rq+0x324/0x1e30 [ 12.727528][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 12.727529][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.727531][ C1] ? lock_acquire+0x6a/0x160 [ 12.727532][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.727534][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.727535][ C1] call_timer_fn+0x160/0x4d0 [ 12.727538][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 12.727540][ C1] ? debug_object_active_state+0x430/0x430 [ 12.727544][ C1] ? __rwlock_init+0x150/0x150 [ 12.727545][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.727547][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727554][ C1] __run_timers+0x68f/0xaa0 [ 12.727556][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.727558][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.727561][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.727563][ C1] ? __rwlock_init+0x150/0x150 [ 12.727565][ C1] run_timer_softirq+0xf0/0x160 [ 12.727567][ C1] ? __run_timers+0xaa0/0xaa0 [ 12.727569][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.727570][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727572][ C1] handle_softirqs+0x1d3/0x900 [ 12.727574][ C1] ? _local_bh_enable+0xc0/0xc0 [ 12.727576][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727577][ C1] ? lock_release+0x184/0x1f0 [ 12.727579][ C1] __irq_exit_rcu+0x145/0x1c0 [ 12.727581][ C1] irq_exit_rcu+0xe/0x30 [ 12.727582][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.727584][ C1] [ 12.727584][ C1] [ 12.727585][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 12.727587][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.727589][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.727592][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.727594][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 12.727597][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 12.727598][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 12.727599][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 12.727600][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 12.727600][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.727602][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.727604][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.727606][ C1] default_idle+0x9/0x10 [ 12.727607][ C1] default_idle_call+0x6e/0xb0 [ 12.727609][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.727610][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 12.727612][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 12.727614][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.727616][ C1] do_idle+0xd8/0x190 [ 12.727618][ C1] cpu_startup_entry+0x53/0x70 [ 12.727619][ C1] start_secondary+0x204/0x2b0 [ 12.727621][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.727623][ C1] common_startup_64+0x13e/0x148 [ 12.727627][ C1] [ 12.749907][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.750324][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.750338][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.750340][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 13.750342][ C1] preempt_count: 102, expected: 0 [ 13.750343][ C1] RCU nest depth: 0, expected: 0 [ 13.750344][ C1] INFO: lockdep is turned off. [ 13.750345][ C1] irq event stamp: 301438 [ 13.750345][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 13.750354][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 13.750357][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 13.750361][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 13.750363][ C1] Preemption disabled at: [ 13.750364][ C1] [<0000000000000000>] 0x0 [ 13.750372][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.750375][ C1] Tainted: [W]=WARN [ 13.750376][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.750378][ C1] Call Trace: [ 13.750380][ C1] [ 13.750382][ C1] dump_stack_lvl+0x6f/0xa0 [ 13.750387][ C1] __might_resched.cold+0x1fe/0x2c1 [ 13.750391][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.750394][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750398][ C1] __kmalloc_noprof+0x443/0x760 [ 13.750402][ C1] ? __rwlock_init+0x150/0x150 [ 13.750404][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 13.750408][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.750410][ C1] alloc_buf.isra.0+0x4b/0x260 [ 13.750412][ C1] put_chars+0x1e1/0x2f0 [ 13.750415][ C1] ? __send_to_port+0x420/0x420 [ 13.750416][ C1] ? printk_get_next_message+0x240/0x650 [ 13.750420][ C1] hvc_console_print+0x292/0x780 [ 13.750424][ C1] ? hvc_write+0x3a0/0x3a0 [ 13.750425][ C1] ? __rwlock_init+0x150/0x150 [ 13.750427][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750429][ C1] ? lock_acquire+0x13c/0x160 [ 13.750431][ C1] console_emit_next_record+0x22f/0x4c0 [ 13.750433][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 13.750435][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750437][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750439][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750440][ C1] ? lock_acquire+0x13c/0x160 [ 13.750442][ C1] ? console_flush_one_record+0x111/0x710 [ 13.750444][ C1] console_flush_one_record+0x46f/0x710 [ 13.750446][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 13.750449][ C1] console_unlock+0xee/0x1f0 [ 13.750451][ C1] ? lock_acquire+0x13c/0x160 [ 13.750453][ C1] ? console_flush_one_record+0x710/0x710 [ 13.750454][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750456][ C1] ? lock_release+0x184/0x1f0 [ 13.750457][ C1] ? lock_acquire+0x60/0x160 [ 13.750459][ C1] ? __rcu_read_lock+0x30/0x70 [ 13.750461][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.750463][ C1] ? vprintk_emit+0x320/0x3e0 [ 13.750465][ C1] vprintk_emit+0x37c/0x3e0 [ 13.750467][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 13.750469][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 13.750470][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750472][ C1] ? lock_acquire+0x13c/0x160 [ 13.750474][ C1] _printk+0xc7/0x100 [ 13.750477][ C1] ? snapshot_read.cold+0x21/0x21 [ 13.750479][ C1] ? ___ratelimit+0x4e7/0xa00 [ 13.750481][ C1] ? trace_hardirqs_on+0x36/0x40 [ 13.750484][ C1] ? idr_get_free+0x830/0x830 [ 13.750486][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.750488][ C1] tcp_make_synack.cold+0x36/0xb6 [ 13.750492][ C1] ? tcp_send_synack+0x1570/0x1570 [ 13.750496][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750498][ C1] ? inet_csk_route_req+0x747/0xc30 [ 13.750501][ C1] tcp_v4_send_synack+0x103/0xb20 [ 13.750503][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.750505][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.750507][ C1] ? trace_hardirqs_on+0x36/0x40 [ 13.750508][ C1] ? get_random_u16+0x740/0x740 [ 13.750510][ C1] tcp_rtx_synack+0x150/0x440 [ 13.750512][ C1] ? tcp_send_probe0+0x590/0x590 [ 13.750514][ C1] ? sched_balance_rq+0x324/0x1e30 [ 13.750517][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 13.750519][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.750520][ C1] ? lock_acquire+0x6a/0x160 [ 13.750522][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.750523][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.750525][ C1] call_timer_fn+0x160/0x4d0 [ 13.750528][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 13.750529][ C1] ? debug_object_active_state+0x430/0x430 [ 13.750533][ C1] ? __rwlock_init+0x150/0x150 [ 13.750535][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.750536][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750539][ C1] __run_timers+0x68f/0xaa0 [ 13.750541][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.750543][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.750545][ C1] ? do_raw_spin_lock+0x131/0x280 [ 13.750547][ C1] ? __rwlock_init+0x150/0x150 [ 13.750549][ C1] run_timer_softirq+0xf0/0x160 [ 13.750557][ C1] ? __run_timers+0xaa0/0xaa0 [ 13.750559][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.750560][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750562][ C1] handle_softirqs+0x1d3/0x900 [ 13.750564][ C1] ? _local_bh_enable+0xc0/0xc0 [ 13.750565][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750567][ C1] ? lock_release+0x184/0x1f0 [ 13.750569][ C1] __irq_exit_rcu+0x145/0x1c0 [ 13.750570][ C1] irq_exit_rcu+0xe/0x30 [ 13.750572][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.750574][ C1] [ 13.750575][ C1] [ 13.750575][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 13.750577][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.750580][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.750582][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.750584][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 13.750588][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 13.750589][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 13.750590][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 13.750591][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 13.750591][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.750593][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.750595][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.750597][ C1] default_idle+0x9/0x10 [ 13.750598][ C1] default_idle_call+0x6e/0xb0 [ 13.750600][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.750601][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 13.750603][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 13.750605][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.750608][ C1] do_idle+0xd8/0x190 [ 13.750609][ C1] cpu_startup_entry+0x53/0x70 [ 13.750610][ C1] start_secondary+0x204/0x2b0 [ 13.750612][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.750614][ C1] common_startup_64+0x13e/0x148 [ 13.750618][ C1] [ 13.771480][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.774344][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.774364][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.774367][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 14.774369][ C1] preempt_count: 102, expected: 0 [ 14.774371][ C1] RCU nest depth: 0, expected: 0 [ 14.774373][ C1] INFO: lockdep is turned off. [ 14.774374][ C1] irq event stamp: 301438 [ 14.774375][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 14.774385][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 14.774389][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 14.774394][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 14.774397][ C1] Preemption disabled at: [ 14.774398][ C1] [<0000000000000000>] 0x0 [ 14.774407][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.774412][ C1] Tainted: [W]=WARN [ 14.774413][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.774416][ C1] Call Trace: [ 14.774418][ C1] [ 14.774421][ C1] dump_stack_lvl+0x6f/0xa0 [ 14.774428][ C1] __might_resched.cold+0x1fe/0x2c1 [ 14.774432][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.774437][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774442][ C1] __kmalloc_noprof+0x443/0x760 [ 14.774446][ C1] ? __rwlock_init+0x150/0x150 [ 14.774450][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 14.774455][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.774458][ C1] alloc_buf.isra.0+0x4b/0x260 [ 14.774461][ C1] put_chars+0x1e1/0x2f0 [ 14.774464][ C1] ? __send_to_port+0x420/0x420 [ 14.774467][ C1] ? printk_get_next_message+0x240/0x650 [ 14.774471][ C1] hvc_console_print+0x292/0x780 [ 14.774476][ C1] ? hvc_write+0x3a0/0x3a0 [ 14.774479][ C1] ? __rwlock_init+0x150/0x150 [ 14.774481][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774484][ C1] ? lock_acquire+0x13c/0x160 [ 14.774487][ C1] console_emit_next_record+0x22f/0x4c0 [ 14.774491][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 14.774494][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774496][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774499][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774501][ C1] ? lock_acquire+0x13c/0x160 [ 14.774504][ C1] ? console_flush_one_record+0x111/0x710 [ 14.774507][ C1] console_flush_one_record+0x46f/0x710 [ 14.774510][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 14.774514][ C1] console_unlock+0xee/0x1f0 [ 14.774516][ C1] ? lock_acquire+0x13c/0x160 [ 14.774519][ C1] ? console_flush_one_record+0x710/0x710 [ 14.774521][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774523][ C1] ? lock_release+0x184/0x1f0 [ 14.774526][ C1] ? lock_acquire+0x60/0x160 [ 14.774528][ C1] ? __rcu_read_lock+0x30/0x70 [ 14.774531][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.774533][ C1] ? vprintk_emit+0x320/0x3e0 [ 14.774536][ C1] vprintk_emit+0x37c/0x3e0 [ 14.774540][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 14.774542][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 14.774545][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774547][ C1] ? lock_acquire+0x13c/0x160 [ 14.774550][ C1] _printk+0xc7/0x100 [ 14.774554][ C1] ? snapshot_read.cold+0x21/0x21 [ 14.774563][ C1] ? ___ratelimit+0x4e7/0xa00 [ 14.774567][ C1] ? idr_get_free+0x830/0x830 [ 14.774570][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.774573][ C1] tcp_make_synack.cold+0x36/0xb6 [ 14.774579][ C1] ? tcp_send_synack+0x1570/0x1570 [ 14.774583][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774587][ C1] ? inet_csk_route_req+0x747/0xc30 [ 14.774591][ C1] tcp_v4_send_synack+0x103/0xb20 [ 14.774595][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 14.774597][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 14.774601][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.774603][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.774606][ C1] ? get_random_u16+0x740/0x740 [ 14.774609][ C1] tcp_rtx_synack+0x150/0x440 [ 14.774612][ C1] ? tcp_send_probe0+0x590/0x590 [ 14.774616][ C1] ? sched_balance_rq+0x324/0x1e30 [ 14.774619][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 14.774622][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.774625][ C1] ? lock_acquire+0x6a/0x160 [ 14.774627][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.774630][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.774632][ C1] call_timer_fn+0x160/0x4d0 [ 14.774636][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 14.774638][ C1] ? debug_object_active_state+0x430/0x430 [ 14.774644][ C1] ? __rwlock_init+0x150/0x150 [ 14.774646][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 14.774649][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774652][ C1] __run_timers+0x68f/0xaa0 [ 14.774655][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.774658][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.774661][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.774665][ C1] ? __rwlock_init+0x150/0x150 [ 14.774668][ C1] run_timer_softirq+0xf0/0x160 [ 14.774671][ C1] ? __run_timers+0xaa0/0xaa0 [ 14.774674][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.774676][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774678][ C1] handle_softirqs+0x1d3/0x900 [ 14.774682][ C1] ? _local_bh_enable+0xc0/0xc0 [ 14.774684][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774687][ C1] ? lock_release+0x184/0x1f0 [ 14.774689][ C1] __irq_exit_rcu+0x145/0x1c0 [ 14.774692][ C1] irq_exit_rcu+0xe/0x30 [ 14.774694][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.774698][ C1] [ 14.774699][ C1] [ 14.774700][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 14.774703][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.774706][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.774710][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.774712][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 14.774717][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 14.774719][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 14.774720][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 14.774722][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 14.774723][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.774725][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.774728][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.774732][ C1] default_idle+0x9/0x10 [ 14.774734][ C1] default_idle_call+0x6e/0xb0 [ 14.774736][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.774738][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 14.774741][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 14.774744][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.774747][ C1] do_idle+0xd8/0x190 [ 14.774750][ C1] cpu_startup_entry+0x53/0x70 [ 14.774752][ C1] start_secondary+0x204/0x2b0 [ 14.774755][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.774758][ C1] common_startup_64+0x13e/0x148 [ 14.774764][ C1] [ 14.806980][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.863349][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.863365][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.863367][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 15.863369][ C1] preempt_count: 102, expected: 0 [ 15.863370][ C1] RCU nest depth: 0, expected: 0 [ 15.863371][ C1] INFO: lockdep is turned off. [ 15.863372][ C1] irq event stamp: 301438 [ 15.863373][ C1] hardirqs last enabled at (301437): [] default_idle_call+0x98/0xb0 [ 15.863381][ C1] hardirqs last disabled at (301438): [] __schedule+0x1246/0x20e0 [ 15.863384][ C1] softirqs last enabled at (301428): [] handle_softirqs+0x67c/0x900 [ 15.863388][ C1] softirqs last disabled at (301423): [] __irq_exit_rcu+0x145/0x1c0 [ 15.863390][ C1] Preemption disabled at: [ 15.863391][ C1] [<0000000000000000>] 0x0 [ 15.863397][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.863401][ C1] Tainted: [W]=WARN [ 15.863402][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.863403][ C1] Call Trace: [ 15.863405][ C1] [ 15.863408][ C1] dump_stack_lvl+0x6f/0xa0 [ 15.863413][ C1] __might_resched.cold+0x1fe/0x2c1 [ 15.863417][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.863420][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863424][ C1] __kmalloc_noprof+0x443/0x760 [ 15.863427][ C1] ? __rwlock_init+0x150/0x150 [ 15.863430][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 15.863434][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.863435][ C1] alloc_buf.isra.0+0x4b/0x260 [ 15.863438][ C1] put_chars+0x1e1/0x2f0 [ 15.863440][ C1] ? __send_to_port+0x420/0x420 [ 15.863442][ C1] ? printk_get_next_message+0x240/0x650 [ 15.863445][ C1] hvc_console_print+0x292/0x780 [ 15.863449][ C1] ? hvc_write+0x3a0/0x3a0 [ 15.863451][ C1] ? __rwlock_init+0x150/0x150 [ 15.863452][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863454][ C1] ? lock_acquire+0x13c/0x160 [ 15.863456][ C1] console_emit_next_record+0x22f/0x4c0 [ 15.863459][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 15.863461][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863463][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863464][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863466][ C1] ? lock_acquire+0x13c/0x160 [ 15.863468][ C1] ? console_flush_one_record+0x111/0x710 [ 15.863469][ C1] console_flush_one_record+0x46f/0x710 [ 15.863472][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 15.863474][ C1] console_unlock+0xee/0x1f0 [ 15.863476][ C1] ? lock_acquire+0x13c/0x160 [ 15.863478][ C1] ? console_flush_one_record+0x710/0x710 [ 15.863479][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863481][ C1] ? lock_release+0x184/0x1f0 [ 15.863482][ C1] ? lock_acquire+0x60/0x160 [ 15.863484][ C1] ? __rcu_read_lock+0x30/0x70 [ 15.863486][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.863488][ C1] ? vprintk_emit+0x320/0x3e0 [ 15.863490][ C1] vprintk_emit+0x37c/0x3e0 [ 15.863492][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 15.863494][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 15.863495][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863497][ C1] ? lock_acquire+0x13c/0x160 [ 15.863499][ C1] _printk+0xc7/0x100 [ 15.863502][ C1] ? snapshot_read.cold+0x21/0x21 [ 15.863503][ C1] ? ___ratelimit+0x4e7/0xa00 [ 15.863506][ C1] ? trace_hardirqs_on+0x36/0x40 [ 15.863509][ C1] ? idr_get_free+0x830/0x830 [ 15.863511][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.863512][ C1] tcp_make_synack.cold+0x36/0xb6 [ 15.863516][ C1] ? tcp_send_synack+0x1570/0x1570 [ 15.863520][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863522][ C1] ? inet_csk_route_req+0x747/0xc30 [ 15.863525][ C1] tcp_v4_send_synack+0x103/0xb20 [ 15.863528][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.863529][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 15.863532][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.863534][ C1] ? trace_hardirqs_on+0x36/0x40 [ 15.863535][ C1] ? get_random_u16+0x740/0x740 [ 15.863537][ C1] tcp_rtx_synack+0x150/0x440 [ 15.863539][ C1] ? tcp_send_probe0+0x590/0x590 [ 15.863541][ C1] ? sched_balance_rq+0x324/0x1e30 [ 15.863543][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 15.863545][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.863547][ C1] ? lock_acquire+0x6a/0x160 [ 15.863548][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.863550][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.863551][ C1] call_timer_fn+0x160/0x4d0 [ 15.863555][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 15.863556][ C1] ? debug_object_active_state+0x430/0x430 [ 15.863566][ C1] ? __rwlock_init+0x150/0x150 [ 15.863568][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 15.863570][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863572][ C1] __run_timers+0x68f/0xaa0 [ 15.863574][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.863576][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.863578][ C1] ? do_raw_spin_lock+0x131/0x280 [ 15.863580][ C1] ? __rwlock_init+0x150/0x150 [ 15.863583][ C1] run_timer_softirq+0xf0/0x160 [ 15.863585][ C1] ? __run_timers+0xaa0/0xaa0 [ 15.863586][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.863588][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863589][ C1] handle_softirqs+0x1d3/0x900 [ 15.863591][ C1] ? _local_bh_enable+0xc0/0xc0 [ 15.863593][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863595][ C1] ? lock_release+0x184/0x1f0 [ 15.863596][ C1] __irq_exit_rcu+0x145/0x1c0 [ 15.863598][ C1] irq_exit_rcu+0xe/0x30 [ 15.863599][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.863601][ C1] [ 15.863602][ C1] [ 15.863602][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 15.863604][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.863607][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.863609][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 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.863611][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 15.863614][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 15.863615][ C1] RDX: 0000000000000001 RSI: ffffffffb4a8dc60 RDI: ffffffffb20fa307 [ 15.863616][ C1] RBP: 0000000000000000 R08: ffffffffb471e421 R09: 1fe2200006a563a2 [ 15.863617][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 15.863618][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.863619][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.863621][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.863623][ C1] default_idle+0x9/0x10 [ 15.863624][ C1] default_idle_call+0x6e/0xb0 [ 15.863626][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.863627][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 15.863629][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 15.863631][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.863633][ C1] do_idle+0xd8/0x190 [ 15.863635][ C1] cpu_startup_entry+0x53/0x70 [ 15.863636][ C1] start_secondary+0x204/0x2b0 [ 15.863638][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.863640][ C1] common_startup_64+0x13e/0x148 [ 15.863644][ C1]