[ 8.743444][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 8.743470][ C2] [ 8.743471][ C2] ======================================================== [ 8.743472][ C2] WARNING: possible irq lock inversion dependency detected [ 8.743474][ C2] 7.2.0-virtme #1 Tainted: G W [ 8.743475][ C2] -------------------------------------------------------- [ 8.743476][ C2] connect-deny_ip/169 just changed the state of lock: [ 8.743477][ C2] ffffffffa7299660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 8.743489][ C2] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 8.743490][ C2] (fs_reclaim){+.+.}-{0:0} [ 8.743492][ C2] [ 8.743492][ C2] [ 8.743492][ C2] and interrupts could create inverse lock ordering between them. [ 8.743492][ C2] [ 8.743492][ C2] [ 8.743492][ C2] other info that might help us debug this: [ 8.743493][ C2] Possible interrupt unsafe locking scenario: [ 8.743493][ C2] [ 8.743494][ C2] CPU0 CPU1 [ 8.743494][ C2] ---- ---- [ 8.743495][ C2] lock(fs_reclaim); [ 8.743496][ C2] local_irq_disable(); [ 8.743496][ C2] lock(console_owner); [ 8.743497][ C2] lock(fs_reclaim); [ 8.743498][ C2] [ 8.743498][ C2] lock(console_owner); [ 8.743499][ C2] [ 8.743499][ C2] *** DEADLOCK *** [ 8.743499][ C2] [ 8.743499][ C2] locks held by connect-deny_ip/169: 9, last CPU#2: [ 8.743501][ C2] #0: ff11000016289d90 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 8.743506][ C2] #1: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 8.743510][ C2] #2: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 8.743513][ C2] #3: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 8.743516][ C2] #4: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 8.743521][ C2] #5: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 8.743524][ C2] #6: ffffffffa7390b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 8.743529][ C2] #7: ffffffffa7379cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 8.743532][ C2] #8: ffffffffa7379d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 8.743535][ C2] [ 8.743535][ C2] the shortest dependencies between 2nd lock and 1st lock: [ 8.743539][ C2] -> (fs_reclaim){+.+.}-{0:0} { [ 8.743541][ C2] HARDIRQ-ON-W at: [ 8.743543][ C2] __lock_acquire+0x388/0xc20 [ 8.743546][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743547][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.743550][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.743552][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.743555][ C2] workqueue_init+0x2a/0x680 [ 8.743558][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.743561][ C2] kernel_init+0x21/0x150 [ 8.743564][ C2] ret_from_fork+0x474/0x6b0 [ 8.743567][ C2] ret_from_fork_asm+0x11/0x20 [ 8.743570][ C2] SOFTIRQ-ON-W at: [ 8.743570][ C2] __lock_acquire+0x388/0xc20 [ 8.743572][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743573][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.743574][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.743576][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.743577][ C2] workqueue_init+0x2a/0x680 [ 8.743578][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.743580][ C2] kernel_init+0x21/0x150 [ 8.743581][ C2] ret_from_fork+0x474/0x6b0 [ 8.743582][ C2] ret_from_fork_asm+0x11/0x20 [ 8.743583][ C2] INITIAL USE at: [ 8.743584][ C2] __lock_acquire+0x388/0xc20 [ 8.743586][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743587][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.743588][ C2] __kmalloc_cache_noprof+0x6e/0x620 [ 8.743590][ C2] kthread_create_worker_on_node+0xea/0x210 [ 8.743591][ C2] workqueue_init+0x2a/0x680 [ 8.743592][ C2] kernel_init_freeable+0x2fe/0x630 [ 8.743594][ C2] kernel_init+0x21/0x150 [ 8.743595][ C2] ret_from_fork+0x474/0x6b0 [ 8.743596][ C2] ret_from_fork_asm+0x11/0x20 [ 8.743598][ C2] } [ 8.743598][ C2] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 8.743602][ C2] ... acquired at: [ 8.743603][ C2] __lock_acquire+0x518/0xc20 [ 8.743604][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743606][ C2] fs_reclaim_acquire+0xd5/0x120 [ 8.743607][ C2] __kmalloc_noprof+0xd3/0x760 [ 8.743608][ C2] alloc_buf.isra.0+0x4b/0x260 [ 8.743611][ C2] put_chars+0x1e1/0x2f0 [ 8.743613][ C2] hvc_console_print+0x292/0x780 [ 8.743615][ C2] console_emit_next_record+0x22f/0x4c0 [ 8.743617][ C2] console_flush_one_record+0x46f/0x710 [ 8.743618][ C2] console_unlock+0xee/0x1f0 [ 8.743620][ C2] vprintk_emit+0x37c/0x3e0 [ 8.743621][ C2] _printk+0xc7/0x100 [ 8.743624][ C2] dm_interface_init+0x50/0x60 [ 8.743627][ C2] dm_init+0x51/0xd0 [ 8.743629][ C2] do_one_initcall+0x124/0x4f0 [ 8.743630][ C2] kernel_init_freeable+0x596/0x630 [ 8.743632][ C2] kernel_init+0x21/0x150 [ 8.743633][ C2] ret_from_fork+0x474/0x6b0 [ 8.743634][ C2] ret_from_fork_asm+0x11/0x20 [ 8.743636][ C2] [ 8.743636][ C2] -> (console_owner){..-.}-{0:0} { [ 8.743638][ C2] IN-SOFTIRQ-W at: [ 8.743638][ C2] __lock_acquire+0x388/0xc20 [ 8.743640][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743641][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.743643][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.743644][ C2] console_flush_one_record+0x46f/0x710 [ 8.743646][ C2] console_unlock+0xee/0x1f0 [ 8.743647][ C2] vprintk_emit+0x37c/0x3e0 [ 8.743649][ C2] _printk+0xc7/0x100 [ 8.743650][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.743652][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.743654][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.743656][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.743658][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.743660][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.743662][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.743664][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.743665][ C2] ip_local_deliver+0x184/0x4c0 [ 8.743666][ C2] ip_rcv+0xdc/0x3d0 [ 8.743667][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.743669][ C2] process_backlog+0x431/0x14c0 [ 8.743671][ C2] __napi_poll+0xa7/0x3b0 [ 8.743673][ C2] net_rx_action+0x513/0xf50 [ 8.743674][ C2] handle_softirqs+0x1d3/0x900 [ 8.743677][ C2] do_softirq+0xac/0xe0 [ 8.743678][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.743679][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.743681][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.743682][ C2] ip_output+0x1ca/0x660 [ 8.743684][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.743685][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.743686][ C2] tcp_connect+0x1024/0x1e20 [ 8.743687][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.743689][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.743690][ C2] inet_stream_connect+0x59/0xb0 [ 8.743691][ C2] __sys_connect+0x1cf/0x2e0 [ 8.743694][ C2] __x64_sys_connect+0x72/0xd0 [ 8.743695][ C2] do_syscall_64+0xff/0x530 [ 8.743698][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.743699][ C2] INITIAL USE at: [ 8.743700][ C2] } [ 8.743701][ C2] ... key at: [] console_owner_dep_map+0x0/0x60 [ 8.743704][ C2] ... acquired at: [ 8.743705][ C2] mark_lock+0x1d7/0xa00 [ 8.743706][ C2] mark_usage+0x42/0x170 [ 8.743707][ C2] __lock_acquire+0x388/0xc20 [ 8.743709][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743710][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.743711][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.743713][ C2] console_flush_one_record+0x46f/0x710 [ 8.743714][ C2] console_unlock+0xee/0x1f0 [ 8.743716][ C2] vprintk_emit+0x37c/0x3e0 [ 8.743717][ C2] _printk+0xc7/0x100 [ 8.743719][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.743720][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.743721][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.743723][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.743725][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.743726][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.743728][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.743729][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.743730][ C2] ip_local_deliver+0x184/0x4c0 [ 8.743731][ C2] ip_rcv+0xdc/0x3d0 [ 8.743733][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.743734][ C2] process_backlog+0x431/0x14c0 [ 8.743736][ C2] __napi_poll+0xa7/0x3b0 [ 8.743737][ C2] net_rx_action+0x513/0xf50 [ 8.743739][ C2] handle_softirqs+0x1d3/0x900 [ 8.743740][ C2] do_softirq+0xac/0xe0 [ 8.743741][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.743743][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.743744][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.743746][ C2] ip_output+0x1ca/0x660 [ 8.743747][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.743748][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.743749][ C2] tcp_connect+0x1024/0x1e20 [ 8.743750][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.743752][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.743753][ C2] inet_stream_connect+0x59/0xb0 [ 8.743754][ C2] __sys_connect+0x1cf/0x2e0 [ 8.743755][ C2] __x64_sys_connect+0x72/0xd0 [ 8.743757][ C2] do_syscall_64+0xff/0x530 [ 8.743758][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.743759][ C2] [ 8.743760][ C2] [ 8.743760][ C2] stack backtrace: [ 8.743762][ C2] CPU: 2 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.743765][ C2] Tainted: [W]=WARN [ 8.743766][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.743768][ C2] Call Trace: [ 8.743769][ C2] [ 8.743770][ C2] dump_stack_lvl+0x6f/0xa0 [ 8.743774][ C2] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 8.743776][ C2] mark_lock_irq+0x989/0x9c0 [ 8.743779][ C2] mark_lock+0x1d7/0xa00 [ 8.743781][ C2] mark_usage+0x42/0x170 [ 8.743782][ C2] __lock_acquire+0x388/0xc20 [ 8.743784][ C2] lock_acquire.part.0+0xd4/0x280 [ 8.743786][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 8.743788][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743791][ C2] ? lock_acquire+0x13c/0x160 [ 8.743793][ C2] console_lock_spinning_enable+0x5c/0x60 [ 8.743800][ C2] ? console_lock_spinning_enable+0x40/0x60 [ 8.743801][ C2] console_emit_next_record+0x1d1/0x4c0 [ 8.743804][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 8.743805][ C2] ? console_flush_one_record+0x106/0x710 [ 8.743807][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743809][ C2] ? lock_acquire+0x13c/0x160 [ 8.743811][ C2] console_flush_one_record+0x46f/0x710 [ 8.743813][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 8.743814][ C2] ? __lock_acquire+0x518/0xc20 [ 8.743816][ C2] console_unlock+0xee/0x1f0 [ 8.743818][ C2] ? console_flush_one_record+0x710/0x710 [ 8.743820][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743822][ C2] ? lock_acquire+0x60/0x160 [ 8.743823][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.743825][ C2] ? vprintk_emit+0x320/0x3e0 [ 8.743827][ C2] vprintk_emit+0x37c/0x3e0 [ 8.743829][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 8.743831][ C2] _printk+0xc7/0x100 [ 8.743833][ C2] ? snapshot_read.cold+0x21/0x21 [ 8.743835][ C2] ? ___ratelimit+0x4e7/0xa00 [ 8.743837][ C2] ? idr_get_free+0x830/0x830 [ 8.743839][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.743842][ C2] ? tcp_send_synack+0x1570/0x1570 [ 8.743843][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 8.743845][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 8.743847][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.743849][ C2] ? add_timer_on+0x580/0x580 [ 8.743852][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.743854][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 8.743856][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 8.743859][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 8.743861][ C2] ? inet_csk_route_req+0x747/0xc30 [ 8.743863][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 8.743864][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.743866][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.743870][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.743872][ C2] ? __lock_acquire+0x518/0xc20 [ 8.743874][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.743875][ C2] ? __lock_acquire+0x518/0xc20 [ 8.743877][ C2] ? down_read_nested+0xe7/0x500 [ 8.743879][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743881][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.743883][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.743885][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.743887][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 8.743889][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.743891][ C2] ? mark_usage+0x61/0x170 [ 8.743893][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 8.743895][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.743896][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 8.743898][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.743900][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.743902][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.743903][ C2] ip_local_deliver+0x184/0x4c0 [ 8.743905][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 8.743907][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 8.743909][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.743911][ C2] ip_rcv+0xdc/0x3d0 [ 8.743912][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 8.743914][ C2] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.743915][ C2] ? validate_chain+0x38b/0xc20 [ 8.743917][ C2] ? mark_usage+0x61/0x170 [ 8.743918][ C2] ? __lock_acquire+0x518/0xc20 [ 8.743920][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.743922][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.743924][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.743925][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.743927][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.743929][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743931][ C2] process_backlog+0x431/0x14c0 [ 8.743934][ C2] __napi_poll+0xa7/0x3b0 [ 8.743936][ C2] net_rx_action+0x513/0xf50 [ 8.743939][ C2] ? __napi_poll+0x3b0/0x3b0 [ 8.743941][ C2] ? find_held_lock+0x2b/0x80 [ 8.743943][ C2] ? mark_held_locks+0x40/0x70 [ 8.743945][ C2] handle_softirqs+0x1d3/0x900 [ 8.743947][ C2] ? _local_bh_enable+0xc0/0xc0 [ 8.743949][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743950][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 8.743953][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 8.743955][ C2] do_softirq+0xac/0xe0 [ 8.743956][ C2] [ 8.743957][ C2] [ 8.743957][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.743959][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.743961][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.743964][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.743965][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.743967][ C2] ? find_held_lock+0x2b/0x80 [ 8.743968][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.743970][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.743971][ C2] ? mark_held_locks+0x40/0x70 [ 8.743973][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.743974][ C2] ? neigh_hh_output+0x152/0x4c0 [ 8.743976][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.743978][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 8.743980][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.743981][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 8.743984][ C2] ip_output+0x1ca/0x660 [ 8.743985][ C2] ? ip_finish_output+0x460/0x460 [ 8.743987][ C2] ? find_held_lock+0x2b/0x80 [ 8.743988][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.743990][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 8.743992][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.743994][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.743997][ C2] ? __tcp_select_window+0xf20/0xf20 [ 8.743999][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744000][ C2] ? ktime_get+0x18e/0x2d0 [ 8.744002][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 8.744005][ C2] ? ktime_get+0x1dd/0x2d0 [ 8.744007][ C2] tcp_connect+0x1024/0x1e20 [ 8.744009][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.744011][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 8.744013][ C2] ? do_raw_spin_lock+0x131/0x280 [ 8.744015][ C2] ? find_held_lock+0x2b/0x80 [ 8.744016][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.744018][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744019][ C2] inet_stream_connect+0x59/0xb0 [ 8.744021][ C2] __sys_connect+0x1cf/0x2e0 [ 8.744022][ C2] ? do_fcntl+0x36f/0xc50 [ 8.744025][ C2] ? __sys_connect_file+0x250/0x250 [ 8.744028][ C2] ? fput+0x1f/0xa0 [ 8.744030][ C2] __x64_sys_connect+0x72/0xd0 [ 8.744032][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744033][ C2] ? do_syscall_64+0xa6/0x530 [ 8.744035][ C2] do_syscall_64+0xff/0x530 [ 8.744036][ C2] ? exc_page_fault+0xee/0x100 [ 8.744037][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.744039][ C2] RIP: 0033:0x7f1ca06f4312 [ 8.744042][ 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.744044][ C2] RSP: 002b:00007f1c9fe71988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.744046][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007f1ca06f4312 [ 8.744047][ C2] RDX: 0000000000000010 RSI: 00007f1c9fe71c40 RDI: 000000000000000a [ 8.744048][ C2] RBP: 00007f1c9fe719b0 R08: 0000000000000000 R09: 0000000000000000 [ 8.744049][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1c9fe71c40 [ 8.744050][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 8.744052][ C2] [ 8.744056][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 8.744057][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 8.744059][ C2] preempt_count: 302, expected: 0 [ 8.744059][ C2] RCU nest depth: 6, expected: 0 [ 8.744060][ C2] INFO: lockdep is turned off. [ 8.744061][ C2] irq event stamp: 9849 [ 8.744061][ C2] hardirqs last enabled at (9848): [] __down_trylock_console_sem+0x86/0xa0 [ 8.744063][ C2] hardirqs last disabled at (9849): [] console_emit_next_record+0x3d4/0x4c0 [ 8.744065][ C2] softirqs last enabled at (9680): [] __dev_queue_xmit+0x964/0x1b80 [ 8.744067][ C2] softirqs last disabled at (9681): [] do_softirq+0xac/0xe0 [ 8.744069][ C2] Preemption disabled at: [ 8.744069][ C2] [] __dev_queue_xmit+0x204/0x1b80 [ 8.744072][ C2] CPU: 2 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.744074][ C2] Tainted: [W]=WARN [ 8.744075][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.744075][ C2] Call Trace: [ 8.744076][ C2] [ 8.744076][ C2] dump_stack_lvl+0x6f/0xa0 [ 8.744078][ C2] ? __dev_queue_xmit+0x204/0x1b80 [ 8.744080][ C2] __might_resched.cold+0x1fe/0x2c1 [ 8.744083][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 8.744086][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744088][ C2] __kmalloc_noprof+0x443/0x760 [ 8.744090][ C2] ? __rwlock_init+0x150/0x150 [ 8.744091][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 8.744093][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.744094][ C2] alloc_buf.isra.0+0x4b/0x260 [ 8.744096][ C2] put_chars+0x1e1/0x2f0 [ 8.744098][ C2] ? __send_to_port+0x420/0x420 [ 8.744100][ C2] hvc_console_print+0x292/0x780 [ 8.744102][ C2] ? __lock_acquire+0x388/0xc20 [ 8.744104][ C2] ? hvc_write+0x3a0/0x3a0 [ 8.744106][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744108][ C2] ? lock_acquire+0x13c/0x160 [ 8.744109][ C2] console_emit_next_record+0x22f/0x4c0 [ 8.744111][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 8.744113][ C2] ? console_flush_one_record+0x106/0x710 [ 8.744115][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744116][ C2] ? lock_acquire+0x13c/0x160 [ 8.744118][ C2] console_flush_one_record+0x46f/0x710 [ 8.744120][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 8.744122][ C2] ? __lock_acquire+0x518/0xc20 [ 8.744124][ C2] console_unlock+0xee/0x1f0 [ 8.744126][ C2] ? console_flush_one_record+0x710/0x710 [ 8.744127][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744129][ C2] ? lock_acquire+0x60/0x160 [ 8.744131][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.744132][ C2] ? vprintk_emit+0x320/0x3e0 [ 8.744134][ C2] vprintk_emit+0x37c/0x3e0 [ 8.744136][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 8.744139][ C2] _printk+0xc7/0x100 [ 8.744140][ C2] ? snapshot_read.cold+0x21/0x21 [ 8.744142][ C2] ? ___ratelimit+0x4e7/0xa00 [ 8.744144][ C2] ? idr_get_free+0x830/0x830 [ 8.744146][ C2] tcp_make_synack.cold+0x36/0xb6 [ 8.744148][ C2] ? tcp_send_synack+0x1570/0x1570 [ 8.744149][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 8.744151][ C2] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 8.744153][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 8.744154][ C2] ? add_timer_on+0x580/0x580 [ 8.744156][ C2] tcp_v4_send_synack+0x103/0xb20 [ 8.744158][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 8.744160][ C2] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 8.744163][ C2] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 8.744164][ C2] ? inet_csk_route_req+0x747/0xc30 [ 8.744166][ C2] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 8.744167][ C2] tcp_conn_request+0x1f15/0x2d20 [ 8.744169][ C2] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.744172][ C2] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.744174][ C2] ? __lock_acquire+0x518/0xc20 [ 8.744176][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.744177][ C2] ? __lock_acquire+0x518/0xc20 [ 8.744179][ C2] ? down_read_nested+0xe7/0x500 [ 8.744181][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744183][ C2] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.744185][ C2] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.744187][ C2] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.744188][ C2] ? tcp_v4_fill_cb+0x33/0x430 [ 8.744190][ C2] tcp_v4_rcv+0x253c/0x2b70 [ 8.744192][ C2] ? mark_usage+0x61/0x170 [ 8.744194][ C2] ? tcp_add_backlog+0x1e30/0x1e30 [ 8.744196][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.744197][ C2] ? ip_local_deliver_finish+0x2ba/0x610 [ 8.744199][ C2] ip_protocol_deliver_rcu+0x82/0x350 [ 8.744201][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.744203][ C2] ip_local_deliver_finish+0x36f/0x610 [ 8.744204][ C2] ip_local_deliver+0x184/0x4c0 [ 8.744206][ C2] ? ip_local_deliver_finish+0x610/0x610 [ 8.744208][ C2] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 8.744210][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.744212][ C2] ip_rcv+0xdc/0x3d0 [ 8.744213][ C2] ? ip_local_deliver+0x4c0/0x4c0 [ 8.744215][ C2] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.744216][ C2] ? validate_chain+0x38b/0xc20 [ 8.744217][ C2] ? mark_usage+0x61/0x170 [ 8.744219][ C2] ? __lock_acquire+0x518/0xc20 [ 8.744220][ C2] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.744222][ C2] __netif_receive_skb_one_core+0xfc/0x180 [ 8.744224][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.744225][ C2] ? process_backlog+0x3f1/0x14c0 [ 8.744227][ C2] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.744229][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744231][ C2] process_backlog+0x431/0x14c0 [ 8.744234][ C2] __napi_poll+0xa7/0x3b0 [ 8.744236][ C2] net_rx_action+0x513/0xf50 [ 8.744238][ C2] ? __napi_poll+0x3b0/0x3b0 [ 8.744240][ C2] ? find_held_lock+0x2b/0x80 [ 8.744243][ C2] ? mark_held_locks+0x40/0x70 [ 8.744245][ C2] handle_softirqs+0x1d3/0x900 [ 8.744247][ C2] ? _local_bh_enable+0xc0/0xc0 [ 8.744248][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744250][ C2] ? trace_csd_function_exit+0xb3/0x180 [ 8.744251][ C2] ? __dev_queue_xmit+0x964/0x1b80 [ 8.744253][ C2] do_softirq+0xac/0xe0 [ 8.744255][ C2] [ 8.744255][ C2] [ 8.744256][ C2] __local_bh_enable_ip+0x118/0x150 [ 8.744257][ C2] __dev_queue_xmit+0x979/0x1b80 [ 8.744259][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.744261][ C2] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.744263][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.744264][ C2] ? find_held_lock+0x2b/0x80 [ 8.744266][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.744267][ C2] ? rcu_is_watching+0x16/0xd0 [ 8.744269][ C2] ? mark_held_locks+0x40/0x70 [ 8.744270][ C2] ? __asan_memcpy+0x3c/0x60 [ 8.744272][ C2] ? neigh_hh_output+0x152/0x4c0 [ 8.744274][ C2] ip_finish_output2+0xd9b/0x1bc0 [ 8.744275][ C2] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 8.744277][ C2] ? lock_acquire.part.0+0xd4/0x280 [ 8.744279][ C2] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 8.744281][ C2] ip_output+0x1ca/0x660 [ 8.744283][ C2] ? ip_finish_output+0x460/0x460 [ 8.744284][ C2] ? find_held_lock+0x2b/0x80 [ 8.744286][ C2] ? __lock_release.isra.0+0x69/0x1a0 [ 8.744287][ C2] ? ip4_dst_hoplimit+0x15b/0x320 [ 8.744289][ C2] __ip_queue_xmit+0x774/0x1650 [ 8.744291][ C2] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.744294][ C2] ? __tcp_select_window+0xf20/0xf20 [ 8.744296][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744297][ C2] ? ktime_get+0x18e/0x2d0 [ 8.744298][ C2] ? kvm_clock_get_cycles+0x19/0x30 [ 8.744300][ C2] ? ktime_get+0x1dd/0x2d0 [ 8.744301][ C2] tcp_connect+0x1024/0x1e20 [ 8.744304][ C2] tcp_v4_connect+0x12bd/0x1960 [ 8.744306][ C2] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 8.744308][ C2] ? do_raw_spin_lock+0x131/0x280 [ 8.744309][ C2] ? find_held_lock+0x2b/0x80 [ 8.744311][ C2] __inet_stream_connect+0x2ed/0xd00 [ 8.744312][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744314][ C2] inet_stream_connect+0x59/0xb0 [ 8.744315][ C2] __sys_connect+0x1cf/0x2e0 [ 8.744317][ C2] ? do_fcntl+0x36f/0xc50 [ 8.744319][ C2] ? __sys_connect_file+0x250/0x250 [ 8.744321][ C2] ? fput+0x1f/0xa0 [ 8.744323][ C2] __x64_sys_connect+0x72/0xd0 [ 8.744325][ C2] ? lockdep_hardirqs_on+0x91/0x130 [ 8.744326][ C2] ? do_syscall_64+0xa6/0x530 [ 8.744327][ C2] do_syscall_64+0xff/0x530 [ 8.744329][ C2] ? exc_page_fault+0xee/0x100 [ 8.744330][ C2] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.744331][ C2] RIP: 0033:0x7f1ca06f4312 [ 8.744333][ 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.744334][ C2] RSP: 002b:00007f1c9fe71988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.744335][ C2] RAX: ffffffffffffffda RBX: 000000000000000a RCX: 00007f1ca06f4312 [ 8.744336][ C2] RDX: 0000000000000010 RSI: 00007f1c9fe71c40 RDI: 000000000000000a [ 8.744337][ C2] RBP: 00007f1c9fe719b0 R08: 0000000000000000 R09: 0000000000000000 [ 8.744337][ C2] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1c9fe71c40 [ 8.744338][ C2] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 8.744340][ C2] [ 9.774501][ C2] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.774507][ C2] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.774509][ C2] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/2 [ 9.774511][ C2] preempt_count: 102, expected: 0 [ 9.774511][ C2] RCU nest depth: 0, expected: 0 [ 9.774512][ C2] INFO: lockdep is turned off. [ 9.774513][ C2] irq event stamp: 269910 [ 9.774514][ C2] hardirqs last enabled at (269909): [] default_idle_call+0x98/0xb0 [ 9.774520][ C2] hardirqs last disabled at (269910): [] __schedule+0x1246/0x20e0 [ 9.774522][ C2] softirqs last enabled at (269834): [] handle_softirqs+0x67c/0x900 [ 9.774526][ C2] softirqs last disabled at (269825): [] __irq_exit_rcu+0x145/0x1c0 [ 9.774527][ C2] Preemption disabled at: [ 9.774528][ C2] [<0000000000000000>] 0x0 [ 9.774533][ C2] CPU: 2 UID: 0 PID: 0 Comm: swapper/2 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.774536][ C2] Tainted: [W]=WARN [ 9.774537][ C2] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.774538][ C2] Call Trace: [ 9.774539][ C2] [ 9.774540][ C2] dump_stack_lvl+0x6f/0xa0 [ 9.774545][ C2] __might_resched.cold+0x1fe/0x2c1 [ 9.774548][ C2] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.774551][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774554][ C2] __kmalloc_noprof+0x443/0x760 [ 9.774557][ C2] ? __rwlock_init+0x150/0x150 [ 9.774560][ C2] ? alloc_buf.isra.0+0x4b/0x260 [ 9.774564][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.774565][ C2] alloc_buf.isra.0+0x4b/0x260 [ 9.774567][ C2] put_chars+0x1e1/0x2f0 [ 9.774569][ C2] ? __send_to_port+0x420/0x420 [ 9.774571][ C2] ? printk_get_next_message+0x240/0x650 [ 9.774574][ C2] hvc_console_print+0x292/0x780 [ 9.774577][ C2] ? hvc_write+0x3a0/0x3a0 [ 9.774579][ C2] ? __rwlock_init+0x150/0x150 [ 9.774580][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774582][ C2] ? lock_acquire+0x13c/0x160 [ 9.774584][ C2] console_emit_next_record+0x22f/0x4c0 [ 9.774586][ C2] ? devkmsg_read+0x4b0/0x4b0 [ 9.774588][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774590][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774591][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774593][ C2] ? lock_acquire+0x13c/0x160 [ 9.774595][ C2] ? console_flush_one_record+0x111/0x710 [ 9.774596][ C2] console_flush_one_record+0x46f/0x710 [ 9.774599][ C2] ? console_emit_next_record+0x4c0/0x4c0 [ 9.774601][ C2] console_unlock+0xee/0x1f0 [ 9.774603][ C2] ? lock_acquire+0x13c/0x160 [ 9.774604][ C2] ? console_flush_one_record+0x710/0x710 [ 9.774606][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774607][ C2] ? lock_release+0x184/0x1f0 [ 9.774609][ C2] ? lock_acquire+0x60/0x160 [ 9.774610][ C2] ? __rcu_read_lock+0x30/0x70 [ 9.774612][ C2] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.774614][ C2] ? vprintk_emit+0x320/0x3e0 [ 9.774616][ C2] vprintk_emit+0x37c/0x3e0 [ 9.774618][ C2] ? wake_up_klogd_work_func+0x90/0x90 [ 9.774619][ C2] ? do_raw_spin_trylock+0xb6/0x180 [ 9.774621][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774623][ C2] ? lock_acquire+0x13c/0x160 [ 9.774624][ C2] _printk+0xc7/0x100 [ 9.774627][ C2] ? snapshot_read.cold+0x21/0x21 [ 9.774628][ C2] ? ___ratelimit+0x4e7/0xa00 [ 9.774631][ C2] ? trace_hardirqs_on+0x36/0x40 [ 9.774633][ C2] ? idr_get_free+0x830/0x830 [ 9.774635][ C2] ? trace_irq_enable.constprop.0+0x30/0x160 [ 9.774636][ C2] tcp_make_synack.cold+0x36/0xb6 [ 9.774640][ C2] ? tcp_send_synack+0x1570/0x1570 [ 9.774643][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774645][ C2] ? inet_csk_route_req+0x747/0xc30 [ 9.774648][ C2] tcp_v4_send_synack+0x103/0xb20 [ 9.774650][ C2] ? tcp_v4_timewait_ack+0x870/0x870 [ 9.774652][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.774653][ C2] ? trace_hardirqs_on+0x36/0x40 [ 9.774655][ C2] ? get_random_u16+0x740/0x740 [ 9.774657][ C2] tcp_rtx_synack+0x150/0x440 [ 9.774659][ C2] ? tcp_send_probe0+0x590/0x590 [ 9.774662][ C2] ? sched_balance_rq+0x324/0x1e30 [ 9.774664][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.774666][ C2] reqsk_timer_handler+0x8d1/0xe30 [ 9.774668][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.774669][ C2] ? lock_acquire+0x6a/0x160 [ 9.774671][ C2] ? do_raw_spin_unlock+0x59/0x250 [ 9.774672][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.774673][ C2] call_timer_fn+0x160/0x4d0 [ 9.774677][ C2] ? detach_if_pending+0x1d0/0x1d0 [ 9.774678][ C2] ? debug_object_active_state+0x430/0x430 [ 9.774682][ C2] ? __rwlock_init+0x150/0x150 [ 9.774684][ C2] ? timer_recalc_next_expiry+0xf0/0x210 [ 9.774685][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774688][ C2] __run_timers+0x68f/0xaa0 [ 9.774689][ C2] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.774691][ C2] ? __bpf_trace_itimer_expire+0x10/0x10 [ 9.774694][ C2] ? do_raw_spin_lock+0x131/0x280 [ 9.774696][ C2] ? __rwlock_init+0x150/0x150 [ 9.774698][ C2] run_timer_softirq+0xf0/0x160 [ 9.774700][ C2] ? __run_timers+0xaa0/0xaa0 [ 9.774702][ C2] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.774703][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774704][ C2] handle_softirqs+0x1d3/0x900 [ 9.774706][ C2] ? _local_bh_enable+0xc0/0xc0 [ 9.774708][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774709][ C2] ? lock_release+0x184/0x1f0 [ 9.774711][ C2] __irq_exit_rcu+0x145/0x1c0 [ 9.774713][ C2] irq_exit_rcu+0xe/0x30 [ 9.774714][ C2] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 9.774716][ C2] [ 9.774717][ C2] [ 9.774717][ C2] ? _raw_spin_unlock+0x2d/0x50 [ 9.774719][ C2] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 9.774721][ C2] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 9.774723][ 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.774725][ C2] RSP: 0018:ffa0000000157e00 EFLAGS: 00000246 [ 9.774727][ C2] RAX: 0000000000000002 RBX: ff11000001bf46c0 RCX: 0000000000000001 [ 9.774728][ C2] RDX: 0000000000000002 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 9.774729][ C2] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a663a2 [ 9.774730][ C2] R10: 0000000000000002 R11: 0000000000000000 R12: 1ff400000002afc3 [ 9.774731][ C2] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 9.774732][ C2] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 9.774734][ C2] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.774736][ C2] default_idle+0x9/0x10 [ 9.774737][ C2] default_idle_call+0x6e/0xb0 [ 9.774739][ C2] cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.774740][ C2] ? arch_cpu_idle_exit+0x40/0x40 [ 9.774742][ C2] ? mark_tsc_async_resets+0x30/0x30 [ 9.774745][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774746][ C2] ? rcu_is_watching+0x16/0xd0 [ 9.774748][ C2] do_idle+0xd8/0x190 [ 9.774750][ C2] cpu_startup_entry+0x53/0x70 [ 9.774751][ C2] start_secondary+0x204/0x2b0 [ 9.774753][ C2] ? set_cpu_sibling_map+0x2130/0x2130 [ 9.774754][ C2] common_startup_64+0x13e/0x148 [ 9.774759][ C2] [ 9.902557][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.925481][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.925487][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.925489][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 10.925490][ C3] preempt_count: 102, expected: 0 [ 10.925491][ C3] RCU nest depth: 0, expected: 0 [ 10.925492][ C3] INFO: lockdep is turned off. [ 10.925493][ C3] irq event stamp: 220703 [ 10.925493][ C3] hardirqs last enabled at (220703): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.925499][ C3] hardirqs last disabled at (220702): [] do_idle+0xd1/0x190 [ 10.925501][ C3] softirqs last enabled at (220696): [] handle_softirqs+0x67c/0x900 [ 10.925504][ C3] softirqs last disabled at (220685): [] __irq_exit_rcu+0x145/0x1c0 [ 10.925505][ C3] Preemption disabled at: [ 10.925506][ C3] [<0000000000000000>] 0x0 [ 10.925511][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.925514][ C3] Tainted: [W]=WARN [ 10.925514][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.925515][ C3] Call Trace: [ 10.925517][ C3] [ 10.925518][ C3] dump_stack_lvl+0x6f/0xa0 [ 10.925523][ C3] __might_resched.cold+0x1fe/0x2c1 [ 10.925526][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.925529][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925532][ C3] __kmalloc_noprof+0x443/0x760 [ 10.925536][ C3] ? __rwlock_init+0x150/0x150 [ 10.925538][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 10.925542][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 10.925543][ C3] alloc_buf.isra.0+0x4b/0x260 [ 10.925545][ C3] put_chars+0x1e1/0x2f0 [ 10.925547][ C3] ? __send_to_port+0x420/0x420 [ 10.925549][ C3] ? printk_get_next_message+0x240/0x650 [ 10.925552][ C3] hvc_console_print+0x292/0x780 [ 10.925555][ C3] ? hvc_write+0x3a0/0x3a0 [ 10.925557][ C3] ? __rwlock_init+0x150/0x150 [ 10.925558][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925560][ C3] ? lock_acquire+0x13c/0x160 [ 10.925562][ C3] console_emit_next_record+0x22f/0x4c0 [ 10.925564][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 10.925566][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925567][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925569][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925571][ C3] ? lock_acquire+0x13c/0x160 [ 10.925572][ C3] ? console_flush_one_record+0x111/0x710 [ 10.925574][ C3] console_flush_one_record+0x46f/0x710 [ 10.925576][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 10.925579][ C3] console_unlock+0xee/0x1f0 [ 10.925580][ C3] ? lock_acquire+0x13c/0x160 [ 10.925582][ C3] ? console_flush_one_record+0x710/0x710 [ 10.925583][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925585][ C3] ? lock_release+0x184/0x1f0 [ 10.925586][ C3] ? lock_acquire+0x60/0x160 [ 10.925587][ C3] ? __rcu_read_lock+0x30/0x70 [ 10.925589][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.925591][ C3] ? vprintk_emit+0x320/0x3e0 [ 10.925593][ C3] vprintk_emit+0x37c/0x3e0 [ 10.925595][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 10.925597][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 10.925598][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925600][ C3] ? lock_acquire+0x13c/0x160 [ 10.925602][ C3] _printk+0xc7/0x100 [ 10.925604][ C3] ? snapshot_read.cold+0x21/0x21 [ 10.925606][ C3] ? ___ratelimit+0x4e7/0xa00 [ 10.925609][ C3] ? trace_hardirqs_on+0x36/0x40 [ 10.925612][ C3] ? idr_get_free+0x830/0x830 [ 10.925613][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.925615][ C3] tcp_make_synack.cold+0x36/0xb6 [ 10.925618][ C3] ? tcp_send_synack+0x1570/0x1570 [ 10.925621][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925623][ C3] ? inet_csk_route_req+0x747/0xc30 [ 10.925626][ C3] tcp_v4_send_synack+0x103/0xb20 [ 10.925628][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 10.925630][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 10.925632][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.925633][ C3] ? trace_hardirqs_on+0x36/0x40 [ 10.925635][ C3] ? get_random_u16+0x740/0x740 [ 10.925637][ C3] tcp_rtx_synack+0x150/0x440 [ 10.925638][ C3] ? trace_pelt_cfs_tp+0x9b/0x190 [ 10.925640][ C3] ? tcp_send_probe0+0x590/0x590 [ 10.925641][ C3] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 10.925644][ C3] ? update_cfs_rq_load_avg+0x4b/0x660 [ 10.925646][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 10.925648][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.925649][ C3] ? lock_acquire+0x6a/0x160 [ 10.925651][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 10.925652][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.925654][ C3] call_timer_fn+0x160/0x4d0 [ 10.925657][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 10.925658][ C3] ? debug_object_active_state+0x430/0x430 [ 10.925663][ C3] ? trace_sched_wakeup+0x9b/0x160 [ 10.925664][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.925666][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925668][ C3] __run_timers+0x68f/0xaa0 [ 10.925670][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.925672][ C3] ? debug_object_deactivate+0x2f7/0x440 [ 10.925674][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.925676][ C3] ? do_raw_spin_lock+0x131/0x280 [ 10.925678][ C3] ? __rwlock_init+0x150/0x150 [ 10.925680][ C3] run_timer_softirq+0xf0/0x160 [ 10.925682][ C3] ? __run_timers+0xaa0/0xaa0 [ 10.925684][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.925685][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925687][ C3] handle_softirqs+0x1d3/0x900 [ 10.925689][ C3] ? _local_bh_enable+0xc0/0xc0 [ 10.925690][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925692][ C3] ? lock_release+0x184/0x1f0 [ 10.925693][ C3] __irq_exit_rcu+0x145/0x1c0 [ 10.925695][ C3] irq_exit_rcu+0xe/0x30 [ 10.925696][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.925698][ C3] [ 10.925699][ C3] [ 10.925700][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 10.925702][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.925704][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.925705][ C3] 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.925707][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 10.925710][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 10.925711][ C3] RDX: 0000000000000003 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 10.925712][ C3] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a763a2 [ 10.925712][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 10.925713][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.925714][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.925716][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.925718][ C3] default_idle+0x9/0x10 [ 10.925720][ C3] default_idle_call+0x6e/0xb0 [ 10.925721][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.925723][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 10.925724][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 10.925726][ C3] ? rcu_is_watching+0x16/0xd0 [ 10.925728][ C3] do_idle+0xd8/0x190 [ 10.925730][ C3] cpu_startup_entry+0x53/0x70 [ 10.925731][ C3] start_secondary+0x204/0x2b0 [ 10.925733][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.925735][ C3] common_startup_64+0x13e/0x148 [ 10.925739][ C3] [ 10.943166][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.950472][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.950475][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.950476][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 11.950478][ C3] preempt_count: 102, expected: 0 [ 11.950479][ C3] RCU nest depth: 0, expected: 0 [ 11.950479][ C3] INFO: lockdep is turned off. [ 11.950480][ C3] irq event stamp: 220703 [ 11.950481][ C3] hardirqs last enabled at (220703): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.950484][ C3] hardirqs last disabled at (220702): [] do_idle+0xd1/0x190 [ 11.950486][ C3] softirqs last enabled at (220696): [] handle_softirqs+0x67c/0x900 [ 11.950487][ C3] softirqs last disabled at (220685): [] __irq_exit_rcu+0x145/0x1c0 [ 11.950489][ C3] Preemption disabled at: [ 11.950490][ C3] [<0000000000000000>] 0x0 [ 11.950493][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.950496][ C3] Tainted: [W]=WARN [ 11.950497][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.950497][ C3] Call Trace: [ 11.950498][ C3] [ 11.950499][ C3] dump_stack_lvl+0x6f/0xa0 [ 11.950503][ C3] __might_resched.cold+0x1fe/0x2c1 [ 11.950505][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.950508][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950511][ C3] __kmalloc_noprof+0x443/0x760 [ 11.950513][ C3] ? __rwlock_init+0x150/0x150 [ 11.950515][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 11.950518][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 11.950520][ C3] alloc_buf.isra.0+0x4b/0x260 [ 11.950521][ C3] put_chars+0x1e1/0x2f0 [ 11.950523][ C3] ? __send_to_port+0x420/0x420 [ 11.950525][ C3] ? printk_get_next_message+0x240/0x650 [ 11.950528][ C3] hvc_console_print+0x292/0x780 [ 11.950531][ C3] ? hvc_write+0x3a0/0x3a0 [ 11.950532][ C3] ? __rwlock_init+0x150/0x150 [ 11.950534][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950536][ C3] ? lock_acquire+0x13c/0x160 [ 11.950538][ C3] console_emit_next_record+0x22f/0x4c0 [ 11.950540][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 11.950542][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950543][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950545][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950547][ C3] ? lock_acquire+0x13c/0x160 [ 11.950548][ C3] ? console_flush_one_record+0x111/0x710 [ 11.950550][ C3] console_flush_one_record+0x46f/0x710 [ 11.950552][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 11.950555][ C3] console_unlock+0xee/0x1f0 [ 11.950556][ C3] ? lock_acquire+0x13c/0x160 [ 11.950558][ C3] ? console_flush_one_record+0x710/0x710 [ 11.950560][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950561][ C3] ? lock_release+0x184/0x1f0 [ 11.950563][ C3] ? lock_acquire+0x60/0x160 [ 11.950564][ C3] ? __rcu_read_lock+0x30/0x70 [ 11.950566][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.950568][ C3] ? vprintk_emit+0x320/0x3e0 [ 11.950570][ C3] vprintk_emit+0x37c/0x3e0 [ 11.950572][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 11.950573][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 11.950575][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950577][ C3] ? lock_acquire+0x13c/0x160 [ 11.950578][ C3] _printk+0xc7/0x100 [ 11.950581][ C3] ? snapshot_read.cold+0x21/0x21 [ 11.950582][ C3] ? ___ratelimit+0x4e7/0xa00 [ 11.950585][ C3] ? trace_hardirqs_on+0x36/0x40 [ 11.950587][ C3] ? idr_get_free+0x830/0x830 [ 11.950589][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 11.950590][ C3] tcp_make_synack.cold+0x36/0xb6 [ 11.950593][ C3] ? tcp_send_synack+0x1570/0x1570 [ 11.950595][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950597][ C3] ? inet_csk_route_req+0x747/0xc30 [ 11.950600][ C3] tcp_v4_send_synack+0x103/0xb20 [ 11.950602][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.950603][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 11.950606][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.950607][ C3] ? trace_hardirqs_on+0x36/0x40 [ 11.950609][ C3] ? get_random_u16+0x740/0x740 [ 11.950611][ C3] tcp_rtx_synack+0x150/0x440 [ 11.950612][ C3] ? tcp_send_probe0+0x590/0x590 [ 11.950615][ C3] ? sched_balance_rq+0x324/0x1e30 [ 11.950616][ C3] ? do_raw_spin_lock+0x131/0x280 [ 11.950618][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 11.950620][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.950621][ C3] ? lock_acquire+0x6a/0x160 [ 11.950622][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 11.950624][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.950626][ C3] call_timer_fn+0x160/0x4d0 [ 11.950628][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 11.950629][ C3] ? debug_object_active_state+0x430/0x430 [ 11.950633][ C3] ? __rwlock_init+0x150/0x150 [ 11.950634][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 11.950636][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950638][ C3] __run_timers+0x68f/0xaa0 [ 11.950640][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.950642][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.950644][ C3] ? do_raw_spin_lock+0x131/0x280 [ 11.950646][ C3] ? __rwlock_init+0x150/0x150 [ 11.950648][ C3] run_timer_softirq+0xf0/0x160 [ 11.950650][ C3] ? __run_timers+0xaa0/0xaa0 [ 11.950652][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.950653][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950655][ C3] handle_softirqs+0x1d3/0x900 [ 11.950657][ C3] ? _local_bh_enable+0xc0/0xc0 [ 11.950658][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950660][ C3] ? lock_release+0x184/0x1f0 [ 11.950662][ C3] __irq_exit_rcu+0x145/0x1c0 [ 11.950664][ C3] irq_exit_rcu+0xe/0x30 [ 11.950665][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.950667][ C3] [ 11.950668][ C3] [ 11.950668][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 11.950670][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.950672][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 11.950673][ C3] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 11.950675][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 11.950676][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 11.950677][ C3] RDX: 0000000000000003 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 11.950678][ C3] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a763a2 [ 11.950679][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 11.950679][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 11.950681][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 11.950683][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.950684][ C3] default_idle+0x9/0x10 [ 11.950686][ C3] default_idle_call+0x6e/0xb0 [ 11.950687][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.950689][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 11.950690][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 11.950693][ C3] ? rcu_is_watching+0x16/0xd0 [ 11.950695][ C3] do_idle+0xd8/0x190 [ 11.950696][ C3] cpu_startup_entry+0x53/0x70 [ 11.950698][ C3] start_secondary+0x204/0x2b0 [ 11.950699][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 11.950701][ C3] common_startup_64+0x13e/0x148 [ 11.950705][ C3] [ 11.971571][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.974473][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.974476][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.974477][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 12.974479][ C3] preempt_count: 102, expected: 0 [ 12.974479][ C3] RCU nest depth: 0, expected: 0 [ 12.974480][ C3] INFO: lockdep is turned off. [ 12.974481][ C3] irq event stamp: 220703 [ 12.974481][ C3] hardirqs last enabled at (220703): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.974484][ C3] hardirqs last disabled at (220702): [] do_idle+0xd1/0x190 [ 12.974486][ C3] softirqs last enabled at (220696): [] handle_softirqs+0x67c/0x900 [ 12.974488][ C3] softirqs last disabled at (220685): [] __irq_exit_rcu+0x145/0x1c0 [ 12.974489][ C3] Preemption disabled at: [ 12.974490][ C3] [<0000000000000000>] 0x0 [ 12.974493][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.974495][ C3] Tainted: [W]=WARN [ 12.974496][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.974497][ C3] Call Trace: [ 12.974497][ C3] [ 12.974498][ C3] dump_stack_lvl+0x6f/0xa0 [ 12.974501][ C3] __might_resched.cold+0x1fe/0x2c1 [ 12.974504][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.974506][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974509][ C3] __kmalloc_noprof+0x443/0x760 [ 12.974511][ C3] ? __rwlock_init+0x150/0x150 [ 12.974513][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 12.974515][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 12.974517][ C3] alloc_buf.isra.0+0x4b/0x260 [ 12.974519][ C3] put_chars+0x1e1/0x2f0 [ 12.974520][ C3] ? __send_to_port+0x420/0x420 [ 12.974522][ C3] ? printk_get_next_message+0x240/0x650 [ 12.974525][ C3] hvc_console_print+0x292/0x780 [ 12.974527][ C3] ? hvc_write+0x3a0/0x3a0 [ 12.974529][ C3] ? __rwlock_init+0x150/0x150 [ 12.974531][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974532][ C3] ? lock_acquire+0x13c/0x160 [ 12.974534][ C3] console_emit_next_record+0x22f/0x4c0 [ 12.974536][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 12.974538][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974540][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974541][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974543][ C3] ? lock_acquire+0x13c/0x160 [ 12.974545][ C3] ? console_flush_one_record+0x111/0x710 [ 12.974547][ C3] console_flush_one_record+0x46f/0x710 [ 12.974549][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 12.974551][ C3] console_unlock+0xee/0x1f0 [ 12.974553][ C3] ? lock_acquire+0x13c/0x160 [ 12.974554][ C3] ? console_flush_one_record+0x710/0x710 [ 12.974556][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974558][ C3] ? lock_release+0x184/0x1f0 [ 12.974559][ C3] ? lock_acquire+0x60/0x160 [ 12.974560][ C3] ? __rcu_read_lock+0x30/0x70 [ 12.974562][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.974564][ C3] ? vprintk_emit+0x320/0x3e0 [ 12.974566][ C3] vprintk_emit+0x37c/0x3e0 [ 12.974568][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 12.974569][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 12.974571][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974573][ C3] ? lock_acquire+0x13c/0x160 [ 12.974575][ C3] _printk+0xc7/0x100 [ 12.974577][ C3] ? snapshot_read.cold+0x21/0x21 [ 12.974578][ C3] ? ___ratelimit+0x4e7/0xa00 [ 12.974581][ C3] ? trace_hardirqs_on+0x36/0x40 [ 12.974583][ C3] ? idr_get_free+0x830/0x830 [ 12.974584][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.974586][ C3] tcp_make_synack.cold+0x36/0xb6 [ 12.974588][ C3] ? tcp_send_synack+0x1570/0x1570 [ 12.974591][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974593][ C3] ? inet_csk_route_req+0x747/0xc30 [ 12.974595][ C3] tcp_v4_send_synack+0x103/0xb20 [ 12.974597][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.974598][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 12.974601][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.974602][ C3] ? trace_hardirqs_on+0x36/0x40 [ 12.974603][ C3] ? get_random_u16+0x740/0x740 [ 12.974605][ C3] tcp_rtx_synack+0x150/0x440 [ 12.974607][ C3] ? tcp_send_probe0+0x590/0x590 [ 12.974609][ C3] ? sched_balance_rq+0x324/0x1e30 [ 12.974611][ C3] ? do_raw_spin_lock+0x131/0x280 [ 12.974613][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 12.974614][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.974616][ C3] ? lock_acquire+0x6a/0x160 [ 12.974617][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 12.974619][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.974620][ C3] call_timer_fn+0x160/0x4d0 [ 12.974622][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 12.974624][ C3] ? debug_object_active_state+0x430/0x430 [ 12.974627][ C3] ? __rwlock_init+0x150/0x150 [ 12.974628][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.974630][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974632][ C3] __run_timers+0x68f/0xaa0 [ 12.974634][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.974636][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.974638][ C3] ? do_raw_spin_lock+0x131/0x280 [ 12.974640][ C3] ? __rwlock_init+0x150/0x150 [ 12.974643][ C3] run_timer_softirq+0xf0/0x160 [ 12.974645][ C3] ? __run_timers+0xaa0/0xaa0 [ 12.974646][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.974647][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974649][ C3] handle_softirqs+0x1d3/0x900 [ 12.974651][ C3] ? _local_bh_enable+0xc0/0xc0 [ 12.974653][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974654][ C3] ? lock_release+0x184/0x1f0 [ 12.974656][ C3] __irq_exit_rcu+0x145/0x1c0 [ 12.974658][ C3] irq_exit_rcu+0xe/0x30 [ 12.974659][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.974661][ C3] [ 12.974662][ C3] [ 12.974662][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 12.974664][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.974666][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.974667][ C3] 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.974668][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 12.974670][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 12.974671][ C3] RDX: 0000000000000003 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 12.974671][ C3] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a763a2 [ 12.974672][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 12.974673][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.974674][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.974676][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.974678][ C3] default_idle+0x9/0x10 [ 12.974679][ C3] default_idle_call+0x6e/0xb0 [ 12.974680][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.974682][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 12.974683][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 12.974686][ C3] ? rcu_is_watching+0x16/0xd0 [ 12.974687][ C3] do_idle+0xd8/0x190 [ 12.974689][ C3] cpu_startup_entry+0x53/0x70 [ 12.974690][ C3] start_secondary+0x204/0x2b0 [ 12.974692][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.974694][ C3] common_startup_64+0x13e/0x148 [ 12.974697][ C3] [ 12.995809][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.997483][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.997489][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.997490][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 13.997491][ C3] preempt_count: 102, expected: 0 [ 13.997492][ C3] RCU nest depth: 0, expected: 0 [ 13.997493][ C3] INFO: lockdep is turned off. [ 13.997493][ C3] irq event stamp: 220703 [ 13.997494][ C3] hardirqs last enabled at (220703): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.997498][ C3] hardirqs last disabled at (220702): [] do_idle+0xd1/0x190 [ 13.997499][ C3] softirqs last enabled at (220696): [] handle_softirqs+0x67c/0x900 [ 13.997501][ C3] softirqs last disabled at (220685): [] __irq_exit_rcu+0x145/0x1c0 [ 13.997503][ C3] Preemption disabled at: [ 13.997504][ C3] [<0000000000000000>] 0x0 [ 13.997507][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.997510][ C3] Tainted: [W]=WARN [ 13.997511][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.997512][ C3] Call Trace: [ 13.997513][ C3] [ 13.997514][ C3] dump_stack_lvl+0x6f/0xa0 [ 13.997517][ C3] __might_resched.cold+0x1fe/0x2c1 [ 13.997519][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.997521][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997524][ C3] __kmalloc_noprof+0x443/0x760 [ 13.997526][ C3] ? __rwlock_init+0x150/0x150 [ 13.997528][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 13.997530][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 13.997532][ C3] alloc_buf.isra.0+0x4b/0x260 [ 13.997533][ C3] put_chars+0x1e1/0x2f0 [ 13.997535][ C3] ? __send_to_port+0x420/0x420 [ 13.997537][ C3] ? printk_get_next_message+0x240/0x650 [ 13.997539][ C3] hvc_console_print+0x292/0x780 [ 13.997542][ C3] ? hvc_write+0x3a0/0x3a0 [ 13.997543][ C3] ? __rwlock_init+0x150/0x150 [ 13.997545][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997547][ C3] ? lock_acquire+0x13c/0x160 [ 13.997548][ C3] console_emit_next_record+0x22f/0x4c0 [ 13.997551][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 13.997552][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997554][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997556][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997557][ C3] ? lock_acquire+0x13c/0x160 [ 13.997559][ C3] ? console_flush_one_record+0x111/0x710 [ 13.997561][ C3] console_flush_one_record+0x46f/0x710 [ 13.997563][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 13.997565][ C3] console_unlock+0xee/0x1f0 [ 13.997567][ C3] ? lock_acquire+0x13c/0x160 [ 13.997568][ C3] ? console_flush_one_record+0x710/0x710 [ 13.997570][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997571][ C3] ? lock_release+0x184/0x1f0 [ 13.997573][ C3] ? lock_acquire+0x60/0x160 [ 13.997574][ C3] ? __rcu_read_lock+0x30/0x70 [ 13.997576][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.997578][ C3] ? vprintk_emit+0x320/0x3e0 [ 13.997580][ C3] vprintk_emit+0x37c/0x3e0 [ 13.997582][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 13.997583][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 13.997585][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997587][ C3] ? lock_acquire+0x13c/0x160 [ 13.997588][ C3] _printk+0xc7/0x100 [ 13.997591][ C3] ? snapshot_read.cold+0x21/0x21 [ 13.997592][ C3] ? ___ratelimit+0x4e7/0xa00 [ 13.997595][ C3] ? idr_get_free+0x830/0x830 [ 13.997597][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.997598][ C3] tcp_make_synack.cold+0x36/0xb6 [ 13.997601][ C3] ? tcp_send_synack+0x1570/0x1570 [ 13.997603][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997605][ C3] ? inet_csk_route_req+0x747/0xc30 [ 13.997607][ C3] tcp_v4_send_synack+0x103/0xb20 [ 13.997609][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.997611][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.997612][ C3] ? trace_hardirqs_on+0x36/0x40 [ 13.997614][ C3] ? get_random_u16+0x740/0x740 [ 13.997616][ C3] tcp_rtx_synack+0x150/0x440 [ 13.997618][ C3] ? tcp_send_probe0+0x590/0x590 [ 13.997620][ C3] ? sched_balance_rq+0x324/0x1e30 [ 13.997622][ C3] ? do_raw_spin_lock+0x131/0x280 [ 13.997623][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 13.997625][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.997627][ C3] ? lock_acquire+0x6a/0x160 [ 13.997628][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 13.997630][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.997631][ C3] call_timer_fn+0x160/0x4d0 [ 13.997633][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 13.997635][ C3] ? debug_object_active_state+0x430/0x430 [ 13.997638][ C3] ? __rwlock_init+0x150/0x150 [ 13.997639][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.997641][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997643][ C3] __run_timers+0x68f/0xaa0 [ 13.997645][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.997647][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.997649][ C3] ? do_raw_spin_lock+0x131/0x280 [ 13.997651][ C3] ? __rwlock_init+0x150/0x150 [ 13.997653][ C3] run_timer_softirq+0xf0/0x160 [ 13.997655][ C3] ? __run_timers+0xaa0/0xaa0 [ 13.997657][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.997658][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997660][ C3] handle_softirqs+0x1d3/0x900 [ 13.997662][ C3] ? _local_bh_enable+0xc0/0xc0 [ 13.997664][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997665][ C3] ? lock_release+0x184/0x1f0 [ 13.997667][ C3] __irq_exit_rcu+0x145/0x1c0 [ 13.997668][ C3] irq_exit_rcu+0xe/0x30 [ 13.997670][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.997672][ C3] [ 13.997672][ C3] [ 13.997673][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 13.997674][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.997676][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.997678][ C3] 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.997679][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 13.997681][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 13.997682][ C3] RDX: 0000000000000003 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 13.997683][ C3] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a763a2 [ 13.997684][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 13.997684][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.997686][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.997688][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.997689][ C3] default_idle+0x9/0x10 [ 13.997691][ C3] default_idle_call+0x6e/0xb0 [ 13.997692][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.997694][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 13.997695][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 13.997697][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.997699][ C3] do_idle+0xd8/0x190 [ 13.997700][ C3] cpu_startup_entry+0x53/0x70 [ 13.997702][ C3] start_secondary+0x204/0x2b0 [ 13.997703][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.997705][ C3] common_startup_64+0x13e/0x148 [ 13.997708][ C3] [ 14.014637][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.022474][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.022477][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.022478][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 15.022479][ C3] preempt_count: 102, expected: 0 [ 15.022480][ C3] RCU nest depth: 0, expected: 0 [ 15.022481][ C3] INFO: lockdep is turned off. [ 15.022481][ C3] irq event stamp: 220703 [ 15.022482][ C3] hardirqs last enabled at (220703): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.022485][ C3] hardirqs last disabled at (220702): [] do_idle+0xd1/0x190 [ 15.022486][ C3] softirqs last enabled at (220696): [] handle_softirqs+0x67c/0x900 [ 15.022488][ C3] softirqs last disabled at (220685): [] __irq_exit_rcu+0x145/0x1c0 [ 15.022490][ C3] Preemption disabled at: [ 15.022490][ C3] [<0000000000000000>] 0x0 [ 15.022493][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.022495][ C3] Tainted: [W]=WARN [ 15.022496][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.022497][ C3] Call Trace: [ 15.022497][ C3] [ 15.022499][ C3] dump_stack_lvl+0x6f/0xa0 [ 15.022501][ C3] __might_resched.cold+0x1fe/0x2c1 [ 15.022503][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.022506][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022508][ C3] __kmalloc_noprof+0x443/0x760 [ 15.022510][ C3] ? __rwlock_init+0x150/0x150 [ 15.022511][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 15.022514][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 15.022515][ C3] alloc_buf.isra.0+0x4b/0x260 [ 15.022517][ C3] put_chars+0x1e1/0x2f0 [ 15.022518][ C3] ? __send_to_port+0x420/0x420 [ 15.022520][ C3] ? printk_get_next_message+0x240/0x650 [ 15.022522][ C3] hvc_console_print+0x292/0x780 [ 15.022525][ C3] ? hvc_write+0x3a0/0x3a0 [ 15.022526][ C3] ? __rwlock_init+0x150/0x150 [ 15.022528][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022529][ C3] ? lock_acquire+0x13c/0x160 [ 15.022531][ C3] console_emit_next_record+0x22f/0x4c0 [ 15.022534][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 15.022535][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022537][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022538][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022540][ C3] ? lock_acquire+0x13c/0x160 [ 15.022542][ C3] ? console_flush_one_record+0x111/0x710 [ 15.022543][ C3] console_flush_one_record+0x46f/0x710 [ 15.022546][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 15.022548][ C3] console_unlock+0xee/0x1f0 [ 15.022550][ C3] ? lock_acquire+0x13c/0x160 [ 15.022551][ C3] ? console_flush_one_record+0x710/0x710 [ 15.022553][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022554][ C3] ? lock_release+0x184/0x1f0 [ 15.022556][ C3] ? lock_acquire+0x60/0x160 [ 15.022557][ C3] ? __rcu_read_lock+0x30/0x70 [ 15.022559][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.022560][ C3] ? vprintk_emit+0x320/0x3e0 [ 15.022562][ C3] vprintk_emit+0x37c/0x3e0 [ 15.022564][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 15.022566][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 15.022568][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022569][ C3] ? lock_acquire+0x13c/0x160 [ 15.022571][ C3] _printk+0xc7/0x100 [ 15.022573][ C3] ? snapshot_read.cold+0x21/0x21 [ 15.022575][ C3] ? ___ratelimit+0x4e7/0xa00 [ 15.022577][ C3] ? trace_hardirqs_on+0x36/0x40 [ 15.022578][ C3] ? idr_get_free+0x830/0x830 [ 15.022580][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.022581][ C3] tcp_make_synack.cold+0x36/0xb6 [ 15.022584][ C3] ? tcp_send_synack+0x1570/0x1570 [ 15.022586][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022588][ C3] ? inet_csk_route_req+0x747/0xc30 [ 15.022590][ C3] tcp_v4_send_synack+0x103/0xb20 [ 15.022592][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.022593][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 15.022596][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.022597][ C3] ? trace_hardirqs_on+0x36/0x40 [ 15.022598][ C3] ? get_random_u16+0x740/0x740 [ 15.022600][ C3] tcp_rtx_synack+0x150/0x440 [ 15.022602][ C3] ? tcp_send_probe0+0x590/0x590 [ 15.022604][ C3] ? sched_balance_rq+0x324/0x1e30 [ 15.022606][ C3] ? do_raw_spin_lock+0x131/0x280 [ 15.022608][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 15.022609][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.022611][ C3] ? lock_acquire+0x6a/0x160 [ 15.022612][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 15.022614][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.022615][ C3] call_timer_fn+0x160/0x4d0 [ 15.022617][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 15.022619][ C3] ? debug_object_active_state+0x430/0x430 [ 15.022621][ C3] ? __rwlock_init+0x150/0x150 [ 15.022623][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 15.022625][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022627][ C3] __run_timers+0x68f/0xaa0 [ 15.022628][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.022630][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.022632][ C3] ? do_raw_spin_lock+0x131/0x280 [ 15.022635][ C3] ? __rwlock_init+0x150/0x150 [ 15.022637][ C3] run_timer_softirq+0xf0/0x160 [ 15.022639][ C3] ? __run_timers+0xaa0/0xaa0 [ 15.022640][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.022641][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022643][ C3] handle_softirqs+0x1d3/0x900 [ 15.022645][ C3] ? _local_bh_enable+0xc0/0xc0 [ 15.022647][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022648][ C3] ? lock_release+0x184/0x1f0 [ 15.022650][ C3] __irq_exit_rcu+0x145/0x1c0 [ 15.022651][ C3] irq_exit_rcu+0xe/0x30 [ 15.022653][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.022654][ C3] [ 15.022655][ C3] [ 15.022655][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 15.022657][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.022659][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.022660][ C3] 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.022662][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 15.022663][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 15.022664][ C3] RDX: 0000000000000003 RSI: ffffffffa688dc60 RDI: ffffffffa3efa307 [ 15.022665][ C3] RBP: 0000000000000000 R08: ffffffffa651f421 R09: 1fe2200006a763a2 [ 15.022666][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 15.022666][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.022668][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.022669][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.022671][ C3] default_idle+0x9/0x10 [ 15.022672][ C3] default_idle_call+0x6e/0xb0 [ 15.022674][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.022675][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 15.022677][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 15.022678][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.022680][ C3] do_idle+0xd8/0x190 [ 15.022682][ C3] cpu_startup_entry+0x53/0x70 [ 15.022683][ C3] start_secondary+0x204/0x2b0 [ 15.022685][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.022686][ C3] common_startup_64+0x13e/0x148 [ 15.022689][ C3]