[ 9.797843][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.797869][ C1] [ 9.797870][ C1] ======================================================== [ 9.797871][ C1] WARNING: possible irq lock inversion dependency detected [ 9.797873][ C1] 7.2.0-virtme #1 Tainted: G W [ 9.797874][ C1] -------------------------------------------------------- [ 9.797875][ C1] connect-deny_ip/169 just changed the state of lock: [ 9.797876][ C1] ffffffff9bc99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 9.797888][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 9.797889][ C1] (fs_reclaim){+.+.}-{0:0} [ 9.797890][ C1] [ 9.797890][ C1] [ 9.797890][ C1] and interrupts could create inverse lock ordering between them. [ 9.797890][ C1] [ 9.797891][ C1] [ 9.797891][ C1] other info that might help us debug this: [ 9.797892][ C1] Possible interrupt unsafe locking scenario: [ 9.797892][ C1] [ 9.797892][ C1] CPU0 CPU1 [ 9.797893][ C1] ---- ---- [ 9.797893][ C1] lock(fs_reclaim); [ 9.797894][ C1] local_irq_disable(); [ 9.797895][ C1] lock(console_owner); [ 9.797896][ C1] lock(fs_reclaim); [ 9.797897][ C1] [ 9.797897][ C1] lock(console_owner); [ 9.797898][ C1] [ 9.797898][ C1] *** DEADLOCK *** [ 9.797898][ C1] [ 9.797898][ C1] locks held by connect-deny_ip/169: 9, last CPU#1: [ 9.797900][ C1] #0: ff1100000f72c890 (sk_lock-AF_INET6){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 9.797906][ C1] #1: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: inet6_csk_xmit+0xfe/0x5f0 [ 9.797911][ C1] #2: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: ip6_xmit+0x26a/0x1ec0 [ 9.797915][ C1] #3: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: ip6_output+0x11d/0x7f0 [ 9.797918][ C1] #4: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 9.797923][ C1] #5: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: ip6_input+0xa1/0x570 [ 9.797926][ C1] #6: ffffffff9bd90b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 9.797931][ C1] #7: ffffffff9bd79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 9.797934][ C1] #8: ffffffff9bd79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 9.797937][ C1] [ 9.797937][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 9.797942][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 9.797944][ C1] HARDIRQ-ON-W at: [ 9.797946][ C1] __lock_acquire+0x388/0xc20 [ 9.797949][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.797951][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.797954][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.797956][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.797958][ C1] workqueue_init+0x2a/0x680 [ 9.797962][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.797965][ C1] kernel_init+0x21/0x150 [ 9.797967][ C1] ret_from_fork+0x474/0x6b0 [ 9.797970][ C1] ret_from_fork_asm+0x11/0x20 [ 9.797973][ C1] SOFTIRQ-ON-W at: [ 9.797974][ C1] __lock_acquire+0x388/0xc20 [ 9.797975][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.797977][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.797978][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.797979][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.797981][ C1] workqueue_init+0x2a/0x680 [ 9.797982][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.797983][ C1] kernel_init+0x21/0x150 [ 9.797985][ C1] ret_from_fork+0x474/0x6b0 [ 9.797986][ C1] ret_from_fork_asm+0x11/0x20 [ 9.797987][ C1] INITIAL USE at: [ 9.797988][ C1] __lock_acquire+0x388/0xc20 [ 9.797989][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.797991][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.797992][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 9.797993][ C1] kthread_create_worker_on_node+0xea/0x210 [ 9.797995][ C1] workqueue_init+0x2a/0x680 [ 9.797996][ C1] kernel_init_freeable+0x2fe/0x630 [ 9.797997][ C1] kernel_init+0x21/0x150 [ 9.797999][ C1] ret_from_fork+0x474/0x6b0 [ 9.798000][ C1] ret_from_fork_asm+0x11/0x20 [ 9.798001][ C1] } [ 9.798001][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 9.798005][ C1] ... acquired at: [ 9.798006][ C1] __lock_acquire+0x518/0xc20 [ 9.798008][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.798009][ C1] fs_reclaim_acquire+0xd5/0x120 [ 9.798010][ C1] __kmalloc_noprof+0xd3/0x760 [ 9.798011][ C1] alloc_buf.isra.0+0x4b/0x260 [ 9.798015][ C1] put_chars+0x1e1/0x2f0 [ 9.798016][ C1] hvc_console_print+0x292/0x780 [ 9.798019][ C1] console_emit_next_record+0x22f/0x4c0 [ 9.798020][ C1] console_flush_one_record+0x46f/0x710 [ 9.798022][ C1] console_unlock+0xee/0x1f0 [ 9.798023][ C1] vprintk_emit+0x37c/0x3e0 [ 9.798025][ C1] dev_vprintk_emit+0x27f/0x2c0 [ 9.798029][ C1] dev_printk_emit+0xb9/0xee [ 9.798030][ C1] _dev_info+0xe2/0x116 [ 9.798032][ C1] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 9.798034][ C1] cmos_do_probe+0x73b/0x98a [ 9.798036][ C1] platform_probe+0xfe/0x1f0 [ 9.798038][ C1] call_driver_probe+0x61/0x1c0 [ 9.798040][ C1] really_probe+0x199/0x760 [ 9.798042][ C1] __driver_probe_device+0x24f/0x440 [ 9.798044][ C1] driver_probe_device+0x4a/0xf0 [ 9.798045][ C1] __driver_attach+0x1b8/0x540 [ 9.798047][ C1] bus_for_each_dev+0x130/0x1e0 [ 9.798048][ C1] bus_add_driver+0x2c8/0x530 [ 9.798050][ C1] driver_register+0x1a3/0x390 [ 9.798051][ C1] __platform_driver_probe+0x13f/0x270 [ 9.798052][ C1] cmos_init+0x31/0x40 [ 9.798055][ C1] do_one_initcall+0x124/0x4f0 [ 9.798056][ C1] kernel_init_freeable+0x596/0x630 [ 9.798058][ C1] kernel_init+0x21/0x150 [ 9.798059][ C1] ret_from_fork+0x474/0x6b0 [ 9.798060][ C1] ret_from_fork_asm+0x11/0x20 [ 9.798062][ C1] [ 9.798062][ C1] -> (console_owner){..-.}-{0:0} { [ 9.798064][ C1] IN-SOFTIRQ-W at: [ 9.798065][ C1] __lock_acquire+0x388/0xc20 [ 9.798066][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.798067][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.798069][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.798071][ C1] console_flush_one_record+0x46f/0x710 [ 9.798072][ C1] console_unlock+0xee/0x1f0 [ 9.798074][ C1] vprintk_emit+0x37c/0x3e0 [ 9.798075][ C1] _printk+0xc7/0x100 [ 9.798078][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.798080][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 9.798082][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.798084][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798086][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.798087][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 9.798088][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 9.798090][ C1] ip6_input_finish+0x196/0x590 [ 9.798091][ C1] ip6_input+0x130/0x570 [ 9.798093][ C1] ipv6_rcv+0x3c1/0x5a0 [ 9.798094][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.798096][ C1] process_backlog+0x431/0x14c0 [ 9.798098][ C1] __napi_poll+0xa7/0x3b0 [ 9.798099][ C1] net_rx_action+0x513/0xf50 [ 9.798103][ C1] handle_softirqs+0x1d3/0x900 [ 9.798106][ C1] do_softirq+0xac/0xe0 [ 9.798107][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.798108][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.798110][ C1] ip6_finish_output2+0x96f/0x12a0 [ 9.798112][ C1] ip6_finish_output+0x646/0xda0 [ 9.798113][ C1] ip6_output+0x23f/0x7f0 [ 9.798114][ C1] ip6_xmit+0xc44/0x1ec0 [ 9.798116][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 9.798117][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.798119][ C1] tcp_connect+0x1024/0x1e20 [ 9.798120][ C1] tcp_v6_connect+0x148b/0x2380 [ 9.798121][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.798122][ C1] inet_stream_connect+0x59/0xb0 [ 9.798123][ C1] __sys_connect+0x1cf/0x2e0 [ 9.798126][ C1] __x64_sys_connect+0x72/0xd0 [ 9.798127][ C1] do_syscall_64+0xff/0x530 [ 9.798130][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.798132][ C1] INITIAL USE at: [ 9.798133][ C1] } [ 9.798133][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 9.798137][ C1] ... acquired at: [ 9.798137][ C1] mark_lock+0x1d7/0xa00 [ 9.798138][ C1] mark_usage+0x42/0x170 [ 9.798140][ C1] __lock_acquire+0x388/0xc20 [ 9.798141][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.798142][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.798144][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.798146][ C1] console_flush_one_record+0x46f/0x710 [ 9.798147][ C1] console_unlock+0xee/0x1f0 [ 9.798149][ C1] vprintk_emit+0x37c/0x3e0 [ 9.798150][ C1] _printk+0xc7/0x100 [ 9.798152][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.798153][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 9.798154][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.798156][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798158][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.798159][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 9.798160][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 9.798161][ C1] ip6_input_finish+0x196/0x590 [ 9.798163][ C1] ip6_input+0x130/0x570 [ 9.798164][ C1] ipv6_rcv+0x3c1/0x5a0 [ 9.798165][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.798167][ C1] process_backlog+0x431/0x14c0 [ 9.798169][ C1] __napi_poll+0xa7/0x3b0 [ 9.798170][ C1] net_rx_action+0x513/0xf50 [ 9.798172][ C1] handle_softirqs+0x1d3/0x900 [ 9.798173][ C1] do_softirq+0xac/0xe0 [ 9.798175][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.798176][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.798177][ C1] ip6_finish_output2+0x96f/0x12a0 [ 9.798179][ C1] ip6_finish_output+0x646/0xda0 [ 9.798180][ C1] ip6_output+0x23f/0x7f0 [ 9.798181][ C1] ip6_xmit+0xc44/0x1ec0 [ 9.798183][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 9.798184][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.798185][ C1] tcp_connect+0x1024/0x1e20 [ 9.798186][ C1] tcp_v6_connect+0x148b/0x2380 [ 9.798187][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.798188][ C1] inet_stream_connect+0x59/0xb0 [ 9.798189][ C1] __sys_connect+0x1cf/0x2e0 [ 9.798191][ C1] __x64_sys_connect+0x72/0xd0 [ 9.798192][ C1] do_syscall_64+0xff/0x530 [ 9.798194][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.798195][ C1] [ 9.798195][ C1] [ 9.798195][ C1] stack backtrace: [ 9.798198][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.798202][ C1] Tainted: [W]=WARN [ 9.798203][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.798204][ C1] Call Trace: [ 9.798206][ C1] [ 9.798207][ C1] dump_stack_lvl+0x6f/0xa0 [ 9.798211][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 9.798213][ C1] mark_lock_irq+0x989/0x9c0 [ 9.798216][ C1] mark_lock+0x1d7/0xa00 [ 9.798218][ C1] mark_usage+0x42/0x170 [ 9.798220][ C1] __lock_acquire+0x388/0xc20 [ 9.798222][ C1] lock_acquire.part.0+0xd4/0x280 [ 9.798224][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 9.798226][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798229][ C1] ? lock_acquire+0x13c/0x160 [ 9.798231][ C1] console_lock_spinning_enable+0x5c/0x60 [ 9.798233][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 9.798235][ C1] console_emit_next_record+0x1d1/0x4c0 [ 9.798237][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 9.798238][ C1] ? console_flush_one_record+0x106/0x710 [ 9.798240][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798242][ C1] ? lock_acquire+0x13c/0x160 [ 9.798244][ C1] console_flush_one_record+0x46f/0x710 [ 9.798246][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 9.798248][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798250][ C1] console_unlock+0xee/0x1f0 [ 9.798252][ C1] ? console_flush_one_record+0x710/0x710 [ 9.798254][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798256][ C1] ? lock_acquire+0x60/0x160 [ 9.798258][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.798259][ C1] ? vprintk_emit+0x320/0x3e0 [ 9.798261][ C1] vprintk_emit+0x37c/0x3e0 [ 9.798263][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 9.798265][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798267][ C1] _printk+0xc7/0x100 [ 9.798269][ C1] ? snapshot_read.cold+0x21/0x21 [ 9.798271][ C1] ? ___ratelimit+0x4e7/0xa00 [ 9.798274][ C1] ? idr_get_free+0x830/0x830 [ 9.798276][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.798278][ C1] ? tcp_send_synack+0x1570/0x1570 [ 9.798280][ C1] ? add_timer_on+0x580/0x580 [ 9.798284][ C1] ? lockdep_init_map_type+0x5d/0x250 [ 9.798285][ C1] ? timer_init_key+0x10d/0x280 [ 9.798287][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 9.798289][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 9.798290][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x10/0x160 [ 9.798293][ C1] ? tcp_v6_route_req+0x501/0x640 [ 9.798294][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.798297][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.798300][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.798302][ C1] ? mark_usage+0x61/0x170 [ 9.798304][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798306][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798307][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798309][ C1] ? down_read_nested+0xe7/0x500 [ 9.798312][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798314][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798316][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.798317][ C1] ? tcp_v6_fill_cb+0x33/0x440 [ 9.798319][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 9.798321][ C1] ? tcp_v6_syn_recv_sock+0x1be0/0x1be0 [ 9.798323][ C1] ? ipv6_raw_deliver+0x35f/0x930 [ 9.798326][ C1] ? ipv6_raw_deliver+0x369/0x930 [ 9.798327][ C1] ? rcu_do_batch+0x2b6/0x1000 [ 9.798329][ C1] ? is_bpf_text_address+0x72/0x110 [ 9.798333][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 9.798336][ C1] ip6_input_finish+0x196/0x590 [ 9.798338][ C1] ip6_input+0x130/0x570 [ 9.798339][ C1] ? ip6_input_finish+0x590/0x590 [ 9.798341][ C1] ? ip6_rcv_core+0xe22/0x1be0 [ 9.798344][ C1] ipv6_rcv+0x3c1/0x5a0 [ 9.798345][ C1] ? ip6_rcv_core+0x1be0/0x1be0 [ 9.798347][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 9.798349][ C1] ? mark_usage+0x61/0x170 [ 9.798350][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798352][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 9.798354][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.798356][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.798358][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798359][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.798361][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.798363][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798366][ C1] process_backlog+0x431/0x14c0 [ 9.798368][ C1] __napi_poll+0xa7/0x3b0 [ 9.798370][ C1] net_rx_action+0x513/0xf50 [ 9.798373][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798374][ C1] ? __napi_poll+0x3b0/0x3b0 [ 9.798378][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 9.798380][ C1] ? mark_held_locks+0x40/0x70 [ 9.798382][ C1] handle_softirqs+0x1d3/0x900 [ 9.798384][ C1] ? _local_bh_enable+0xc0/0xc0 [ 9.798386][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.798388][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798389][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 9.798391][ C1] do_softirq+0xac/0xe0 [ 9.798393][ C1] [ 9.798393][ C1] [ 9.798394][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.798395][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.798399][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.798400][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798402][ C1] ? find_held_lock+0x2b/0x80 [ 9.798403][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798405][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798407][ C1] ? mark_held_locks+0x40/0x70 [ 9.798408][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.798410][ C1] ? neigh_hh_output+0x152/0x4c0 [ 9.798413][ C1] ip6_finish_output2+0x96f/0x12a0 [ 9.798415][ C1] ? ip6_dst_lookup+0x80/0x80 [ 9.798416][ C1] ? find_held_lock+0x2b/0x80 [ 9.798418][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798420][ C1] ? ip6_mtu+0x15d/0x310 [ 9.798422][ C1] ip6_finish_output+0x646/0xda0 [ 9.798424][ C1] ip6_output+0x23f/0x7f0 [ 9.798426][ C1] ? ip6_finish_output+0xda0/0xda0 [ 9.798428][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798429][ C1] ? find_held_lock+0x2b/0x80 [ 9.798431][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798433][ C1] ip6_xmit+0xc44/0x1ec0 [ 9.798434][ C1] ? mark_usage+0x61/0x170 [ 9.798436][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798438][ C1] ? ip6_autoflowlabel+0x120/0x120 [ 9.798440][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798441][ C1] ? mark_usage+0x61/0x170 [ 9.798443][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798445][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798446][ C1] ? inet6_csk_xmit+0xfe/0x5f0 [ 9.798448][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798450][ C1] ? lock_acquire+0x13c/0x160 [ 9.798451][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 9.798454][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.798456][ C1] ? __tcp_select_window+0xf20/0xf20 [ 9.798458][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798460][ C1] ? ktime_get+0x18e/0x2d0 [ 9.798461][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 9.798464][ C1] ? ktime_get+0x1dd/0x2d0 [ 9.798466][ C1] tcp_connect+0x1024/0x1e20 [ 9.798467][ C1] ? inet6_hash_connect+0xca/0x170 [ 9.798470][ C1] tcp_v6_connect+0x148b/0x2380 [ 9.798472][ C1] ? inet6_sk_rx_dst_set+0x230/0x230 [ 9.798474][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798475][ C1] ? do_raw_spin_lock+0x131/0x280 [ 9.798477][ C1] ? find_held_lock+0x2b/0x80 [ 9.798479][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.798480][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798482][ C1] inet_stream_connect+0x59/0xb0 [ 9.798483][ C1] __sys_connect+0x1cf/0x2e0 [ 9.798485][ C1] ? do_fcntl+0x36f/0xc50 [ 9.798488][ C1] ? __sys_connect_file+0x250/0x250 [ 9.798491][ C1] ? fput+0x1f/0xa0 [ 9.798493][ C1] __x64_sys_connect+0x72/0xd0 [ 9.798495][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798496][ C1] ? do_syscall_64+0xa6/0x530 [ 9.798497][ C1] do_syscall_64+0xff/0x530 [ 9.798499][ C1] ? exc_page_fault+0xee/0x100 [ 9.798500][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.798502][ C1] RIP: 0033:0x7fccc5c2e312 [ 9.798506][ 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.798507][ C1] RSP: 002b:00007fccc53ab968 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.798510][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007fccc5c2e312 [ 9.798512][ C1] RDX: 000000000000001c RSI: 00007fccc53abc30 RDI: 0000000000000009 [ 9.798512][ C1] RBP: 00007fccc53ab990 R08: 0000000000000000 R09: 0000000000000000 [ 9.798513][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fccc53abc30 [ 9.798514][ C1] R13: 000000000000001c R14: 0000000000000001 R15: 0000000000412230 [ 9.798516][ C1] [ 9.798521][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.798522][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 9.798523][ C1] preempt_count: 302, expected: 0 [ 9.798524][ C1] RCU nest depth: 6, expected: 0 [ 9.798525][ C1] INFO: lockdep is turned off. [ 9.798525][ C1] irq event stamp: 12721 [ 9.798526][ C1] hardirqs last enabled at (12720): [] __down_trylock_console_sem+0x86/0xa0 [ 9.798528][ C1] hardirqs last disabled at (12721): [] console_emit_next_record+0x3d4/0x4c0 [ 9.798530][ C1] softirqs last enabled at (12540): [] __dev_queue_xmit+0x964/0x1b80 [ 9.798532][ C1] softirqs last disabled at (12541): [] do_softirq+0xac/0xe0 [ 9.798534][ C1] Preemption disabled at: [ 9.798535][ C1] [] __dev_queue_xmit+0x204/0x1b80 [ 9.798537][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.798540][ C1] Tainted: [W]=WARN [ 9.798540][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.798541][ C1] Call Trace: [ 9.798542][ C1] [ 9.798542][ C1] dump_stack_lvl+0x6f/0xa0 [ 9.798544][ C1] ? __dev_queue_xmit+0x204/0x1b80 [ 9.798546][ C1] __might_resched.cold+0x1fe/0x2c1 [ 9.798549][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.798552][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798554][ C1] __kmalloc_noprof+0x443/0x760 [ 9.798556][ C1] ? __rwlock_init+0x150/0x150 [ 9.798557][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 9.798559][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.798561][ C1] alloc_buf.isra.0+0x4b/0x260 [ 9.798563][ C1] put_chars+0x1e1/0x2f0 [ 9.798565][ C1] ? __send_to_port+0x420/0x420 [ 9.798567][ C1] hvc_console_print+0x292/0x780 [ 9.798569][ C1] ? __lock_acquire+0x388/0xc20 [ 9.798571][ C1] ? hvc_write+0x3a0/0x3a0 [ 9.798573][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798575][ C1] ? lock_acquire+0x13c/0x160 [ 9.798577][ C1] console_emit_next_record+0x22f/0x4c0 [ 9.798579][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 9.798581][ C1] ? console_flush_one_record+0x106/0x710 [ 9.798583][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798584][ C1] ? lock_acquire+0x13c/0x160 [ 9.798586][ C1] console_flush_one_record+0x46f/0x710 [ 9.798588][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 9.798590][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798592][ C1] console_unlock+0xee/0x1f0 [ 9.798594][ C1] ? console_flush_one_record+0x710/0x710 [ 9.798596][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798598][ C1] ? lock_acquire+0x60/0x160 [ 9.798599][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.798601][ C1] ? vprintk_emit+0x320/0x3e0 [ 9.798603][ C1] vprintk_emit+0x37c/0x3e0 [ 9.798605][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 9.798607][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798609][ C1] _printk+0xc7/0x100 [ 9.798611][ C1] ? snapshot_read.cold+0x21/0x21 [ 9.798612][ C1] ? ___ratelimit+0x4e7/0xa00 [ 9.798614][ C1] ? idr_get_free+0x830/0x830 [ 9.798617][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.798619][ C1] ? tcp_send_synack+0x1570/0x1570 [ 9.798621][ C1] ? add_timer_on+0x580/0x580 [ 9.798623][ C1] ? lockdep_init_map_type+0x5d/0x250 [ 9.798625][ C1] ? timer_init_key+0x10d/0x280 [ 9.798627][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 9.798629][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 9.798630][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x10/0x160 [ 9.798632][ C1] ? tcp_v6_route_req+0x501/0x640 [ 9.798634][ C1] tcp_conn_request+0x1f15/0x2d20 [ 9.798636][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 9.798639][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 9.798640][ C1] ? mark_usage+0x61/0x170 [ 9.798642][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798644][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798645][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798647][ C1] ? down_read_nested+0xe7/0x500 [ 9.798650][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798652][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 9.798654][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 9.798655][ C1] ? tcp_v6_fill_cb+0x33/0x440 [ 9.798656][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 9.798659][ C1] ? tcp_v6_syn_recv_sock+0x1be0/0x1be0 [ 9.798661][ C1] ? ipv6_raw_deliver+0x35f/0x930 [ 9.798662][ C1] ? ipv6_raw_deliver+0x369/0x930 [ 9.798664][ C1] ? rcu_do_batch+0x2b6/0x1000 [ 9.798665][ C1] ? is_bpf_text_address+0x72/0x110 [ 9.798668][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 9.798671][ C1] ip6_input_finish+0x196/0x590 [ 9.798672][ C1] ip6_input+0x130/0x570 [ 9.798674][ C1] ? ip6_input_finish+0x590/0x590 [ 9.798676][ C1] ? ip6_rcv_core+0xe22/0x1be0 [ 9.798678][ C1] ipv6_rcv+0x3c1/0x5a0 [ 9.798680][ C1] ? ip6_rcv_core+0x1be0/0x1be0 [ 9.798682][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 9.798683][ C1] ? mark_usage+0x61/0x170 [ 9.798685][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798686][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 9.798688][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.798696][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 9.798698][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798700][ C1] ? process_backlog+0x3f1/0x14c0 [ 9.798702][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 9.798704][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798706][ C1] process_backlog+0x431/0x14c0 [ 9.798709][ C1] __napi_poll+0xa7/0x3b0 [ 9.798711][ C1] net_rx_action+0x513/0xf50 [ 9.798713][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798715][ C1] ? __napi_poll+0x3b0/0x3b0 [ 9.798719][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 9.798720][ C1] ? mark_held_locks+0x40/0x70 [ 9.798722][ C1] handle_softirqs+0x1d3/0x900 [ 9.798724][ C1] ? _local_bh_enable+0xc0/0xc0 [ 9.798725][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.798727][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798729][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 9.798731][ C1] do_softirq+0xac/0xe0 [ 9.798732][ C1] [ 9.798733][ C1] [ 9.798733][ C1] __local_bh_enable_ip+0x118/0x150 [ 9.798735][ C1] __dev_queue_xmit+0x979/0x1b80 [ 9.798738][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 9.798740][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798741][ C1] ? find_held_lock+0x2b/0x80 [ 9.798743][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798744][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798746][ C1] ? mark_held_locks+0x40/0x70 [ 9.798747][ C1] ? __asan_memcpy+0x3c/0x60 [ 9.798749][ C1] ? neigh_hh_output+0x152/0x4c0 [ 9.798751][ C1] ip6_finish_output2+0x96f/0x12a0 [ 9.798753][ C1] ? ip6_dst_lookup+0x80/0x80 [ 9.798755][ C1] ? find_held_lock+0x2b/0x80 [ 9.798756][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798758][ C1] ? ip6_mtu+0x15d/0x310 [ 9.798760][ C1] ip6_finish_output+0x646/0xda0 [ 9.798762][ C1] ip6_output+0x23f/0x7f0 [ 9.798764][ C1] ? ip6_finish_output+0xda0/0xda0 [ 9.798765][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798767][ C1] ? find_held_lock+0x2b/0x80 [ 9.798768][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798770][ C1] ip6_xmit+0xc44/0x1ec0 [ 9.798772][ C1] ? mark_usage+0x61/0x170 [ 9.798773][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798776][ C1] ? ip6_autoflowlabel+0x120/0x120 [ 9.798777][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 9.798779][ C1] ? mark_usage+0x61/0x170 [ 9.798780][ C1] ? __lock_acquire+0x518/0xc20 [ 9.798782][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798784][ C1] ? inet6_csk_xmit+0xfe/0x5f0 [ 9.798785][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.798787][ C1] ? lock_acquire+0x13c/0x160 [ 9.798789][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 9.798791][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 9.798794][ C1] ? __tcp_select_window+0xf20/0xf20 [ 9.798796][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798797][ C1] ? ktime_get+0x18e/0x2d0 [ 9.798798][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 9.798800][ C1] ? ktime_get+0x1dd/0x2d0 [ 9.798802][ C1] tcp_connect+0x1024/0x1e20 [ 9.798804][ C1] ? inet6_hash_connect+0xca/0x170 [ 9.798806][ C1] tcp_v6_connect+0x148b/0x2380 [ 9.798808][ C1] ? inet6_sk_rx_dst_set+0x230/0x230 [ 9.798809][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 9.798811][ C1] ? do_raw_spin_lock+0x131/0x280 [ 9.798812][ C1] ? find_held_lock+0x2b/0x80 [ 9.798814][ C1] __inet_stream_connect+0x2ed/0xd00 [ 9.798816][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798817][ C1] inet_stream_connect+0x59/0xb0 [ 9.798819][ C1] __sys_connect+0x1cf/0x2e0 [ 9.798820][ C1] ? do_fcntl+0x36f/0xc50 [ 9.798822][ C1] ? __sys_connect_file+0x250/0x250 [ 9.798825][ C1] ? fput+0x1f/0xa0 [ 9.798827][ C1] __x64_sys_connect+0x72/0xd0 [ 9.798828][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 9.798830][ C1] ? do_syscall_64+0xa6/0x530 [ 9.798831][ C1] do_syscall_64+0xff/0x530 [ 9.798833][ C1] ? exc_page_fault+0xee/0x100 [ 9.798834][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 9.798835][ C1] RIP: 0033:0x7fccc5c2e312 [ 9.798837][ 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.798838][ C1] RSP: 002b:00007fccc53ab968 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 9.798839][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007fccc5c2e312 [ 9.798840][ C1] RDX: 000000000000001c RSI: 00007fccc53abc30 RDI: 0000000000000009 [ 9.798841][ C1] RBP: 00007fccc53ab990 R08: 0000000000000000 R09: 0000000000000000 [ 9.798841][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fccc53abc30 [ 9.798842][ C1] R13: 000000000000001c R14: 0000000000000001 R15: 0000000000412230 [ 9.798844][ C1] [ 10.808166][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.808182][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.808184][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 10.808186][ C1] preempt_count: 102, expected: 0 [ 10.808187][ C1] RCU nest depth: 0, expected: 0 [ 10.808188][ C1] INFO: lockdep is turned off. [ 10.808189][ C1] irq event stamp: 279540 [ 10.808190][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 10.808198][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 10.808200][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 10.808204][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 10.808207][ C1] Preemption disabled at: [ 10.808207][ C1] [<0000000000000000>] 0x0 [ 10.808215][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.808218][ C1] Tainted: [W]=WARN [ 10.808219][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.808220][ C1] Call Trace: [ 10.808222][ C1] [ 10.808223][ C1] dump_stack_lvl+0x6f/0xa0 [ 10.808229][ C1] __might_resched.cold+0x1fe/0x2c1 [ 10.808233][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.808236][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808240][ C1] __kmalloc_noprof+0x443/0x760 [ 10.808244][ C1] ? __rwlock_init+0x150/0x150 [ 10.808246][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 10.808250][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.808252][ C1] alloc_buf.isra.0+0x4b/0x260 [ 10.808254][ C1] put_chars+0x1e1/0x2f0 [ 10.808256][ C1] ? __send_to_port+0x420/0x420 [ 10.808257][ C1] ? printk_get_next_message+0x240/0x650 [ 10.808260][ C1] ? console_prepend_replay+0x20/0x20 [ 10.808263][ C1] hvc_console_print+0x292/0x780 [ 10.808267][ C1] ? hvc_write+0x3a0/0x3a0 [ 10.808268][ C1] ? __rwlock_init+0x150/0x150 [ 10.808270][ C1] ? lock_acquire+0x13c/0x160 [ 10.808272][ C1] console_emit_next_record+0x22f/0x4c0 [ 10.808274][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 10.808276][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808278][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808279][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808281][ C1] ? lock_acquire+0x13c/0x160 [ 10.808283][ C1] ? console_flush_one_record+0x111/0x710 [ 10.808285][ C1] console_flush_one_record+0x46f/0x710 [ 10.808287][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 10.808289][ C1] console_unlock+0xee/0x1f0 [ 10.808291][ C1] ? lock_acquire+0x13c/0x160 [ 10.808293][ C1] ? console_flush_one_record+0x710/0x710 [ 10.808294][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808296][ C1] ? lock_release+0x184/0x1f0 [ 10.808297][ C1] ? lock_acquire+0x60/0x160 [ 10.808299][ C1] ? __rcu_read_lock+0x30/0x70 [ 10.808301][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.808303][ C1] ? vprintk_emit+0x320/0x3e0 [ 10.808305][ C1] vprintk_emit+0x37c/0x3e0 [ 10.808307][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 10.808309][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 10.808310][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808312][ C1] ? lock_acquire+0x13c/0x160 [ 10.808314][ C1] _printk+0xc7/0x100 [ 10.808317][ C1] ? snapshot_read.cold+0x21/0x21 [ 10.808318][ C1] ? ___ratelimit+0x4e7/0xa00 [ 10.808321][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.808324][ C1] ? idr_get_free+0x830/0x830 [ 10.808326][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.808327][ C1] tcp_make_synack.cold+0x36/0xb6 [ 10.808331][ C1] ? tcp_send_synack+0x1570/0x1570 [ 10.808334][ C1] ? lock_release+0x184/0x1f0 [ 10.808336][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 10.808340][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 10.808341][ C1] ? lock_acquire+0x13c/0x160 [ 10.808343][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 10.808344][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.808345][ C1] ? get_random_u16+0x740/0x740 [ 10.808348][ C1] tcp_rtx_synack+0x150/0x440 [ 10.808349][ C1] ? tcp_send_probe0+0x590/0x590 [ 10.808352][ C1] ? sched_balance_rq+0x324/0x1e30 [ 10.808354][ C1] ? cpu_startup_entry+0x53/0x70 [ 10.808355][ C1] ? start_secondary+0x204/0x2b0 [ 10.808357][ C1] ? common_startup_64+0x13e/0x148 [ 10.808361][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 10.808363][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.808365][ C1] ? lock_acquire+0x6a/0x160 [ 10.808366][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.808368][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.808369][ C1] call_timer_fn+0x160/0x4d0 [ 10.808372][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 10.808374][ C1] ? debug_object_active_state+0x430/0x430 [ 10.808378][ C1] ? __rwlock_init+0x150/0x150 [ 10.808380][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.808382][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808384][ C1] __run_timers+0x68f/0xaa0 [ 10.808386][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.808388][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.808390][ C1] ? do_raw_spin_lock+0x131/0x280 [ 10.808392][ C1] ? __rwlock_init+0x150/0x150 [ 10.808395][ C1] run_timer_softirq+0xf0/0x160 [ 10.808397][ C1] ? __run_timers+0xaa0/0xaa0 [ 10.808398][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.808399][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808401][ C1] handle_softirqs+0x1d3/0x900 [ 10.808403][ C1] ? _local_bh_enable+0xc0/0xc0 [ 10.808405][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808406][ C1] ? lock_release+0x184/0x1f0 [ 10.808408][ C1] __irq_exit_rcu+0x145/0x1c0 [ 10.808409][ C1] irq_exit_rcu+0xe/0x30 [ 10.808411][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.808413][ C1] [ 10.808413][ C1] [ 10.808414][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 10.808416][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.808418][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.808420][ 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.808422][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 10.808425][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 10.808427][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 10.808428][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 10.808428][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 10.808429][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.808430][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.808432][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.808434][ C1] default_idle+0x9/0x10 [ 10.808435][ C1] default_idle_call+0x6e/0xb0 [ 10.808437][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.808438][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 10.808440][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 10.808442][ C1] ? default_idle_call+0x98/0xb0 [ 10.808443][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.808445][ C1] do_idle+0xd8/0x190 [ 10.808447][ C1] cpu_startup_entry+0x53/0x70 [ 10.808448][ C1] start_secondary+0x204/0x2b0 [ 10.808449][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.808451][ C1] common_startup_64+0x13e/0x148 [ 10.808454][ C1] [ 10.937251][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.960189][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.960206][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.960209][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 11.960210][ C1] preempt_count: 102, expected: 0 [ 11.960211][ C1] RCU nest depth: 0, expected: 0 [ 11.960212][ C1] INFO: lockdep is turned off. [ 11.960214][ C1] irq event stamp: 279540 [ 11.960214][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 11.960224][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 11.960226][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 11.960230][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 11.960232][ C1] Preemption disabled at: [ 11.960233][ C1] [<0000000000000000>] 0x0 [ 11.960240][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.960244][ C1] Tainted: [W]=WARN [ 11.960245][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.960247][ C1] Call Trace: [ 11.960248][ C1] [ 11.960251][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.960257][ C1] __might_resched.cold+0x1fe/0x2c1 [ 11.960261][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.960265][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960269][ C1] __kmalloc_noprof+0x443/0x760 [ 11.960273][ C1] ? __rwlock_init+0x150/0x150 [ 11.960276][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 11.960280][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.960282][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.960284][ C1] put_chars+0x1e1/0x2f0 [ 11.960286][ C1] ? __send_to_port+0x420/0x420 [ 11.960288][ C1] ? printk_get_next_message+0x240/0x650 [ 11.960291][ C1] ? console_prepend_replay+0x20/0x20 [ 11.960293][ C1] hvc_console_print+0x292/0x780 [ 11.960298][ C1] ? hvc_write+0x3a0/0x3a0 [ 11.960299][ C1] ? __rwlock_init+0x150/0x150 [ 11.960301][ C1] ? lock_acquire+0x13c/0x160 [ 11.960303][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.960306][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.960308][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960310][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960311][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960313][ C1] ? lock_acquire+0x13c/0x160 [ 11.960315][ C1] ? console_flush_one_record+0x111/0x710 [ 11.960317][ C1] console_flush_one_record+0x46f/0x710 [ 11.960319][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.960322][ C1] console_unlock+0xee/0x1f0 [ 11.960323][ C1] ? lock_acquire+0x13c/0x160 [ 11.960325][ C1] ? console_flush_one_record+0x710/0x710 [ 11.960327][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960329][ C1] ? lock_release+0x184/0x1f0 [ 11.960330][ C1] ? lock_acquire+0x60/0x160 [ 11.960332][ C1] ? __rcu_read_lock+0x30/0x70 [ 11.960334][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.960336][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.960338][ C1] vprintk_emit+0x37c/0x3e0 [ 11.960340][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.960342][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 11.960344][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960345][ C1] ? lock_acquire+0x13c/0x160 [ 11.960347][ C1] _printk+0xc7/0x100 [ 11.960350][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.960352][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.960355][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.960357][ C1] ? idr_get_free+0x830/0x830 [ 11.960359][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 11.960361][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.960365][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.960368][ C1] ? lock_release+0x184/0x1f0 [ 11.960370][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 11.960374][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 11.960376][ C1] ? lock_acquire+0x13c/0x160 [ 11.960377][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 11.960379][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.960380][ C1] ? get_random_u16+0x740/0x740 [ 11.960382][ C1] tcp_rtx_synack+0x150/0x440 [ 11.960384][ C1] ? tcp_send_probe0+0x590/0x590 [ 11.960387][ C1] ? sched_balance_rq+0x324/0x1e30 [ 11.960389][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.960391][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 11.960394][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.960395][ C1] ? lock_acquire+0x6a/0x160 [ 11.960397][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.960399][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.960400][ C1] call_timer_fn+0x160/0x4d0 [ 11.960403][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 11.960405][ C1] ? debug_object_active_state+0x430/0x430 [ 11.960409][ C1] ? __rwlock_init+0x150/0x150 [ 11.960411][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 11.960412][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960415][ C1] __run_timers+0x68f/0xaa0 [ 11.960416][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.960418][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.960421][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.960423][ C1] ? __rwlock_init+0x150/0x150 [ 11.960425][ C1] run_timer_softirq+0xf0/0x160 [ 11.960428][ C1] ? __run_timers+0xaa0/0xaa0 [ 11.960429][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.960431][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960432][ C1] handle_softirqs+0x1d3/0x900 [ 11.960435][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.960436][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960438][ C1] ? lock_release+0x184/0x1f0 [ 11.960440][ C1] __irq_exit_rcu+0x145/0x1c0 [ 11.960441][ C1] irq_exit_rcu+0xe/0x30 [ 11.960443][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.960445][ C1] [ 11.960445][ C1] [ 11.960446][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 11.960448][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.960451][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 11.960453][ 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.960454][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 11.960458][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 11.960459][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 11.960460][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 11.960461][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 11.960462][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 11.960463][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 11.960465][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.960467][ C1] default_idle+0x9/0x10 [ 11.960469][ C1] default_idle_call+0x6e/0xb0 [ 11.960470][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.960472][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 11.960473][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 11.960476][ C1] ? default_idle_call+0x98/0xb0 [ 11.960477][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.960479][ C1] do_idle+0xd8/0x190 [ 11.960481][ C1] cpu_startup_entry+0x53/0x70 [ 11.960482][ C1] start_secondary+0x204/0x2b0 [ 11.960484][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 11.960486][ C1] common_startup_64+0x13e/0x148 [ 11.960490][ C1] [ 11.979004][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.985213][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.985228][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.985230][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 12.985231][ C1] preempt_count: 102, expected: 0 [ 12.985232][ C1] RCU nest depth: 0, expected: 0 [ 12.985233][ C1] INFO: lockdep is turned off. [ 12.985235][ C1] irq event stamp: 279540 [ 12.985235][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 12.985243][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 12.985246][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 12.985249][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 12.985252][ C1] Preemption disabled at: [ 12.985253][ C1] [<0000000000000000>] 0x0 [ 12.985260][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.985263][ C1] Tainted: [W]=WARN [ 12.985264][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.985266][ C1] Call Trace: [ 12.985267][ C1] [ 12.985269][ C1] dump_stack_lvl+0x6f/0xa0 [ 12.985274][ C1] __might_resched.cold+0x1fe/0x2c1 [ 12.985278][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.985282][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985285][ C1] __kmalloc_noprof+0x443/0x760 [ 12.985289][ C1] ? __rwlock_init+0x150/0x150 [ 12.985292][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 12.985296][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.985297][ C1] alloc_buf.isra.0+0x4b/0x260 [ 12.985299][ C1] put_chars+0x1e1/0x2f0 [ 12.985301][ C1] ? __send_to_port+0x420/0x420 [ 12.985303][ C1] ? printk_get_next_message+0x240/0x650 [ 12.985306][ C1] ? console_prepend_replay+0x20/0x20 [ 12.985308][ C1] hvc_console_print+0x292/0x780 [ 12.985313][ C1] ? hvc_write+0x3a0/0x3a0 [ 12.985314][ C1] ? __rwlock_init+0x150/0x150 [ 12.985316][ C1] ? lock_acquire+0x13c/0x160 [ 12.985318][ C1] console_emit_next_record+0x22f/0x4c0 [ 12.985320][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 12.985322][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985324][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985326][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985328][ C1] ? lock_acquire+0x13c/0x160 [ 12.985329][ C1] ? console_flush_one_record+0x111/0x710 [ 12.985331][ C1] console_flush_one_record+0x46f/0x710 [ 12.985333][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 12.985336][ C1] console_unlock+0xee/0x1f0 [ 12.985338][ C1] ? lock_acquire+0x13c/0x160 [ 12.985339][ C1] ? console_flush_one_record+0x710/0x710 [ 12.985341][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985343][ C1] ? lock_release+0x184/0x1f0 [ 12.985344][ C1] ? lock_acquire+0x60/0x160 [ 12.985346][ C1] ? __rcu_read_lock+0x30/0x70 [ 12.985348][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.985350][ C1] ? vprintk_emit+0x320/0x3e0 [ 12.985352][ C1] vprintk_emit+0x37c/0x3e0 [ 12.985354][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 12.985356][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 12.985358][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985360][ C1] ? lock_acquire+0x13c/0x160 [ 12.985361][ C1] _printk+0xc7/0x100 [ 12.985365][ C1] ? snapshot_read.cold+0x21/0x21 [ 12.985366][ C1] ? ___ratelimit+0x4e7/0xa00 [ 12.985369][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.985372][ C1] ? idr_get_free+0x830/0x830 [ 12.985373][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.985375][ C1] tcp_make_synack.cold+0x36/0xb6 [ 12.985379][ C1] ? tcp_send_synack+0x1570/0x1570 [ 12.985382][ C1] ? lock_release+0x184/0x1f0 [ 12.985384][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 12.985387][ C1] ? __trace_set_current_state+0x160/0x160 [ 12.985390][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 12.985391][ C1] ? lock_acquire+0x13c/0x160 [ 12.985393][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 12.985394][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.985396][ C1] ? get_random_u16+0x740/0x740 [ 12.985398][ C1] tcp_rtx_synack+0x150/0x440 [ 12.985400][ C1] ? tcp_send_probe0+0x590/0x590 [ 12.985402][ C1] ? sched_balance_rq+0x324/0x1e30 [ 12.985405][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.985407][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 12.985410][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.985411][ C1] ? lock_acquire+0x6a/0x160 [ 12.985412][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.985414][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.985416][ C1] call_timer_fn+0x160/0x4d0 [ 12.985419][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 12.985420][ C1] ? debug_object_active_state+0x430/0x430 [ 12.985425][ C1] ? __rwlock_init+0x150/0x150 [ 12.985426][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.985428][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985430][ C1] __run_timers+0x68f/0xaa0 [ 12.985432][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.985434][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.985436][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.985439][ C1] ? __rwlock_init+0x150/0x150 [ 12.985441][ C1] run_timer_softirq+0xf0/0x160 [ 12.985443][ C1] ? __run_timers+0xaa0/0xaa0 [ 12.985445][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.985446][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985448][ C1] handle_softirqs+0x1d3/0x900 [ 12.985450][ C1] ? _local_bh_enable+0xc0/0xc0 [ 12.985451][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985453][ C1] ? lock_release+0x184/0x1f0 [ 12.985455][ C1] __irq_exit_rcu+0x145/0x1c0 [ 12.985456][ C1] irq_exit_rcu+0xe/0x30 [ 12.985458][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.985460][ C1] [ 12.985460][ C1] [ 12.985461][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 12.985463][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.985465][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.985468][ 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.985470][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 12.985473][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 12.985474][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 12.985475][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 12.985476][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 12.985477][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.985478][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.985480][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.985482][ C1] default_idle+0x9/0x10 [ 12.985484][ C1] default_idle_call+0x6e/0xb0 [ 12.985485][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.985487][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 12.985489][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 12.985491][ C1] ? default_idle_call+0x98/0xb0 [ 12.985493][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.985495][ C1] do_idle+0xd8/0x190 [ 12.985496][ C1] cpu_startup_entry+0x53/0x70 [ 12.985498][ C1] start_secondary+0x204/0x2b0 [ 12.985499][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.985501][ C1] common_startup_64+0x13e/0x148 [ 12.985506][ C1] [ 13.009547][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.072248][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.072266][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.072269][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 14.072271][ C1] preempt_count: 102, expected: 0 [ 14.072272][ C1] RCU nest depth: 0, expected: 0 [ 14.072274][ C1] INFO: lockdep is turned off. [ 14.072276][ C1] irq event stamp: 279540 [ 14.072277][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 14.072286][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 14.072289][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 14.072294][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 14.072297][ C1] Preemption disabled at: [ 14.072298][ C1] [<0000000000000000>] 0x0 [ 14.072306][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.072311][ C1] Tainted: [W]=WARN [ 14.072312][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.072315][ C1] Call Trace: [ 14.072317][ C1] [ 14.072320][ C1] dump_stack_lvl+0x6f/0xa0 [ 14.072327][ C1] __might_resched.cold+0x1fe/0x2c1 [ 14.072331][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.072335][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072340][ C1] __kmalloc_noprof+0x443/0x760 [ 14.072345][ C1] ? __rwlock_init+0x150/0x150 [ 14.072348][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 14.072353][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.072355][ C1] alloc_buf.isra.0+0x4b/0x260 [ 14.072359][ C1] put_chars+0x1e1/0x2f0 [ 14.072362][ C1] ? __send_to_port+0x420/0x420 [ 14.072364][ C1] ? printk_get_next_message+0x240/0x650 [ 14.072367][ C1] ? console_prepend_replay+0x20/0x20 [ 14.072371][ C1] hvc_console_print+0x292/0x780 [ 14.072376][ C1] ? hvc_write+0x3a0/0x3a0 [ 14.072378][ C1] ? __rwlock_init+0x150/0x150 [ 14.072381][ C1] ? lock_acquire+0x13c/0x160 [ 14.072384][ C1] console_emit_next_record+0x22f/0x4c0 [ 14.072388][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 14.072391][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072393][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072395][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072398][ C1] ? lock_acquire+0x13c/0x160 [ 14.072401][ C1] ? console_flush_one_record+0x111/0x710 [ 14.072403][ C1] console_flush_one_record+0x46f/0x710 [ 14.072407][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 14.072411][ C1] console_unlock+0xee/0x1f0 [ 14.072413][ C1] ? lock_acquire+0x13c/0x160 [ 14.072416][ C1] ? console_flush_one_record+0x710/0x710 [ 14.072418][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072420][ C1] ? lock_release+0x184/0x1f0 [ 14.072423][ C1] ? lock_acquire+0x60/0x160 [ 14.072425][ C1] ? __rcu_read_lock+0x30/0x70 [ 14.072428][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.072431][ C1] ? vprintk_emit+0x320/0x3e0 [ 14.072434][ C1] vprintk_emit+0x37c/0x3e0 [ 14.072437][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 14.072440][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 14.072442][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072445][ C1] ? lock_acquire+0x13c/0x160 [ 14.072448][ C1] _printk+0xc7/0x100 [ 14.072452][ C1] ? snapshot_read.cold+0x21/0x21 [ 14.072454][ C1] ? ___ratelimit+0x4e7/0xa00 [ 14.072458][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.072461][ C1] ? idr_get_free+0x830/0x830 [ 14.072464][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.072467][ C1] tcp_make_synack.cold+0x36/0xb6 [ 14.072472][ C1] ? tcp_send_synack+0x1570/0x1570 [ 14.072476][ C1] ? lock_release+0x184/0x1f0 [ 14.072479][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 14.072484][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 14.072487][ C1] ? lock_acquire+0x13c/0x160 [ 14.072489][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 14.072491][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.072494][ C1] ? get_random_u16+0x740/0x740 [ 14.072497][ C1] tcp_rtx_synack+0x150/0x440 [ 14.072500][ C1] ? tcp_send_probe0+0x590/0x590 [ 14.072504][ C1] ? sched_balance_rq+0x324/0x1e30 [ 14.072507][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.072510][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 14.072514][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.072516][ C1] ? lock_acquire+0x6a/0x160 [ 14.072518][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.072521][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.072523][ C1] call_timer_fn+0x160/0x4d0 [ 14.072527][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 14.072529][ C1] ? debug_object_active_state+0x430/0x430 [ 14.072536][ C1] ? __rwlock_init+0x150/0x150 [ 14.072539][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 14.072541][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072544][ C1] __run_timers+0x68f/0xaa0 [ 14.072547][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.072550][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.072554][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.072557][ C1] ? __rwlock_init+0x150/0x150 [ 14.072561][ C1] run_timer_softirq+0xf0/0x160 [ 14.072564][ C1] ? __run_timers+0xaa0/0xaa0 [ 14.072566][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.072568][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072571][ C1] handle_softirqs+0x1d3/0x900 [ 14.072575][ C1] ? _local_bh_enable+0xc0/0xc0 [ 14.072577][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072579][ C1] ? lock_release+0x184/0x1f0 [ 14.072582][ C1] __irq_exit_rcu+0x145/0x1c0 [ 14.072584][ C1] irq_exit_rcu+0xe/0x30 [ 14.072587][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.072590][ C1] [ 14.072591][ C1] [ 14.072591][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 14.072594][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.072598][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.072601][ 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.072603][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 14.072608][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 14.072610][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 14.072611][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 14.072613][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 14.072614][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.072616][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.072619][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.072622][ C1] default_idle+0x9/0x10 [ 14.072625][ C1] default_idle_call+0x6e/0xb0 [ 14.072627][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.072629][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 14.072632][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 14.072635][ C1] ? default_idle_call+0x98/0xb0 [ 14.072637][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.072640][ C1] do_idle+0xd8/0x190 [ 14.072643][ C1] cpu_startup_entry+0x53/0x70 [ 14.072645][ C1] start_secondary+0x204/0x2b0 [ 14.072647][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.072650][ C1] common_startup_64+0x13e/0x148 [ 14.072657][ C1] [ 14.099566][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.160228][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.160246][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.160249][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 15.160252][ C1] preempt_count: 102, expected: 0 [ 15.160253][ C1] RCU nest depth: 0, expected: 0 [ 15.160255][ C1] INFO: lockdep is turned off. [ 15.160257][ C1] irq event stamp: 279540 [ 15.160258][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 15.160267][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 15.160271][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 15.160275][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 15.160279][ C1] Preemption disabled at: [ 15.160280][ C1] [<0000000000000000>] 0x0 [ 15.160288][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.160293][ C1] Tainted: [W]=WARN [ 15.160294][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.160297][ C1] Call Trace: [ 15.160299][ C1] [ 15.160301][ C1] dump_stack_lvl+0x6f/0xa0 [ 15.160308][ C1] __might_resched.cold+0x1fe/0x2c1 [ 15.160313][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.160317][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160322][ C1] __kmalloc_noprof+0x443/0x760 [ 15.160327][ C1] ? __rwlock_init+0x150/0x150 [ 15.160330][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 15.160335][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.160338][ C1] alloc_buf.isra.0+0x4b/0x260 [ 15.160341][ C1] put_chars+0x1e1/0x2f0 [ 15.160344][ C1] ? __send_to_port+0x420/0x420 [ 15.160346][ C1] ? printk_get_next_message+0x240/0x650 [ 15.160350][ C1] ? console_prepend_replay+0x20/0x20 [ 15.160354][ C1] hvc_console_print+0x292/0x780 [ 15.160360][ C1] ? hvc_write+0x3a0/0x3a0 [ 15.160362][ C1] ? __rwlock_init+0x150/0x150 [ 15.160364][ C1] ? lock_acquire+0x13c/0x160 [ 15.160368][ C1] console_emit_next_record+0x22f/0x4c0 [ 15.160372][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 15.160375][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160377][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160379][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160382][ C1] ? lock_acquire+0x13c/0x160 [ 15.160385][ C1] ? console_flush_one_record+0x111/0x710 [ 15.160387][ C1] console_flush_one_record+0x46f/0x710 [ 15.160391][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 15.160395][ C1] console_unlock+0xee/0x1f0 [ 15.160398][ C1] ? lock_acquire+0x13c/0x160 [ 15.160400][ C1] ? console_flush_one_record+0x710/0x710 [ 15.160402][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160405][ C1] ? lock_release+0x184/0x1f0 [ 15.160407][ C1] ? lock_acquire+0x60/0x160 [ 15.160409][ C1] ? __rcu_read_lock+0x30/0x70 [ 15.160412][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.160415][ C1] ? vprintk_emit+0x320/0x3e0 [ 15.160418][ C1] vprintk_emit+0x37c/0x3e0 [ 15.160422][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 15.160424][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 15.160427][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160430][ C1] ? lock_acquire+0x13c/0x160 [ 15.160433][ C1] _printk+0xc7/0x100 [ 15.160436][ C1] ? snapshot_read.cold+0x21/0x21 [ 15.160439][ C1] ? ___ratelimit+0x4e7/0xa00 [ 15.160443][ C1] ? idr_get_free+0x830/0x830 [ 15.160446][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.160450][ C1] tcp_make_synack.cold+0x36/0xb6 [ 15.160455][ C1] ? tcp_send_synack+0x1570/0x1570 [ 15.160459][ C1] ? lock_release+0x184/0x1f0 [ 15.160462][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 15.160467][ C1] ? __trace_set_current_state+0x160/0x160 [ 15.160471][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 15.160473][ C1] ? lock_acquire+0x13c/0x160 [ 15.160476][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 15.160478][ C1] ? trace_hardirqs_on+0x36/0x40 [ 15.160480][ C1] ? lock_release+0x184/0x1f0 [ 15.160483][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.160485][ C1] ? get_random_u16+0x740/0x740 [ 15.160489][ C1] tcp_rtx_synack+0x150/0x440 [ 15.160491][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160494][ C1] ? tcp_send_probe0+0x590/0x590 [ 15.160498][ C1] ? lock_release+0x184/0x1f0 [ 15.160500][ C1] ? __queue_work+0x3ab/0xd30 [ 15.160504][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 15.160509][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.160511][ C1] ? lock_acquire+0x6a/0x160 [ 15.160513][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.160516][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.160518][ C1] call_timer_fn+0x160/0x4d0 [ 15.160523][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 15.160525][ C1] ? debug_object_active_state+0x430/0x430 [ 15.160531][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160535][ C1] __run_timers+0x68f/0xaa0 [ 15.160538][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.160541][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.160544][ C1] ? do_raw_spin_lock+0x131/0x280 [ 15.160548][ C1] ? __rwlock_init+0x150/0x150 [ 15.160552][ C1] run_timer_softirq+0xf0/0x160 [ 15.160555][ C1] ? __run_timers+0xaa0/0xaa0 [ 15.160557][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.160559][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160562][ C1] handle_softirqs+0x1d3/0x900 [ 15.160566][ C1] ? _local_bh_enable+0xc0/0xc0 [ 15.160568][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160571][ C1] ? lock_release+0x184/0x1f0 [ 15.160574][ C1] __irq_exit_rcu+0x145/0x1c0 [ 15.160576][ C1] irq_exit_rcu+0xe/0x30 [ 15.160578][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.160581][ C1] [ 15.160582][ C1] [ 15.160583][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 15.160586][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.160590][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.160593][ 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.160596][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 15.160600][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 15.160602][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 15.160603][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 15.160605][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 15.160606][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.160608][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.160611][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.160615][ C1] default_idle+0x9/0x10 [ 15.160617][ C1] default_idle_call+0x6e/0xb0 [ 15.160620][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.160622][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 15.160625][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 15.160628][ C1] ? default_idle_call+0x98/0xb0 [ 15.160630][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.160633][ C1] do_idle+0xd8/0x190 [ 15.160636][ C1] cpu_startup_entry+0x53/0x70 [ 15.160638][ C1] start_secondary+0x204/0x2b0 [ 15.160641][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.160644][ C1] common_startup_64+0x13e/0x148 [ 15.160650][ C1] [ 15.202328][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.248234][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.248251][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.248254][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 16.248256][ C1] preempt_count: 102, expected: 0 [ 16.248258][ C1] RCU nest depth: 0, expected: 0 [ 16.248259][ C1] INFO: lockdep is turned off. [ 16.248261][ C1] irq event stamp: 279540 [ 16.248262][ C1] hardirqs last enabled at (279539): [] default_idle_call+0x98/0xb0 [ 16.248272][ C1] hardirqs last disabled at (279540): [] __schedule+0x1246/0x20e0 [ 16.248275][ C1] softirqs last enabled at (279504): [] handle_softirqs+0x67c/0x900 [ 16.248279][ C1] softirqs last disabled at (279495): [] __irq_exit_rcu+0x145/0x1c0 [ 16.248283][ C1] Preemption disabled at: [ 16.248284][ C1] [<0000000000000000>] 0x0 [ 16.248291][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.248296][ C1] Tainted: [W]=WARN [ 16.248298][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.248300][ C1] Call Trace: [ 16.248302][ C1] [ 16.248305][ C1] dump_stack_lvl+0x6f/0xa0 [ 16.248312][ C1] __might_resched.cold+0x1fe/0x2c1 [ 16.248316][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.248321][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248326][ C1] __kmalloc_noprof+0x443/0x760 [ 16.248331][ C1] ? __rwlock_init+0x150/0x150 [ 16.248334][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 16.248339][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 16.248342][ C1] alloc_buf.isra.0+0x4b/0x260 [ 16.248345][ C1] put_chars+0x1e1/0x2f0 [ 16.248348][ C1] ? __send_to_port+0x420/0x420 [ 16.248350][ C1] ? printk_get_next_message+0x240/0x650 [ 16.248354][ C1] ? console_prepend_replay+0x20/0x20 [ 16.248358][ C1] hvc_console_print+0x292/0x780 [ 16.248364][ C1] ? hvc_write+0x3a0/0x3a0 [ 16.248366][ C1] ? __rwlock_init+0x150/0x150 [ 16.248368][ C1] ? lock_acquire+0x13c/0x160 [ 16.248371][ C1] console_emit_next_record+0x22f/0x4c0 [ 16.248375][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 16.248377][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248380][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248382][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248384][ C1] ? lock_acquire+0x13c/0x160 [ 16.248387][ C1] ? console_flush_one_record+0x111/0x710 [ 16.248389][ C1] console_flush_one_record+0x46f/0x710 [ 16.248392][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 16.248396][ C1] console_unlock+0xee/0x1f0 [ 16.248398][ C1] ? lock_acquire+0x13c/0x160 [ 16.248400][ C1] ? console_flush_one_record+0x710/0x710 [ 16.248402][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248404][ C1] ? lock_release+0x184/0x1f0 [ 16.248406][ C1] ? lock_acquire+0x60/0x160 [ 16.248408][ C1] ? __rcu_read_lock+0x30/0x70 [ 16.248411][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.248413][ C1] ? vprintk_emit+0x320/0x3e0 [ 16.248416][ C1] vprintk_emit+0x37c/0x3e0 [ 16.248419][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 16.248421][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 16.248424][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248426][ C1] ? lock_acquire+0x13c/0x160 [ 16.248429][ C1] _printk+0xc7/0x100 [ 16.248432][ C1] ? snapshot_read.cold+0x21/0x21 [ 16.248434][ C1] ? ___ratelimit+0x4e7/0xa00 [ 16.248438][ C1] ? trace_hardirqs_on+0x36/0x40 [ 16.248441][ C1] ? idr_get_free+0x830/0x830 [ 16.248444][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 16.248446][ C1] tcp_make_synack.cold+0x36/0xb6 [ 16.248451][ C1] ? tcp_send_synack+0x1570/0x1570 [ 16.248455][ C1] ? lock_release+0x184/0x1f0 [ 16.248457][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 16.248462][ C1] ? __trace_set_current_state+0x160/0x160 [ 16.248465][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 16.248467][ C1] ? lock_acquire+0x13c/0x160 [ 16.248470][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 16.248472][ C1] ? trace_hardirqs_on+0x36/0x40 [ 16.248474][ C1] ? get_random_u16+0x740/0x740 [ 16.248477][ C1] tcp_rtx_synack+0x150/0x440 [ 16.248479][ C1] ? tcp_send_probe0+0x590/0x590 [ 16.248483][ C1] ? sched_balance_rq+0x324/0x1e30 [ 16.248486][ C1] ? do_raw_spin_lock+0x131/0x280 [ 16.248489][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 16.248493][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.248495][ C1] ? lock_acquire+0x6a/0x160 [ 16.248497][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 16.248499][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.248501][ C1] call_timer_fn+0x160/0x4d0 [ 16.248505][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 16.248507][ C1] ? debug_object_active_state+0x430/0x430 [ 16.248512][ C1] ? __rwlock_init+0x150/0x150 [ 16.248515][ C1] ? timer_recalc_next_expiry+0x71/0x210 [ 16.248517][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248521][ C1] __run_timers+0x68f/0xaa0 [ 16.248523][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.248527][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 16.248530][ C1] ? do_raw_spin_lock+0x131/0x280 [ 16.248535][ C1] ? __rwlock_init+0x150/0x150 [ 16.248539][ C1] run_timer_softirq+0xf0/0x160 [ 16.248542][ C1] ? __run_timers+0xaa0/0xaa0 [ 16.248544][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.248546][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248549][ C1] handle_softirqs+0x1d3/0x900 [ 16.248552][ C1] ? _local_bh_enable+0xc0/0xc0 [ 16.248555][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248557][ C1] ? lock_release+0x184/0x1f0 [ 16.248560][ C1] __irq_exit_rcu+0x145/0x1c0 [ 16.248562][ C1] irq_exit_rcu+0xe/0x30 [ 16.248565][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 16.248567][ C1] [ 16.248568][ C1] [ 16.248569][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 16.248572][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.248576][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 16.248579][ 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 [ 16.248582][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 16.248586][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 16.248588][ C1] RDX: 0000000000000001 RSI: ffffffff9b28dc60 RDI: ffffffff988fa307 [ 16.248589][ C1] RBP: 0000000000000000 R08: ffffffff9af1e421 R09: 1fe2200006a563a2 [ 16.248591][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 16.248592][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 16.248594][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 16.248597][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.248601][ C1] default_idle+0x9/0x10 [ 16.248603][ C1] default_idle_call+0x6e/0xb0 [ 16.248605][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.248608][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 16.248610][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 16.248613][ C1] ? default_idle_call+0x98/0xb0 [ 16.248616][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.248619][ C1] do_idle+0xd8/0x190 [ 16.248621][ C1] cpu_startup_entry+0x53/0x70 [ 16.248624][ C1] start_secondary+0x204/0x2b0 [ 16.248626][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 16.248629][ C1] common_startup_64+0x13e/0x148 [ 16.248636][ C1]