[ 11.184818][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.184840][ C1] [ 11.184841][ C1] ======================================================== [ 11.184842][ C1] WARNING: possible irq lock inversion dependency detected [ 11.184844][ C1] 7.2.0-virtme #1 Tainted: G W [ 11.184845][ C1] -------------------------------------------------------- [ 11.184846][ C1] connect-deny_ip/169 just changed the state of lock: [ 11.184847][ C1] ffffffff8ca99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.184859][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.184860][ C1] (fs_reclaim){+.+.}-{0:0} [ 11.184862][ C1] [ 11.184862][ C1] [ 11.184862][ C1] and interrupts could create inverse lock ordering between them. [ 11.184862][ C1] [ 11.184862][ C1] [ 11.184862][ C1] other info that might help us debug this: [ 11.184863][ C1] Possible interrupt unsafe locking scenario: [ 11.184863][ C1] [ 11.184864][ C1] CPU0 CPU1 [ 11.184864][ C1] ---- ---- [ 11.184865][ C1] lock(fs_reclaim); [ 11.184866][ C1] local_irq_disable(); [ 11.184866][ C1] lock(console_owner); [ 11.184867][ C1] lock(fs_reclaim); [ 11.184868][ C1] [ 11.184868][ C1] lock(console_owner); [ 11.184869][ C1] [ 11.184869][ C1] *** DEADLOCK *** [ 11.184869][ C1] [ 11.184870][ C1] locks held by connect-deny_ip/169: 9, last CPU#1: [ 11.184871][ C1] #0: ff11000012f32b10 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 11.184876][ C1] #1: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 11.184880][ C1] #2: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 11.184883][ C1] #3: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 11.184886][ C1] #4: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 11.184891][ C1] #5: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 11.184894][ C1] #6: ffffffff8cb90b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 11.184898][ C1] #7: ffffffff8cb79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.184905][ C1] #8: ffffffff8cb79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.184908][ C1] [ 11.184908][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 11.184913][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 11.184915][ C1] HARDIRQ-ON-W at: [ 11.184916][ C1] __lock_acquire+0x388/0xc20 [ 11.184919][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.184921][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.184924][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.184926][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.184929][ C1] workqueue_init+0x2a/0x680 [ 11.184932][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.184935][ C1] kernel_init+0x21/0x150 [ 11.184938][ C1] ret_from_fork+0x474/0x6b0 [ 11.184941][ C1] ret_from_fork_asm+0x11/0x20 [ 11.184944][ C1] SOFTIRQ-ON-W at: [ 11.184944][ C1] __lock_acquire+0x388/0xc20 [ 11.184946][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.184947][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.184948][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.184949][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.184951][ C1] workqueue_init+0x2a/0x680 [ 11.184952][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.184953][ C1] kernel_init+0x21/0x150 [ 11.184954][ C1] ret_from_fork+0x474/0x6b0 [ 11.184956][ C1] ret_from_fork_asm+0x11/0x20 [ 11.184957][ C1] INITIAL USE at: [ 11.184957][ C1] __lock_acquire+0x388/0xc20 [ 11.184959][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.184960][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.184961][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.184962][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.184964][ C1] workqueue_init+0x2a/0x680 [ 11.184965][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.184966][ C1] kernel_init+0x21/0x150 [ 11.184968][ C1] ret_from_fork+0x474/0x6b0 [ 11.184969][ C1] ret_from_fork_asm+0x11/0x20 [ 11.184970][ C1] } [ 11.184970][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.184973][ C1] ... acquired at: [ 11.184974][ C1] __lock_acquire+0x518/0xc20 [ 11.184976][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.184977][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.184978][ C1] __kmalloc_noprof+0xd3/0x760 [ 11.184979][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.184982][ C1] put_chars+0x1e1/0x2f0 [ 11.184984][ C1] hvc_console_print+0x292/0x780 [ 11.184986][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.184988][ C1] console_flush_one_record+0x46f/0x710 [ 11.184989][ C1] console_unlock+0xee/0x1f0 [ 11.184991][ C1] vprintk_emit+0x37c/0x3e0 [ 11.184992][ C1] dev_vprintk_emit+0x27f/0x2c0 [ 11.184996][ C1] dev_printk_emit+0xb9/0xee [ 11.184997][ C1] _dev_info+0xe2/0x116 [ 11.184999][ C1] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 11.185001][ C1] cmos_do_probe+0x73b/0x98a [ 11.185003][ C1] platform_probe+0xfe/0x1f0 [ 11.185005][ C1] call_driver_probe+0x61/0x1c0 [ 11.185007][ C1] really_probe+0x199/0x760 [ 11.185009][ C1] __driver_probe_device+0x24f/0x440 [ 11.185010][ C1] driver_probe_device+0x4a/0xf0 [ 11.185012][ C1] __driver_attach+0x1b8/0x540 [ 11.185013][ C1] bus_for_each_dev+0x130/0x1e0 [ 11.185015][ C1] bus_add_driver+0x2c8/0x530 [ 11.185016][ C1] driver_register+0x1a3/0x390 [ 11.185018][ C1] __platform_driver_probe+0x13f/0x270 [ 11.185019][ C1] cmos_init+0x31/0x40 [ 11.185021][ C1] do_one_initcall+0x124/0x4f0 [ 11.185023][ C1] kernel_init_freeable+0x596/0x630 [ 11.185025][ C1] kernel_init+0x21/0x150 [ 11.185026][ C1] ret_from_fork+0x474/0x6b0 [ 11.185027][ C1] ret_from_fork_asm+0x11/0x20 [ 11.185028][ C1] [ 11.185029][ C1] -> (console_owner){..-.}-{0:0} { [ 11.185030][ C1] IN-SOFTIRQ-W at: [ 11.185031][ C1] __lock_acquire+0x388/0xc20 [ 11.185033][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.185034][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.185035][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.185037][ C1] console_flush_one_record+0x46f/0x710 [ 11.185039][ C1] console_unlock+0xee/0x1f0 [ 11.185040][ C1] vprintk_emit+0x37c/0x3e0 [ 11.185042][ C1] _printk+0xc7/0x100 [ 11.185044][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.185047][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.185049][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.185051][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185052][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.185054][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.185055][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.185057][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.185058][ C1] ip_local_deliver+0x184/0x4c0 [ 11.185059][ C1] ip_rcv+0xdc/0x3d0 [ 11.185060][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.185062][ C1] process_backlog+0x431/0x14c0 [ 11.185064][ C1] __napi_poll+0xa7/0x3b0 [ 11.185066][ C1] net_rx_action+0x513/0xf50 [ 11.185067][ C1] handle_softirqs+0x1d3/0x900 [ 11.185070][ C1] do_softirq+0xac/0xe0 [ 11.185071][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.185072][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.185074][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.185075][ C1] ip_output+0x1ca/0x660 [ 11.185077][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.185078][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.185079][ C1] tcp_connect+0x1024/0x1e20 [ 11.185081][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.185082][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.185083][ C1] inet_stream_connect+0x59/0xb0 [ 11.185084][ C1] __sys_connect+0x1cf/0x2e0 [ 11.185087][ C1] __x64_sys_connect+0x72/0xd0 [ 11.185089][ C1] do_syscall_64+0xff/0x530 [ 11.185091][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.185093][ C1] INITIAL USE at: [ 11.185094][ C1] } [ 11.185094][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.185098][ C1] ... acquired at: [ 11.185098][ C1] mark_lock+0x1d7/0xa00 [ 11.185100][ C1] mark_usage+0x42/0x170 [ 11.185101][ C1] __lock_acquire+0x388/0xc20 [ 11.185102][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.185104][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.185105][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.185107][ C1] console_flush_one_record+0x46f/0x710 [ 11.185108][ C1] console_unlock+0xee/0x1f0 [ 11.185110][ C1] vprintk_emit+0x37c/0x3e0 [ 11.185111][ C1] _printk+0xc7/0x100 [ 11.185113][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.185114][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.185115][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.185121][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185123][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.185124][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.185126][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.185127][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.185128][ C1] ip_local_deliver+0x184/0x4c0 [ 11.185130][ C1] ip_rcv+0xdc/0x3d0 [ 11.185131][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.185133][ C1] process_backlog+0x431/0x14c0 [ 11.185134][ C1] __napi_poll+0xa7/0x3b0 [ 11.185136][ C1] net_rx_action+0x513/0xf50 [ 11.185138][ C1] handle_softirqs+0x1d3/0x900 [ 11.185139][ C1] do_softirq+0xac/0xe0 [ 11.185140][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.185141][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.185143][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.185144][ C1] ip_output+0x1ca/0x660 [ 11.185145][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.185147][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.185148][ C1] tcp_connect+0x1024/0x1e20 [ 11.185149][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.185150][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.185151][ C1] inet_stream_connect+0x59/0xb0 [ 11.185152][ C1] __sys_connect+0x1cf/0x2e0 [ 11.185154][ C1] __x64_sys_connect+0x72/0xd0 [ 11.185155][ C1] do_syscall_64+0xff/0x530 [ 11.185156][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.185157][ C1] [ 11.185158][ C1] [ 11.185158][ C1] stack backtrace: [ 11.185161][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.185164][ C1] Tainted: [W]=WARN [ 11.185165][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.185167][ C1] Call Trace: [ 11.185168][ C1] [ 11.185169][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.185173][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.185175][ C1] mark_lock_irq+0x989/0x9c0 [ 11.185178][ C1] mark_lock+0x1d7/0xa00 [ 11.185179][ C1] mark_usage+0x42/0x170 [ 11.185181][ C1] __lock_acquire+0x388/0xc20 [ 11.185183][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.185185][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 11.185187][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185190][ C1] ? lock_acquire+0x13c/0x160 [ 11.185192][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.185194][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 11.185195][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.185197][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.185199][ C1] ? console_flush_one_record+0x106/0x710 [ 11.185201][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185202][ C1] ? lock_acquire+0x13c/0x160 [ 11.185204][ C1] console_flush_one_record+0x46f/0x710 [ 11.185207][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.185208][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185210][ C1] console_unlock+0xee/0x1f0 [ 11.185212][ C1] ? console_flush_one_record+0x710/0x710 [ 11.185214][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185215][ C1] ? lock_acquire+0x60/0x160 [ 11.185217][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.185219][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.185221][ C1] vprintk_emit+0x37c/0x3e0 [ 11.185223][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.185225][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185227][ C1] _printk+0xc7/0x100 [ 11.185228][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.185230][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.185233][ C1] ? idr_get_free+0x830/0x830 [ 11.185235][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.185237][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.185239][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 11.185240][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.185243][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.185245][ C1] ? add_timer_on+0x580/0x580 [ 11.185248][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.185250][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.185252][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 11.185255][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 11.185258][ C1] ? inet_csk_route_req+0x747/0xc30 [ 11.185260][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 11.185261][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.185263][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 11.185267][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 11.185269][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185271][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185273][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185274][ C1] ? down_read_nested+0xe7/0x500 [ 11.185276][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185279][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185280][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185282][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.185284][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 11.185286][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.185288][ C1] ? mark_usage+0x61/0x170 [ 11.185290][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 11.185292][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185294][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 11.185295][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.185297][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185299][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.185301][ C1] ip_local_deliver+0x184/0x4c0 [ 11.185303][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 11.185304][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 11.185307][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185308][ C1] ip_rcv+0xdc/0x3d0 [ 11.185310][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 11.185312][ C1] ? mark_usage+0x61/0x170 [ 11.185313][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185315][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.185317][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185318][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185320][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 11.185322][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185325][ C1] process_backlog+0x431/0x14c0 [ 11.185327][ C1] __napi_poll+0xa7/0x3b0 [ 11.185329][ C1] net_rx_action+0x513/0xf50 [ 11.185332][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185333][ C1] ? __napi_poll+0x3b0/0x3b0 [ 11.185337][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 11.185339][ C1] ? mark_held_locks+0x40/0x70 [ 11.185341][ C1] handle_softirqs+0x1d3/0x900 [ 11.185343][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.185344][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.185346][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185347][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 11.185349][ C1] do_softirq+0xac/0xe0 [ 11.185351][ C1] [ 11.185351][ C1] [ 11.185352][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.185353][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.185355][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.185359][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 11.185361][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185362][ C1] ? find_held_lock+0x2b/0x80 [ 11.185364][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185365][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185367][ C1] ? mark_held_locks+0x40/0x70 [ 11.185368][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.185369][ C1] ? neigh_hh_output+0x152/0x4c0 [ 11.185372][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.185374][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 11.185375][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185377][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 11.185379][ C1] ip_output+0x1ca/0x660 [ 11.185381][ C1] ? ip_finish_output+0x460/0x460 [ 11.185383][ C1] ? find_held_lock+0x2b/0x80 [ 11.185384][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185386][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 11.185388][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.185390][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.185393][ C1] ? __tcp_select_window+0xf20/0xf20 [ 11.185395][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185396][ C1] ? ktime_get+0x18e/0x2d0 [ 11.185397][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 11.185401][ C1] ? ktime_get+0x1dd/0x2d0 [ 11.185402][ C1] tcp_connect+0x1024/0x1e20 [ 11.185404][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.185407][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 11.185409][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.185410][ C1] ? find_held_lock+0x2b/0x80 [ 11.185412][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.185413][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185415][ C1] inet_stream_connect+0x59/0xb0 [ 11.185416][ C1] __sys_connect+0x1cf/0x2e0 [ 11.185418][ C1] ? do_fcntl+0x36f/0xc50 [ 11.185421][ C1] ? __sys_connect_file+0x250/0x250 [ 11.185424][ C1] ? fput+0x1f/0xa0 [ 11.185426][ C1] __x64_sys_connect+0x72/0xd0 [ 11.185428][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185429][ C1] ? do_syscall_64+0xa6/0x530 [ 11.185430][ C1] do_syscall_64+0xff/0x530 [ 11.185432][ C1] ? irq_exit_rcu+0x1a/0x30 [ 11.185433][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.185435][ C1] RIP: 0033:0x7fe845648312 [ 11.185438][ 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 [ 11.185440][ C1] RSP: 002b:00007fe844dc5988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 11.185443][ C1] RAX: ffffffffffffffda RBX: 000000000000000b RCX: 00007fe845648312 [ 11.185444][ C1] RDX: 0000000000000010 RSI: 00007fe844dc5c40 RDI: 000000000000000b [ 11.185445][ C1] RBP: 00007fe844dc59b0 R08: 0000000000000000 R09: 0000000000000000 [ 11.185446][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe844dc5c40 [ 11.185446][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 11.185449][ C1] [ 11.185453][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.185454][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 11.185455][ C1] preempt_count: 302, expected: 0 [ 11.185456][ C1] RCU nest depth: 6, expected: 0 [ 11.185457][ C1] INFO: lockdep is turned off. [ 11.185457][ C1] irq event stamp: 17693 [ 11.185458][ C1] hardirqs last enabled at (17692): [] __down_trylock_console_sem+0x86/0xa0 [ 11.185460][ C1] hardirqs last disabled at (17693): [] console_emit_next_record+0x3d4/0x4c0 [ 11.185462][ C1] softirqs last enabled at (17524): [] __dev_queue_xmit+0x964/0x1b80 [ 11.185464][ C1] softirqs last disabled at (17525): [] do_softirq+0xac/0xe0 [ 11.185465][ C1] Preemption disabled at: [ 11.185466][ C1] [] __dev_queue_xmit+0x204/0x1b80 [ 11.185469][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.185471][ C1] Tainted: [W]=WARN [ 11.185471][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.185472][ C1] Call Trace: [ 11.185473][ C1] [ 11.185473][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.185476][ C1] ? __dev_queue_xmit+0x204/0x1b80 [ 11.185478][ C1] __might_resched.cold+0x1fe/0x2c1 [ 11.185480][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.185483][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185485][ C1] __kmalloc_noprof+0x443/0x760 [ 11.185487][ C1] ? __rwlock_init+0x150/0x150 [ 11.185488][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 11.185490][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.185492][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.185494][ C1] put_chars+0x1e1/0x2f0 [ 11.185496][ C1] ? __send_to_port+0x420/0x420 [ 11.185498][ C1] hvc_console_print+0x292/0x780 [ 11.185500][ C1] ? __lock_acquire+0x388/0xc20 [ 11.185502][ C1] ? hvc_write+0x3a0/0x3a0 [ 11.185504][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185506][ C1] ? lock_acquire+0x13c/0x160 [ 11.185508][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.185510][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.185511][ C1] ? console_flush_one_record+0x106/0x710 [ 11.185513][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185515][ C1] ? lock_acquire+0x13c/0x160 [ 11.185517][ C1] console_flush_one_record+0x46f/0x710 [ 11.185519][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.185521][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185523][ C1] console_unlock+0xee/0x1f0 [ 11.185525][ C1] ? console_flush_one_record+0x710/0x710 [ 11.185526][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185528][ C1] ? lock_acquire+0x60/0x160 [ 11.185530][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.185531][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.185533][ C1] vprintk_emit+0x37c/0x3e0 [ 11.185535][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.185537][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185539][ C1] _printk+0xc7/0x100 [ 11.185541][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.185542][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.185544][ C1] ? idr_get_free+0x830/0x830 [ 11.185546][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.185548][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.185550][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 11.185551][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.185553][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.185555][ C1] ? add_timer_on+0x580/0x580 [ 11.185557][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.185559][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.185561][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 11.185564][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 11.185565][ C1] ? inet_csk_route_req+0x747/0xc30 [ 11.185567][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 11.185568][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.185570][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 11.185573][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 11.185575][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185577][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185578][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185580][ C1] ? down_read_nested+0xe7/0x500 [ 11.185582][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185584][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185586][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.185588][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.185589][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 11.185591][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.185594][ C1] ? mark_usage+0x61/0x170 [ 11.185595][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 11.185597][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185599][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 11.185600][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.185602][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185604][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.185606][ C1] ip_local_deliver+0x184/0x4c0 [ 11.185607][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 11.185609][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 11.185611][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185613][ C1] ip_rcv+0xdc/0x3d0 [ 11.185615][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 11.185616][ C1] ? mark_usage+0x61/0x170 [ 11.185618][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185620][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.185622][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185623][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.185625][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 11.185627][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185632][ C1] process_backlog+0x431/0x14c0 [ 11.185635][ C1] __napi_poll+0xa7/0x3b0 [ 11.185637][ C1] net_rx_action+0x513/0xf50 [ 11.185640][ C1] ? __lock_acquire+0x518/0xc20 [ 11.185641][ C1] ? __napi_poll+0x3b0/0x3b0 [ 11.185645][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 11.185646][ C1] ? mark_held_locks+0x40/0x70 [ 11.185648][ C1] handle_softirqs+0x1d3/0x900 [ 11.185650][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.185651][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.185653][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185655][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 11.185657][ C1] do_softirq+0xac/0xe0 [ 11.185658][ C1] [ 11.185658][ C1] [ 11.185659][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.185660][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.185662][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.185664][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 11.185666][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185668][ C1] ? find_held_lock+0x2b/0x80 [ 11.185669][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185670][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.185672][ C1] ? mark_held_locks+0x40/0x70 [ 11.185674][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.185675][ C1] ? neigh_hh_output+0x152/0x4c0 [ 11.185677][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.185679][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 11.185680][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.185682][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 11.185684][ C1] ip_output+0x1ca/0x660 [ 11.185686][ C1] ? ip_finish_output+0x460/0x460 [ 11.185688][ C1] ? find_held_lock+0x2b/0x80 [ 11.185689][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.185691][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 11.185693][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.185695][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.185698][ C1] ? __tcp_select_window+0xf20/0xf20 [ 11.185700][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185701][ C1] ? ktime_get+0x18e/0x2d0 [ 11.185702][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 11.185704][ C1] ? ktime_get+0x1dd/0x2d0 [ 11.185706][ C1] tcp_connect+0x1024/0x1e20 [ 11.185708][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.185710][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 11.185712][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.185714][ C1] ? find_held_lock+0x2b/0x80 [ 11.185715][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.185717][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185718][ C1] inet_stream_connect+0x59/0xb0 [ 11.185720][ C1] __sys_connect+0x1cf/0x2e0 [ 11.185721][ C1] ? do_fcntl+0x36f/0xc50 [ 11.185723][ C1] ? __sys_connect_file+0x250/0x250 [ 11.185726][ C1] ? fput+0x1f/0xa0 [ 11.185727][ C1] __x64_sys_connect+0x72/0xd0 [ 11.185729][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.185730][ C1] ? do_syscall_64+0xa6/0x530 [ 11.185732][ C1] do_syscall_64+0xff/0x530 [ 11.185733][ C1] ? irq_exit_rcu+0x1a/0x30 [ 11.185735][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.185736][ C1] RIP: 0033:0x7fe845648312 [ 11.185737][ 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 [ 11.185738][ C1] RSP: 002b:00007fe844dc5988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 11.185740][ C1] RAX: ffffffffffffffda RBX: 000000000000000b RCX: 00007fe845648312 [ 11.185740][ C1] RDX: 0000000000000010 RSI: 00007fe844dc5c40 RDI: 000000000000000b [ 11.185741][ C1] RBP: 00007fe844dc59b0 R08: 0000000000000000 R09: 0000000000000000 [ 11.185742][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe844dc5c40 [ 11.185743][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 11.185745][ C1] [ 12.189742][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.189758][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.189761][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 86, name: (udev-worker) [ 12.189762][ C1] preempt_count: 102, expected: 0 [ 12.189763][ C1] RCU nest depth: 0, expected: 0 [ 12.189764][ C1] INFO: lockdep is turned off. [ 12.189765][ C1] irq event stamp: 390792 [ 12.189766][ C1] hardirqs last enabled at (390791): [] _raw_spin_unlock_irq+0x28/0x50 [ 12.189775][ C1] hardirqs last disabled at (390792): [] __schedule+0x1246/0x20e0 [ 12.189777][ C1] softirqs last enabled at (390726): [] unix_release_sock+0x446/0xe50 [ 12.189780][ C1] softirqs last disabled at (390724): [] unix_release_sock+0x39f/0xe50 [ 12.189782][ C1] Preemption disabled at: [ 12.189783][ C1] [<0000000000000000>] 0x0 [ 12.189789][ C1] CPU: 1 UID: 0 PID: 86 Comm: (udev-worker) Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.189793][ C1] Tainted: [W]=WARN [ 12.189794][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.189796][ C1] Call Trace: [ 12.189797][ C1] [ 12.189799][ C1] dump_stack_lvl+0x6f/0xa0 [ 12.189804][ C1] __might_resched.cold+0x1fe/0x2c1 [ 12.189808][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.189812][ C1] ? __kernel_text_address+0x12/0x30 [ 12.189815][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189819][ C1] __kmalloc_noprof+0x443/0x760 [ 12.189822][ C1] ? __rwlock_init+0x150/0x150 [ 12.189824][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 12.189828][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.189830][ C1] alloc_buf.isra.0+0x4b/0x260 [ 12.189832][ C1] put_chars+0x1e1/0x2f0 [ 12.189834][ C1] ? __send_to_port+0x420/0x420 [ 12.189836][ C1] ? printk_get_next_message+0x240/0x650 [ 12.189839][ C1] hvc_console_print+0x292/0x780 [ 12.189843][ C1] ? hvc_write+0x3a0/0x3a0 [ 12.189845][ C1] ? __rwlock_init+0x150/0x150 [ 12.189846][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189848][ C1] ? lock_acquire+0x13c/0x160 [ 12.189851][ C1] console_emit_next_record+0x22f/0x4c0 [ 12.189853][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 12.189855][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189856][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189858][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189860][ C1] ? lock_acquire+0x13c/0x160 [ 12.189862][ C1] ? console_flush_one_record+0x111/0x710 [ 12.189863][ C1] console_flush_one_record+0x46f/0x710 [ 12.189866][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 12.189868][ C1] console_unlock+0xee/0x1f0 [ 12.189870][ C1] ? lock_acquire+0x13c/0x160 [ 12.189871][ C1] ? console_flush_one_record+0x710/0x710 [ 12.189873][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189875][ C1] ? lock_release+0x184/0x1f0 [ 12.189876][ C1] ? lock_acquire+0x60/0x160 [ 12.189878][ C1] ? __rcu_read_lock+0x30/0x70 [ 12.189880][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.189881][ C1] ? vprintk_emit+0x320/0x3e0 [ 12.189883][ C1] vprintk_emit+0x37c/0x3e0 [ 12.189886][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 12.189887][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 12.189889][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189891][ C1] ? lock_acquire+0x13c/0x160 [ 12.189893][ C1] _printk+0xc7/0x100 [ 12.189896][ C1] ? snapshot_read.cold+0x21/0x21 [ 12.189897][ C1] ? ___ratelimit+0x4e7/0xa00 [ 12.189900][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.189902][ C1] ? idr_get_free+0x830/0x830 [ 12.189904][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.189906][ C1] tcp_make_synack.cold+0x36/0xb6 [ 12.189910][ C1] ? tcp_send_synack+0x1570/0x1570 [ 12.189913][ C1] ? lock_release+0x184/0x1f0 [ 12.189914][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189916][ C1] ? inet_csk_route_req+0x747/0xc30 [ 12.189919][ C1] ? lockdep_unregister_key+0x2b/0x320 [ 12.189921][ C1] tcp_v4_send_synack+0x103/0xb20 [ 12.189923][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.189925][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.189926][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.189928][ C1] ? get_random_u16+0x740/0x740 [ 12.189929][ C1] ? stack_trace_save+0x93/0xc0 [ 12.189932][ C1] ? filter_irq_stacks+0xd0/0xd0 [ 12.189933][ C1] tcp_rtx_synack+0x150/0x440 [ 12.189935][ C1] ? tcp_send_probe0+0x590/0x590 [ 12.189936][ C1] ? kasan_save_stack+0x2f/0x50 [ 12.189940][ C1] ? unwind_next_frame+0x11a7/0x1ea0 [ 12.189942][ C1] ? arch_stack_walk+0xd7/0x130 [ 12.189945][ C1] ? stack_trace_save+0x93/0xc0 [ 12.189946][ C1] ? kasan_save_stack+0x2f/0x50 [ 12.189948][ C1] ? kasan_save_track+0x14/0x30 [ 12.189949][ C1] ? kasan_save_free_info+0x3b/0x60 [ 12.189951][ C1] ? __kasan_slab_free+0x43/0x70 [ 12.189953][ C1] ? kmem_cache_free+0xf8/0x550 [ 12.189954][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 12.189956][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.189958][ C1] ? lock_acquire+0x6a/0x160 [ 12.189959][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.189961][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.189962][ C1] call_timer_fn+0x160/0x4d0 [ 12.189965][ C1] ? update_curr.isra.0+0x266/0x480 [ 12.189967][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 12.189969][ C1] ? debug_object_active_state+0x430/0x430 [ 12.189973][ C1] ? __rwlock_init+0x150/0x150 [ 12.189974][ C1] ? put_objects.isra.0+0x2b0/0x2b0 [ 12.189976][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.189977][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189980][ C1] __run_timers+0x68f/0xaa0 [ 12.189981][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.189983][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.189985][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.189988][ C1] ? __rwlock_init+0x150/0x150 [ 12.189990][ C1] run_timer_softirq+0xf0/0x160 [ 12.189992][ C1] ? __run_timers+0xaa0/0xaa0 [ 12.189994][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.189995][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.189996][ C1] handle_softirqs+0x1d3/0x900 [ 12.190000][ C1] ? _local_bh_enable+0xc0/0xc0 [ 12.190001][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.190003][ C1] ? lock_release+0x184/0x1f0 [ 12.190004][ C1] __irq_exit_rcu+0x145/0x1c0 [ 12.190006][ C1] irq_exit_rcu+0xe/0x30 [ 12.190007][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.190009][ C1] [ 12.190010][ C1] [ 12.190011][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.190013][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 [ 12.190015][ C1] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 c1 5f a1 fd 48 89 df e8 c9 b5 a1 fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 70 7f 93 fd 65 48 83 3d af 2b 03 02 00 74 12 5b [ 12.190017][ C1] RSP: 0018:ffa0000000587998 EFLAGS: 00000246 [ 12.190020][ C1] RAX: 0000000000000046 RBX: ff110000010327c0 RCX: 0000000000000000 [ 12.190022][ C1] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff8bd47483 [ 12.190023][ C1] RBP: 0000000000000246 R08: ffffffff899e0ac0 R09: 1ffffffff1a9d73b [ 12.190024][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: ff110000010327c0 [ 12.190025][ C1] R13: ffd40000003fa990 R14: ffd40000003fa980 R15: ff1100000fea61a0 [ 12.190026][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.190028][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 12.190030][ C1] get_from_partial_node+0x21d/0x500 [ 12.190031][ C1] ? _raw_spin_unlock_irqrestore+0x40/0x80 [ 12.190033][ C1] ? __debug_check_no_obj_freed+0x266/0x5a0 [ 12.190035][ C1] ___slab_alloc+0x71/0x2f0 [ 12.190037][ C1] ? lock_acquire+0x13c/0x160 [ 12.190038][ C1] ? __pcs_replace_empty_main+0x42f/0x6a0 [ 12.190040][ C1] __kmalloc_cache_noprof+0x32e/0x620 [ 12.190042][ C1] ? kmem_cache_free+0x365/0x550 [ 12.190044][ C1] ? tear_down_vmas+0x175/0x520 [ 12.190047][ C1] kmem_cache_free+0x365/0x550 [ 12.190048][ C1] ? fput+0x1f/0xa0 [ 12.190051][ C1] tear_down_vmas+0x175/0x520 [ 12.190053][ C1] exit_mmap+0x486/0x960 [ 12.190055][ C1] ? vm_brk_flags+0x4d0/0x4d0 [ 12.190056][ C1] ? lock_acquire+0x13c/0x160 [ 12.190058][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.190060][ C1] ? attach_task_ctx_data+0x460/0x460 [ 12.190063][ C1] ? __mutex_lock+0x1db/0x1ea0 [ 12.190065][ C1] ? uprobe_clear_state+0x49/0x1e0 [ 12.190068][ C1] ? lock_release+0x184/0x1f0 [ 12.190072][ C1] mmput+0xa9/0x450 [ 12.190074][ C1] exit_mm+0x134/0x200 [ 12.190076][ C1] do_exit+0x548/0xdc0 [ 12.190077][ C1] ? vfs_read+0x3dd/0x7b0 [ 12.190080][ C1] ? exit_notify+0x890/0x890 [ 12.190081][ C1] ? posixtimer_sig_unignore.isra.0+0x5f0/0x5f0 [ 12.190083][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.190086][ C1] do_group_exit+0xb8/0x370 [ 12.190087][ C1] __x64_sys_exit_group+0x3c/0x50 [ 12.190089][ C1] x64_sys_call+0x1567/0x1570 [ 12.190091][ C1] do_syscall_64+0xff/0x530 [ 12.190093][ C1] ? irq_exit_rcu+0x1a/0x30 [ 12.190095][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 12.190096][ C1] RIP: 0033:0x7fa911ffe1b8 [ 12.190098][ C1] Code: Unable to access opcode bytes at 0x7fa911ffe18e. [ 12.190098][ C1] RSP: 002b:00007ffddb320348 EFLAGS: 00000256 ORIG_RAX: 00000000000000e7 [ 12.190100][ C1] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007fa911ffe1b8 [ 12.190101][ C1] RDX: 0000000000000000 RSI: fffffffffffffe90 RDI: 0000000000000000 [ 12.190102][ C1] RBP: 00007ffddb3204d0 R08: 000055db8e7b24b8 R09: 0000000000000000 [ 12.190102][ C1] R10: 0000000000000000 R11: 0000000000000256 R12: 0000000000000000 [ 12.190103][ C1] R13: 00007fa91185c050 R14: 00007fa91252fd9e R15: 000055db8e5f8e30 [ 12.190105][ C1] [ 12.318940][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.341749][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.341766][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.341769][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 13.341771][ C3] preempt_count: 102, expected: 0 [ 13.341773][ C3] RCU nest depth: 0, expected: 0 [ 13.341774][ C3] INFO: lockdep is turned off. [ 13.341776][ C3] irq event stamp: 312993 [ 13.341777][ C3] hardirqs last enabled at (312993): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.341787][ C3] hardirqs last disabled at (312992): [] do_idle+0xd1/0x190 [ 13.341790][ C3] softirqs last enabled at (312988): [] handle_softirqs+0x67c/0x900 [ 13.341794][ C3] softirqs last disabled at (312981): [] __irq_exit_rcu+0x145/0x1c0 [ 13.341797][ C3] Preemption disabled at: [ 13.341798][ C3] [<0000000000000000>] 0x0 [ 13.341807][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.341811][ C3] Tainted: [W]=WARN [ 13.341813][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.341815][ C3] Call Trace: [ 13.341817][ C3] [ 13.341820][ C3] dump_stack_lvl+0x6f/0xa0 [ 13.341826][ C3] __might_resched.cold+0x1fe/0x2c1 [ 13.341831][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.341835][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341840][ C3] __kmalloc_noprof+0x443/0x760 [ 13.341845][ C3] ? __rwlock_init+0x150/0x150 [ 13.341848][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 13.341854][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 13.341856][ C3] alloc_buf.isra.0+0x4b/0x260 [ 13.341860][ C3] put_chars+0x1e1/0x2f0 [ 13.341863][ C3] ? __send_to_port+0x420/0x420 [ 13.341865][ C3] ? printk_get_next_message+0x240/0x650 [ 13.341870][ C3] hvc_console_print+0x292/0x780 [ 13.341875][ C3] ? hvc_write+0x3a0/0x3a0 [ 13.341878][ C3] ? __rwlock_init+0x150/0x150 [ 13.341880][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341883][ C3] ? lock_acquire+0x13c/0x160 [ 13.341886][ C3] console_emit_next_record+0x22f/0x4c0 [ 13.341890][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 13.341893][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341896][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341898][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341900][ C3] ? lock_acquire+0x13c/0x160 [ 13.341903][ C3] ? console_flush_one_record+0x111/0x710 [ 13.341906][ C3] console_flush_one_record+0x46f/0x710 [ 13.341909][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 13.341913][ C3] console_unlock+0xee/0x1f0 [ 13.341916][ C3] ? lock_acquire+0x13c/0x160 [ 13.341918][ C3] ? console_flush_one_record+0x710/0x710 [ 13.341921][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341923][ C3] ? lock_release+0x184/0x1f0 [ 13.341925][ C3] ? lock_acquire+0x60/0x160 [ 13.341927][ C3] ? __rcu_read_lock+0x30/0x70 [ 13.341931][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.341933][ C3] ? vprintk_emit+0x320/0x3e0 [ 13.341936][ C3] vprintk_emit+0x37c/0x3e0 [ 13.341940][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 13.341942][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 13.341945][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341947][ C3] ? lock_acquire+0x13c/0x160 [ 13.341950][ C3] _printk+0xc7/0x100 [ 13.341954][ C3] ? snapshot_read.cold+0x21/0x21 [ 13.341956][ C3] ? ___ratelimit+0x4e7/0xa00 [ 13.341961][ C3] ? trace_hardirqs_on+0x36/0x40 [ 13.341964][ C3] ? idr_get_free+0x830/0x830 [ 13.341967][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.341970][ C3] tcp_make_synack.cold+0x36/0xb6 [ 13.341975][ C3] ? tcp_send_synack+0x1570/0x1570 [ 13.341980][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.341983][ C3] ? inet_csk_route_req+0x747/0xc30 [ 13.341988][ C3] tcp_v4_send_synack+0x103/0xb20 [ 13.341991][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.341993][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 13.341997][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.342000][ C3] ? trace_hardirqs_on+0x36/0x40 [ 13.342002][ C3] ? get_random_u16+0x740/0x740 [ 13.342006][ C3] tcp_rtx_synack+0x150/0x440 [ 13.342008][ C3] ? tcp_send_probe0+0x590/0x590 [ 13.342012][ C3] ? sched_balance_rq+0x324/0x1e30 [ 13.342015][ C3] ? do_raw_spin_lock+0x131/0x280 [ 13.342018][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 13.342021][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.342024][ C3] ? lock_acquire+0x6a/0x160 [ 13.342026][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 13.342029][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.342031][ C3] call_timer_fn+0x160/0x4d0 [ 13.342035][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 13.342038][ C3] ? debug_object_active_state+0x430/0x430 [ 13.342043][ C3] ? __rwlock_init+0x150/0x150 [ 13.342045][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.342048][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.342051][ C3] __run_timers+0x68f/0xaa0 [ 13.342054][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.342057][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.342061][ C3] ? do_raw_spin_lock+0x131/0x280 [ 13.342065][ C3] ? __rwlock_init+0x150/0x150 [ 13.342068][ C3] run_timer_softirq+0xf0/0x160 [ 13.342071][ C3] ? __run_timers+0xaa0/0xaa0 [ 13.342074][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.342076][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.342079][ C3] handle_softirqs+0x1d3/0x900 [ 13.342082][ C3] ? _local_bh_enable+0xc0/0xc0 [ 13.342085][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.342087][ C3] ? lock_release+0x184/0x1f0 [ 13.342090][ C3] __irq_exit_rcu+0x145/0x1c0 [ 13.342092][ C3] irq_exit_rcu+0xe/0x30 [ 13.342095][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.342098][ C3] [ 13.342099][ C3] [ 13.342100][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 13.342103][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.342106][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.342110][ 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.342112][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 13.342116][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 13.342118][ C3] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff896fa307 [ 13.342120][ C3] RBP: 0000000000000000 R08: ffffffff8bd1f421 R09: 1fe2200006a763a2 [ 13.342121][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 13.342128][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.342130][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.342134][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.342137][ C3] default_idle+0x9/0x10 [ 13.342139][ C3] default_idle_call+0x6e/0xb0 [ 13.342141][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.342144][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 13.342146][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 13.342150][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.342152][ C3] ? rcu_is_watching+0x16/0xd0 [ 13.342155][ C3] do_idle+0xd8/0x190 [ 13.342157][ C3] cpu_startup_entry+0x53/0x70 [ 13.342160][ C3] start_secondary+0x204/0x2b0 [ 13.342162][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.342165][ C3] common_startup_64+0x13e/0x148 [ 13.342172][ C3] [ 13.369216][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.430746][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.430764][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.430766][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 14.430768][ C3] preempt_count: 102, expected: 0 [ 14.430769][ C3] RCU nest depth: 0, expected: 0 [ 14.430770][ C3] INFO: lockdep is turned off. [ 14.430771][ C3] irq event stamp: 312993 [ 14.430772][ C3] hardirqs last enabled at (312993): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.430781][ C3] hardirqs last disabled at (312992): [] do_idle+0xd1/0x190 [ 14.430782][ C3] softirqs last enabled at (312988): [] handle_softirqs+0x67c/0x900 [ 14.430786][ C3] softirqs last disabled at (312981): [] __irq_exit_rcu+0x145/0x1c0 [ 14.430788][ C3] Preemption disabled at: [ 14.430789][ C3] [<0000000000000000>] 0x0 [ 14.430796][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.430800][ C3] Tainted: [W]=WARN [ 14.430801][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.430803][ C3] Call Trace: [ 14.430804][ C3] [ 14.430807][ C3] dump_stack_lvl+0x6f/0xa0 [ 14.430813][ C3] __might_resched.cold+0x1fe/0x2c1 [ 14.430817][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.430821][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430824][ C3] __kmalloc_noprof+0x443/0x760 [ 14.430828][ C3] ? __rwlock_init+0x150/0x150 [ 14.430831][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 14.430835][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 14.430837][ C3] alloc_buf.isra.0+0x4b/0x260 [ 14.430839][ C3] put_chars+0x1e1/0x2f0 [ 14.430841][ C3] ? __send_to_port+0x420/0x420 [ 14.430843][ C3] ? printk_get_next_message+0x240/0x650 [ 14.430846][ C3] hvc_console_print+0x292/0x780 [ 14.430850][ C3] ? hvc_write+0x3a0/0x3a0 [ 14.430852][ C3] ? __rwlock_init+0x150/0x150 [ 14.430853][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430855][ C3] ? lock_acquire+0x13c/0x160 [ 14.430858][ C3] console_emit_next_record+0x22f/0x4c0 [ 14.430861][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 14.430863][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430864][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430866][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430868][ C3] ? lock_acquire+0x13c/0x160 [ 14.430869][ C3] ? console_flush_one_record+0x111/0x710 [ 14.430871][ C3] console_flush_one_record+0x46f/0x710 [ 14.430874][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 14.430876][ C3] console_unlock+0xee/0x1f0 [ 14.430878][ C3] ? lock_acquire+0x13c/0x160 [ 14.430880][ C3] ? console_flush_one_record+0x710/0x710 [ 14.430881][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430883][ C3] ? lock_release+0x184/0x1f0 [ 14.430884][ C3] ? lock_acquire+0x60/0x160 [ 14.430886][ C3] ? __rcu_read_lock+0x30/0x70 [ 14.430888][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.430890][ C3] ? vprintk_emit+0x320/0x3e0 [ 14.430892][ C3] vprintk_emit+0x37c/0x3e0 [ 14.430894][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 14.430896][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 14.430897][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430899][ C3] ? lock_acquire+0x13c/0x160 [ 14.430901][ C3] _printk+0xc7/0x100 [ 14.430904][ C3] ? snapshot_read.cold+0x21/0x21 [ 14.430906][ C3] ? ___ratelimit+0x4e7/0xa00 [ 14.430910][ C3] ? trace_hardirqs_on+0x36/0x40 [ 14.430912][ C3] ? idr_get_free+0x830/0x830 [ 14.430914][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.430916][ C3] tcp_make_synack.cold+0x36/0xb6 [ 14.430920][ C3] ? tcp_send_synack+0x1570/0x1570 [ 14.430923][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430926][ C3] ? inet_csk_route_req+0x747/0xc30 [ 14.430929][ C3] tcp_v4_send_synack+0x103/0xb20 [ 14.430931][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 14.430933][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.430934][ C3] ? trace_hardirqs_on+0x36/0x40 [ 14.430936][ C3] ? get_random_u16+0x740/0x740 [ 14.430938][ C3] tcp_rtx_synack+0x150/0x440 [ 14.430940][ C3] ? trace_pelt_cfs_tp+0x9b/0x190 [ 14.430942][ C3] ? tcp_send_probe0+0x590/0x590 [ 14.430943][ C3] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 14.430946][ C3] ? update_cfs_rq_load_avg+0x4b/0x660 [ 14.430948][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 14.430950][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.430952][ C3] ? lock_acquire+0x6a/0x160 [ 14.430953][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 14.430955][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.430956][ C3] call_timer_fn+0x160/0x4d0 [ 14.430959][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 14.430961][ C3] ? debug_object_active_state+0x430/0x430 [ 14.430965][ C3] ? trace_sched_wakeup+0x9b/0x160 [ 14.430967][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 14.430969][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430971][ C3] __run_timers+0x68f/0xaa0 [ 14.430973][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.430975][ C3] ? debug_object_deactivate+0x2f7/0x440 [ 14.430977][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.430979][ C3] ? do_raw_spin_lock+0x131/0x280 [ 14.430981][ C3] ? __rwlock_init+0x150/0x150 [ 14.430984][ C3] run_timer_softirq+0xf0/0x160 [ 14.430986][ C3] ? __run_timers+0xaa0/0xaa0 [ 14.430987][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.430988][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430990][ C3] handle_softirqs+0x1d3/0x900 [ 14.430993][ C3] ? _local_bh_enable+0xc0/0xc0 [ 14.430994][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.430996][ C3] ? lock_release+0x184/0x1f0 [ 14.430998][ C3] __irq_exit_rcu+0x145/0x1c0 [ 14.430999][ C3] irq_exit_rcu+0xe/0x30 [ 14.431001][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.431003][ C3] [ 14.431003][ C3] [ 14.431004][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 14.431006][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.431009][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.431011][ 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 [ 14.431013][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 14.431017][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 14.431018][ C3] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff896fa307 [ 14.431019][ C3] RBP: 0000000000000000 R08: ffffffff8bd1f421 R09: 1fe2200006a763a2 [ 14.431020][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 14.431020][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.431022][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.431024][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.431026][ C3] default_idle+0x9/0x10 [ 14.431027][ C3] default_idle_call+0x6e/0xb0 [ 14.431028][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.431030][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 14.431032][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 14.431034][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.431035][ C3] ? rcu_is_watching+0x16/0xd0 [ 14.431037][ C3] do_idle+0xd8/0x190 [ 14.431039][ C3] cpu_startup_entry+0x53/0x70 [ 14.431040][ C3] start_secondary+0x204/0x2b0 [ 14.431042][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.431044][ C3] common_startup_64+0x13e/0x148 [ 14.431048][ C3] [ 14.457887][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.518737][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.518752][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.518754][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 15.518756][ C3] preempt_count: 102, expected: 0 [ 15.518757][ C3] RCU nest depth: 0, expected: 0 [ 15.518758][ C3] INFO: lockdep is turned off. [ 15.518759][ C3] irq event stamp: 312993 [ 15.518760][ C3] hardirqs last enabled at (312993): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.518768][ C3] hardirqs last disabled at (312992): [] do_idle+0xd1/0x190 [ 15.518770][ C3] softirqs last enabled at (312988): [] handle_softirqs+0x67c/0x900 [ 15.518773][ C3] softirqs last disabled at (312981): [] __irq_exit_rcu+0x145/0x1c0 [ 15.518775][ C3] Preemption disabled at: [ 15.518776][ C3] [<0000000000000000>] 0x0 [ 15.518783][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.518787][ C3] Tainted: [W]=WARN [ 15.518788][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.518790][ C3] Call Trace: [ 15.518791][ C3] [ 15.518794][ C3] dump_stack_lvl+0x6f/0xa0 [ 15.518800][ C3] __might_resched.cold+0x1fe/0x2c1 [ 15.518804][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.518807][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518811][ C3] __kmalloc_noprof+0x443/0x760 [ 15.518815][ C3] ? __rwlock_init+0x150/0x150 [ 15.518818][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 15.518822][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 15.518824][ C3] alloc_buf.isra.0+0x4b/0x260 [ 15.518826][ C3] put_chars+0x1e1/0x2f0 [ 15.518828][ C3] ? __send_to_port+0x420/0x420 [ 15.518830][ C3] ? printk_get_next_message+0x240/0x650 [ 15.518834][ C3] hvc_console_print+0x292/0x780 [ 15.518838][ C3] ? hvc_write+0x3a0/0x3a0 [ 15.518840][ C3] ? __rwlock_init+0x150/0x150 [ 15.518841][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518843][ C3] ? lock_acquire+0x13c/0x160 [ 15.518846][ C3] console_emit_next_record+0x22f/0x4c0 [ 15.518848][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 15.518850][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518852][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518853][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518855][ C3] ? lock_acquire+0x13c/0x160 [ 15.518857][ C3] ? console_flush_one_record+0x111/0x710 [ 15.518859][ C3] console_flush_one_record+0x46f/0x710 [ 15.518861][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 15.518864][ C3] console_unlock+0xee/0x1f0 [ 15.518866][ C3] ? lock_acquire+0x13c/0x160 [ 15.518868][ C3] ? console_flush_one_record+0x710/0x710 [ 15.518869][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518871][ C3] ? lock_release+0x184/0x1f0 [ 15.518872][ C3] ? lock_acquire+0x60/0x160 [ 15.518874][ C3] ? __rcu_read_lock+0x30/0x70 [ 15.518876][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.518878][ C3] ? vprintk_emit+0x320/0x3e0 [ 15.518880][ C3] vprintk_emit+0x37c/0x3e0 [ 15.518882][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 15.518884][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 15.518886][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518888][ C3] ? lock_acquire+0x13c/0x160 [ 15.518890][ C3] _printk+0xc7/0x100 [ 15.518893][ C3] ? snapshot_read.cold+0x21/0x21 [ 15.518894][ C3] ? ___ratelimit+0x4e7/0xa00 [ 15.518898][ C3] ? trace_hardirqs_on+0x36/0x40 [ 15.518901][ C3] ? idr_get_free+0x830/0x830 [ 15.518903][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.518904][ C3] tcp_make_synack.cold+0x36/0xb6 [ 15.518908][ C3] ? tcp_send_synack+0x1570/0x1570 [ 15.518912][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518914][ C3] ? inet_csk_route_req+0x747/0xc30 [ 15.518917][ C3] tcp_v4_send_synack+0x103/0xb20 [ 15.518920][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.518921][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 15.518924][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.518925][ C3] ? trace_hardirqs_on+0x36/0x40 [ 15.518927][ C3] ? get_random_u16+0x740/0x740 [ 15.518929][ C3] tcp_rtx_synack+0x150/0x440 [ 15.518931][ C3] ? tcp_send_probe0+0x590/0x590 [ 15.518933][ C3] ? sched_balance_rq+0x324/0x1e30 [ 15.518936][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 15.518938][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.518939][ C3] ? lock_acquire+0x6a/0x160 [ 15.518940][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 15.518942][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.518944][ C3] call_timer_fn+0x160/0x4d0 [ 15.518947][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 15.518949][ C3] ? debug_object_active_state+0x430/0x430 [ 15.518953][ C3] ? __rwlock_init+0x150/0x150 [ 15.518954][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 15.518956][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518958][ C3] __run_timers+0x68f/0xaa0 [ 15.518960][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.518962][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.518965][ C3] ? do_raw_spin_lock+0x131/0x280 [ 15.518967][ C3] ? __rwlock_init+0x150/0x150 [ 15.518969][ C3] run_timer_softirq+0xf0/0x160 [ 15.518971][ C3] ? __run_timers+0xaa0/0xaa0 [ 15.518973][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.518974][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518976][ C3] handle_softirqs+0x1d3/0x900 [ 15.518978][ C3] ? _local_bh_enable+0xc0/0xc0 [ 15.518980][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.518982][ C3] ? lock_release+0x184/0x1f0 [ 15.518984][ C3] __irq_exit_rcu+0x145/0x1c0 [ 15.518985][ C3] irq_exit_rcu+0xe/0x30 [ 15.518987][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.518989][ C3] [ 15.518990][ C3] [ 15.518990][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 15.518993][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.518995][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.518998][ 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.519000][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 15.519003][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 15.519005][ C3] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff896fa307 [ 15.519006][ C3] RBP: 0000000000000000 R08: ffffffff8bd1f421 R09: 1fe2200006a763a2 [ 15.519006][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 15.519007][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.519008][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.519011][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.519013][ C3] default_idle+0x9/0x10 [ 15.519014][ C3] default_idle_call+0x6e/0xb0 [ 15.519016][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.519018][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 15.519019][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 15.519022][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.519023][ C3] ? rcu_is_watching+0x16/0xd0 [ 15.519025][ C3] do_idle+0xd8/0x190 [ 15.519027][ C3] cpu_startup_entry+0x53/0x70 [ 15.519028][ C3] start_secondary+0x204/0x2b0 [ 15.519030][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.519032][ C3] common_startup_64+0x13e/0x148 [ 15.519037][ C3] [ 15.537166][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.541730][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.541745][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.541747][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 16.541748][ C3] preempt_count: 102, expected: 0 [ 16.541749][ C3] RCU nest depth: 0, expected: 0 [ 16.541750][ C3] INFO: lockdep is turned off. [ 16.541751][ C3] irq event stamp: 312993 [ 16.541752][ C3] hardirqs last enabled at (312993): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.541760][ C3] hardirqs last disabled at (312992): [] do_idle+0xd1/0x190 [ 16.541762][ C3] softirqs last enabled at (312988): [] handle_softirqs+0x67c/0x900 [ 16.541764][ C3] softirqs last disabled at (312981): [] __irq_exit_rcu+0x145/0x1c0 [ 16.541766][ C3] Preemption disabled at: [ 16.541767][ C3] [<0000000000000000>] 0x0 [ 16.541774][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.541777][ C3] Tainted: [W]=WARN [ 16.541778][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.541780][ C3] Call Trace: [ 16.541782][ C3] [ 16.541784][ C3] dump_stack_lvl+0x6f/0xa0 [ 16.541789][ C3] __might_resched.cold+0x1fe/0x2c1 [ 16.541793][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.541797][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541800][ C3] __kmalloc_noprof+0x443/0x760 [ 16.541804][ C3] ? __rwlock_init+0x150/0x150 [ 16.541807][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 16.541811][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 16.541812][ C3] alloc_buf.isra.0+0x4b/0x260 [ 16.541815][ C3] put_chars+0x1e1/0x2f0 [ 16.541817][ C3] ? __send_to_port+0x420/0x420 [ 16.541818][ C3] ? printk_get_next_message+0x240/0x650 [ 16.541822][ C3] hvc_console_print+0x292/0x780 [ 16.541826][ C3] ? hvc_write+0x3a0/0x3a0 [ 16.541827][ C3] ? __rwlock_init+0x150/0x150 [ 16.541829][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541831][ C3] ? lock_acquire+0x13c/0x160 [ 16.541833][ C3] console_emit_next_record+0x22f/0x4c0 [ 16.541836][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 16.541838][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541839][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541841][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541842][ C3] ? lock_acquire+0x13c/0x160 [ 16.541844][ C3] ? console_flush_one_record+0x111/0x710 [ 16.541846][ C3] console_flush_one_record+0x46f/0x710 [ 16.541848][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 16.541851][ C3] console_unlock+0xee/0x1f0 [ 16.541852][ C3] ? lock_acquire+0x13c/0x160 [ 16.541854][ C3] ? console_flush_one_record+0x710/0x710 [ 16.541856][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541857][ C3] ? lock_release+0x184/0x1f0 [ 16.541859][ C3] ? lock_acquire+0x60/0x160 [ 16.541860][ C3] ? __rcu_read_lock+0x30/0x70 [ 16.541862][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.541864][ C3] ? vprintk_emit+0x320/0x3e0 [ 16.541866][ C3] vprintk_emit+0x37c/0x3e0 [ 16.541868][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 16.541870][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 16.541871][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541873][ C3] ? lock_acquire+0x13c/0x160 [ 16.541875][ C3] _printk+0xc7/0x100 [ 16.541878][ C3] ? snapshot_read.cold+0x21/0x21 [ 16.541879][ C3] ? ___ratelimit+0x4e7/0xa00 [ 16.541883][ C3] ? idr_get_free+0x830/0x830 [ 16.541885][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 16.541888][ C3] tcp_make_synack.cold+0x36/0xb6 [ 16.541892][ C3] ? tcp_send_synack+0x1570/0x1570 [ 16.541895][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541897][ C3] ? inet_csk_route_req+0x747/0xc30 [ 16.541900][ C3] tcp_v4_send_synack+0x103/0xb20 [ 16.541902][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 16.541904][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 16.541906][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.541908][ C3] ? trace_hardirqs_on+0x36/0x40 [ 16.541909][ C3] ? get_random_u16+0x740/0x740 [ 16.541911][ C3] tcp_rtx_synack+0x150/0x440 [ 16.541913][ C3] ? trace_pelt_cfs_tp+0x9b/0x190 [ 16.541915][ C3] ? tcp_send_probe0+0x590/0x590 [ 16.541916][ C3] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 16.541919][ C3] ? update_cfs_rq_load_avg+0x4b/0x660 [ 16.541921][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 16.541923][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.541924][ C3] ? lock_acquire+0x6a/0x160 [ 16.541926][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 16.541928][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.541929][ C3] call_timer_fn+0x160/0x4d0 [ 16.541932][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 16.541934][ C3] ? debug_object_active_state+0x430/0x430 [ 16.541938][ C3] ? trace_sched_wakeup+0x9b/0x160 [ 16.541940][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 16.541942][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541944][ C3] __run_timers+0x68f/0xaa0 [ 16.541946][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.541947][ C3] ? debug_object_deactivate+0x2f7/0x440 [ 16.541949][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 16.541952][ C3] ? do_raw_spin_lock+0x131/0x280 [ 16.541954][ C3] ? __rwlock_init+0x150/0x150 [ 16.541956][ C3] run_timer_softirq+0xf0/0x160 [ 16.541958][ C3] ? __run_timers+0xaa0/0xaa0 [ 16.541960][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.541961][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541963][ C3] handle_softirqs+0x1d3/0x900 [ 16.541965][ C3] ? _local_bh_enable+0xc0/0xc0 [ 16.541966][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.541968][ C3] ? lock_release+0x184/0x1f0 [ 16.541970][ C3] __irq_exit_rcu+0x145/0x1c0 [ 16.541971][ C3] irq_exit_rcu+0xe/0x30 [ 16.541973][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 16.541975][ C3] [ 16.541975][ C3] [ 16.541976][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 16.541978][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.541981][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 16.541983][ 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 [ 16.541985][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 16.541988][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 16.541989][ C3] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff896fa307 [ 16.541990][ C3] RBP: 0000000000000000 R08: ffffffff8bd1f421 R09: 1fe2200006a763a2 [ 16.541991][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 16.541992][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 16.541993][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 16.541995][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.541997][ C3] default_idle+0x9/0x10 [ 16.541998][ C3] default_idle_call+0x6e/0xb0 [ 16.542000][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.542001][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 16.542003][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 16.542005][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.542006][ C3] ? rcu_is_watching+0x16/0xd0 [ 16.542008][ C3] do_idle+0xd8/0x190 [ 16.542010][ C3] cpu_startup_entry+0x53/0x70 [ 16.542011][ C3] start_secondary+0x204/0x2b0 [ 16.542013][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 16.542015][ C3] common_startup_64+0x13e/0x148 [ 16.542019][ C3] [ 16.564769][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.565717][ C3] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.565734][ C3] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.565736][ C3] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/3 [ 17.565738][ C3] preempt_count: 102, expected: 0 [ 17.565739][ C3] RCU nest depth: 0, expected: 0 [ 17.565740][ C3] INFO: lockdep is turned off. [ 17.565741][ C3] irq event stamp: 312993 [ 17.565742][ C3] hardirqs last enabled at (312993): [] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.565751][ C3] hardirqs last disabled at (312992): [] do_idle+0xd1/0x190 [ 17.565753][ C3] softirqs last enabled at (312988): [] handle_softirqs+0x67c/0x900 [ 17.565755][ C3] softirqs last disabled at (312981): [] __irq_exit_rcu+0x145/0x1c0 [ 17.565757][ C3] Preemption disabled at: [ 17.565758][ C3] [<0000000000000000>] 0x0 [ 17.565766][ C3] CPU: 3 UID: 0 PID: 0 Comm: swapper/3 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.565769][ C3] Tainted: [W]=WARN [ 17.565771][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.565773][ C3] Call Trace: [ 17.565774][ C3] [ 17.565776][ C3] dump_stack_lvl+0x6f/0xa0 [ 17.565782][ C3] __might_resched.cold+0x1fe/0x2c1 [ 17.565786][ C3] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.565789][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565793][ C3] __kmalloc_noprof+0x443/0x760 [ 17.565797][ C3] ? __rwlock_init+0x150/0x150 [ 17.565800][ C3] ? alloc_buf.isra.0+0x4b/0x260 [ 17.565804][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 17.565805][ C3] alloc_buf.isra.0+0x4b/0x260 [ 17.565808][ C3] put_chars+0x1e1/0x2f0 [ 17.565810][ C3] ? __send_to_port+0x420/0x420 [ 17.565812][ C3] ? printk_get_next_message+0x240/0x650 [ 17.565815][ C3] hvc_console_print+0x292/0x780 [ 17.565819][ C3] ? hvc_write+0x3a0/0x3a0 [ 17.565820][ C3] ? __rwlock_init+0x150/0x150 [ 17.565822][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565824][ C3] ? lock_acquire+0x13c/0x160 [ 17.565826][ C3] console_emit_next_record+0x22f/0x4c0 [ 17.565829][ C3] ? devkmsg_read+0x4b0/0x4b0 [ 17.565831][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565832][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565834][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565836][ C3] ? lock_acquire+0x13c/0x160 [ 17.565838][ C3] ? console_flush_one_record+0x111/0x710 [ 17.565839][ C3] console_flush_one_record+0x46f/0x710 [ 17.565842][ C3] ? console_emit_next_record+0x4c0/0x4c0 [ 17.565844][ C3] console_unlock+0xee/0x1f0 [ 17.565846][ C3] ? lock_acquire+0x13c/0x160 [ 17.565847][ C3] ? console_flush_one_record+0x710/0x710 [ 17.565849][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565851][ C3] ? lock_release+0x184/0x1f0 [ 17.565852][ C3] ? lock_acquire+0x60/0x160 [ 17.565854][ C3] ? __rcu_read_lock+0x30/0x70 [ 17.565856][ C3] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.565858][ C3] ? vprintk_emit+0x320/0x3e0 [ 17.565860][ C3] vprintk_emit+0x37c/0x3e0 [ 17.565862][ C3] ? wake_up_klogd_work_func+0x90/0x90 [ 17.565864][ C3] ? do_raw_spin_trylock+0xb6/0x180 [ 17.565865][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565867][ C3] ? lock_acquire+0x13c/0x160 [ 17.565869][ C3] _printk+0xc7/0x100 [ 17.565872][ C3] ? snapshot_read.cold+0x21/0x21 [ 17.565873][ C3] ? ___ratelimit+0x4e7/0xa00 [ 17.565877][ C3] ? trace_hardirqs_on+0x36/0x40 [ 17.565880][ C3] ? idr_get_free+0x830/0x830 [ 17.565881][ C3] ? trace_irq_enable.constprop.0+0x30/0x160 [ 17.565883][ C3] tcp_make_synack.cold+0x36/0xb6 [ 17.565887][ C3] ? tcp_send_synack+0x1570/0x1570 [ 17.565890][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565892][ C3] ? inet_csk_route_req+0x747/0xc30 [ 17.565895][ C3] tcp_v4_send_synack+0x103/0xb20 [ 17.565897][ C3] ? tcp_v4_timewait_ack+0x870/0x870 [ 17.565899][ C3] ? sched_balance_find_src_group+0xda/0x760 [ 17.565902][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.565903][ C3] ? trace_hardirqs_on+0x36/0x40 [ 17.565905][ C3] ? get_random_u16+0x740/0x740 [ 17.565907][ C3] tcp_rtx_synack+0x150/0x440 [ 17.565909][ C3] ? trace_pelt_cfs_tp+0x9b/0x190 [ 17.565911][ C3] ? tcp_send_probe0+0x590/0x590 [ 17.565912][ C3] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 17.565914][ C3] ? update_cfs_rq_load_avg+0x4b/0x660 [ 17.565917][ C3] reqsk_timer_handler+0x8d1/0xe30 [ 17.565919][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.565920][ C3] ? lock_acquire+0x6a/0x160 [ 17.565922][ C3] ? do_raw_spin_unlock+0x59/0x250 [ 17.565923][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.565925][ C3] call_timer_fn+0x160/0x4d0 [ 17.565928][ C3] ? detach_if_pending+0x1d0/0x1d0 [ 17.565929][ C3] ? debug_object_active_state+0x430/0x430 [ 17.565934][ C3] ? trace_sched_wakeup+0x9b/0x160 [ 17.565936][ C3] ? timer_recalc_next_expiry+0xf0/0x210 [ 17.565937][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565940][ C3] __run_timers+0x68f/0xaa0 [ 17.565941][ C3] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.565943][ C3] ? debug_object_deactivate+0x2f7/0x440 [ 17.565945][ C3] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.565948][ C3] ? do_raw_spin_lock+0x131/0x280 [ 17.565950][ C3] ? __rwlock_init+0x150/0x150 [ 17.565952][ C3] run_timer_softirq+0xf0/0x160 [ 17.565954][ C3] ? __run_timers+0xaa0/0xaa0 [ 17.565956][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.565957][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565959][ C3] handle_softirqs+0x1d3/0x900 [ 17.565961][ C3] ? _local_bh_enable+0xc0/0xc0 [ 17.565962][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.565964][ C3] ? lock_release+0x184/0x1f0 [ 17.565966][ C3] __irq_exit_rcu+0x145/0x1c0 [ 17.565967][ C3] irq_exit_rcu+0xe/0x30 [ 17.565969][ C3] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.565971][ C3] [ 17.565971][ C3] [ 17.565972][ C3] ? _raw_spin_unlock+0x2d/0x50 [ 17.565974][ C3] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.565977][ C3] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 17.565979][ 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 [ 17.565981][ C3] RSP: 0018:ffa0000000167e00 EFLAGS: 00000246 [ 17.565984][ C3] RAX: 0000000000000003 RBX: ff11000001c98040 RCX: 0000000000000001 [ 17.565986][ C3] RDX: 0000000000000003 RSI: ffffffff8c08dc60 RDI: ffffffff896fa307 [ 17.565987][ C3] RBP: 0000000000000000 R08: ffffffff8bd1f421 R09: 1fe2200006a763a2 [ 17.565988][ C3] R10: 0000000000000003 R11: 0000000000000000 R12: 1ff400000002cfc3 [ 17.565988][ C3] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 17.565990][ C3] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 17.565992][ C3] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.565994][ C3] default_idle+0x9/0x10 [ 17.565995][ C3] default_idle_call+0x6e/0xb0 [ 17.565997][ C3] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.565998][ C3] ? arch_cpu_idle_exit+0x40/0x40 [ 17.566000][ C3] ? mark_tsc_async_resets+0x30/0x30 [ 17.566002][ C3] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.566004][ C3] ? rcu_is_watching+0x16/0xd0 [ 17.566006][ C3] do_idle+0xd8/0x190 [ 17.566007][ C3] cpu_startup_entry+0x53/0x70 [ 17.566009][ C3] start_secondary+0x204/0x2b0 [ 17.566010][ C3] ? set_cpu_sibling_map+0x2130/0x2130 [ 17.566012][ C3] common_startup_64+0x13e/0x148 [ 17.566017][ C3]