[ 11.207779][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.207815][ C1] [ 11.207816][ C1] ======================================================== [ 11.207818][ C1] WARNING: possible irq lock inversion dependency detected [ 11.207820][ C1] 7.2.0-virtme #1 Tainted: G W [ 11.207822][ C1] -------------------------------------------------------- [ 11.207823][ C1] connect-deny_ip/168 just changed the state of lock: [ 11.207825][ C1] ffffffff8c099660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 11.207840][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 11.207842][ C1] (fs_reclaim){+.+.}-{0:0} [ 11.207844][ C1] [ 11.207844][ C1] [ 11.207844][ C1] and interrupts could create inverse lock ordering between them. [ 11.207844][ C1] [ 11.207845][ C1] [ 11.207845][ C1] other info that might help us debug this: [ 11.207846][ C1] Possible interrupt unsafe locking scenario: [ 11.207846][ C1] [ 11.207847][ C1] CPU0 CPU1 [ 11.207848][ C1] ---- ---- [ 11.207849][ C1] lock(fs_reclaim); [ 11.207851][ C1] local_irq_disable(); [ 11.207852][ C1] lock(console_owner); [ 11.207853][ C1] lock(fs_reclaim); [ 11.207860][ C1] [ 11.207860][ C1] lock(console_owner); [ 11.207862][ C1] [ 11.207862][ C1] *** DEADLOCK *** [ 11.207862][ C1] [ 11.207862][ C1] locks held by connect-deny_ip/168: 9, last CPU#1: [ 11.207864][ C1] #0: ff11000016ac1d90 (sk_lock-AF_INET){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 11.207872][ C1] #1: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: __ip_queue_xmit+0x63/0x1650 [ 11.207878][ C1] #2: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: ip_output+0xa9/0x660 [ 11.207883][ C1] #3: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: ip_finish_output2+0x25c/0x1bc0 [ 11.207888][ C1] #4: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 11.207895][ C1] #5: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: ip_local_deliver_finish+0x2ba/0x610 [ 11.207900][ C1] #6: ffffffff8c190b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 11.207910][ C1] #7: ffffffff8c179cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 11.207915][ C1] #8: ffffffff8c179d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 11.207921][ C1] [ 11.207921][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 11.207927][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 11.207931][ C1] HARDIRQ-ON-W at: [ 11.207933][ C1] __lock_acquire+0x388/0xc20 [ 11.207937][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.207939][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.207942][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.207945][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.207949][ C1] workqueue_init+0x2a/0x680 [ 11.207953][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.207956][ C1] kernel_init+0x21/0x150 [ 11.207960][ C1] ret_from_fork+0x474/0x6b0 [ 11.207964][ C1] ret_from_fork_asm+0x11/0x20 [ 11.207967][ C1] SOFTIRQ-ON-W at: [ 11.207968][ C1] __lock_acquire+0x388/0xc20 [ 11.207970][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.207972][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.207974][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.207976][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.207978][ C1] workqueue_init+0x2a/0x680 [ 11.207980][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.207983][ C1] kernel_init+0x21/0x150 [ 11.207985][ C1] ret_from_fork+0x474/0x6b0 [ 11.207986][ C1] ret_from_fork_asm+0x11/0x20 [ 11.207988][ C1] INITIAL USE at: [ 11.207989][ C1] __lock_acquire+0x388/0xc20 [ 11.207991][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.207993][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.207995][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 11.207997][ C1] kthread_create_worker_on_node+0xea/0x210 [ 11.207999][ C1] workqueue_init+0x2a/0x680 [ 11.208001][ C1] kernel_init_freeable+0x2fe/0x630 [ 11.208003][ C1] kernel_init+0x21/0x150 [ 11.208005][ C1] ret_from_fork+0x474/0x6b0 [ 11.208007][ C1] ret_from_fork_asm+0x11/0x20 [ 11.208009][ C1] } [ 11.208009][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 11.208014][ C1] ... acquired at: [ 11.208016][ C1] __lock_acquire+0x518/0xc20 [ 11.208018][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.208020][ C1] fs_reclaim_acquire+0xd5/0x120 [ 11.208021][ C1] __kmalloc_noprof+0xd3/0x760 [ 11.208023][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.208027][ C1] put_chars+0x1e1/0x2f0 [ 11.208029][ C1] hvc_console_print+0x292/0x780 [ 11.208032][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.208035][ C1] console_flush_one_record+0x46f/0x710 [ 11.208037][ C1] console_unlock+0xee/0x1f0 [ 11.208039][ C1] vprintk_emit+0x37c/0x3e0 [ 11.208041][ C1] dev_vprintk_emit+0x27f/0x2c0 [ 11.208045][ C1] dev_printk_emit+0xb9/0xee [ 11.208047][ C1] _dev_info+0xe2/0x116 [ 11.208050][ C1] __devm_rtc_register_device.cold+0xc3/0x3a8 [ 11.208053][ C1] cmos_do_probe+0x73b/0x98a [ 11.208055][ C1] platform_probe+0xfe/0x1f0 [ 11.208058][ C1] call_driver_probe+0x61/0x1c0 [ 11.208061][ C1] really_probe+0x199/0x760 [ 11.208063][ C1] __driver_probe_device+0x24f/0x440 [ 11.208066][ C1] driver_probe_device+0x4a/0xf0 [ 11.208068][ C1] __driver_attach+0x1b8/0x540 [ 11.208070][ C1] bus_for_each_dev+0x130/0x1e0 [ 11.208072][ C1] bus_add_driver+0x2c8/0x530 [ 11.208074][ C1] driver_register+0x1a3/0x390 [ 11.208077][ C1] __platform_driver_probe+0x13f/0x270 [ 11.208079][ C1] cmos_init+0x31/0x40 [ 11.208082][ C1] do_one_initcall+0x124/0x4f0 [ 11.208084][ C1] kernel_init_freeable+0x596/0x630 [ 11.208087][ C1] kernel_init+0x21/0x150 [ 11.208089][ C1] ret_from_fork+0x474/0x6b0 [ 11.208090][ C1] ret_from_fork_asm+0x11/0x20 [ 11.208092][ C1] [ 11.208093][ C1] -> (console_owner){..-.}-{0:0} { [ 11.208096][ C1] IN-SOFTIRQ-W at: [ 11.208098][ C1] __lock_acquire+0x388/0xc20 [ 11.208100][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.208102][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.208104][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.208106][ C1] console_flush_one_record+0x46f/0x710 [ 11.208109][ C1] console_unlock+0xee/0x1f0 [ 11.208111][ C1] vprintk_emit+0x37c/0x3e0 [ 11.208113][ C1] _printk+0xc7/0x100 [ 11.208117][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.208120][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.208123][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.208125][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208128][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.208130][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.208132][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.208135][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.208137][ C1] ip_local_deliver+0x184/0x4c0 [ 11.208139][ C1] ip_rcv+0xdc/0x3d0 [ 11.208141][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.208143][ C1] process_backlog+0x431/0x14c0 [ 11.208146][ C1] __napi_poll+0xa7/0x3b0 [ 11.208148][ C1] net_rx_action+0x513/0xf50 [ 11.208151][ C1] handle_softirqs+0x1d3/0x900 [ 11.208154][ C1] do_softirq+0xac/0xe0 [ 11.208156][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.208158][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.208161][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.208163][ C1] ip_output+0x1ca/0x660 [ 11.208165][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.208167][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.208169][ C1] tcp_connect+0x1024/0x1e20 [ 11.208171][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.208173][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.208175][ C1] inet_stream_connect+0x59/0xb0 [ 11.208177][ C1] __sys_connect+0x1cf/0x2e0 [ 11.208180][ C1] __x64_sys_connect+0x72/0xd0 [ 11.208183][ C1] do_syscall_64+0xff/0x530 [ 11.208186][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.208189][ C1] INITIAL USE at: [ 11.208190][ C1] } [ 11.208191][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 11.208195][ C1] ... acquired at: [ 11.208196][ C1] mark_lock+0x1d7/0xa00 [ 11.208198][ C1] mark_usage+0x42/0x170 [ 11.208200][ C1] __lock_acquire+0x388/0xc20 [ 11.208202][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.208204][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.208206][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.208209][ C1] console_flush_one_record+0x46f/0x710 [ 11.208211][ C1] console_unlock+0xee/0x1f0 [ 11.208213][ C1] vprintk_emit+0x37c/0x3e0 [ 11.208215][ C1] _printk+0xc7/0x100 [ 11.208217][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.208219][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.208222][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.208224][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208226][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.208229][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.208231][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.208233][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.208235][ C1] ip_local_deliver+0x184/0x4c0 [ 11.208237][ C1] ip_rcv+0xdc/0x3d0 [ 11.208238][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.208241][ C1] process_backlog+0x431/0x14c0 [ 11.208243][ C1] __napi_poll+0xa7/0x3b0 [ 11.208246][ C1] net_rx_action+0x513/0xf50 [ 11.208248][ C1] handle_softirqs+0x1d3/0x900 [ 11.208250][ C1] do_softirq+0xac/0xe0 [ 11.208252][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.208254][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.208256][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.208258][ C1] ip_output+0x1ca/0x660 [ 11.208260][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.208262][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.208264][ C1] tcp_connect+0x1024/0x1e20 [ 11.208266][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.208268][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.208269][ C1] inet_stream_connect+0x59/0xb0 [ 11.208271][ C1] __sys_connect+0x1cf/0x2e0 [ 11.208273][ C1] __x64_sys_connect+0x72/0xd0 [ 11.208275][ C1] do_syscall_64+0xff/0x530 [ 11.208277][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.208279][ C1] [ 11.208280][ C1] [ 11.208280][ C1] stack backtrace: [ 11.208285][ C1] CPU: 1 UID: 0 PID: 168 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.208289][ C1] Tainted: [W]=WARN [ 11.208290][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.208293][ C1] Call Trace: [ 11.208295][ C1] [ 11.208296][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.208302][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 11.208305][ C1] mark_lock_irq+0x989/0x9c0 [ 11.208310][ C1] mark_lock+0x1d7/0xa00 [ 11.208313][ C1] mark_usage+0x42/0x170 [ 11.208315][ C1] __lock_acquire+0x388/0xc20 [ 11.208318][ C1] lock_acquire.part.0+0xd4/0x280 [ 11.208321][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 11.208324][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208328][ C1] ? lock_acquire+0x13c/0x160 [ 11.208331][ C1] console_lock_spinning_enable+0x5c/0x60 [ 11.208334][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 11.208337][ C1] console_emit_next_record+0x1d1/0x4c0 [ 11.208340][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.208342][ C1] ? console_flush_one_record+0x106/0x710 [ 11.208345][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208348][ C1] ? lock_acquire+0x13c/0x160 [ 11.208351][ C1] console_flush_one_record+0x46f/0x710 [ 11.208354][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.208357][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208360][ C1] console_unlock+0xee/0x1f0 [ 11.208363][ C1] ? console_flush_one_record+0x710/0x710 [ 11.208365][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208368][ C1] ? lock_acquire+0x60/0x160 [ 11.208371][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.208373][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.208376][ C1] vprintk_emit+0x37c/0x3e0 [ 11.208379][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.208382][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.208385][ C1] _printk+0xc7/0x100 [ 11.208388][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.208390][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.208394][ C1] ? idr_get_free+0x830/0x830 [ 11.208398][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.208401][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.208404][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 11.208406][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.208411][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.208414][ C1] ? add_timer_on+0x580/0x580 [ 11.208418][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.208421][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.208424][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 11.208429][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 11.208432][ C1] ? inet_csk_route_req+0x747/0xc30 [ 11.208435][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 11.208438][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.208441][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 11.208446][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 11.208449][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208453][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208455][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208457][ C1] ? down_read_nested+0xe7/0x500 [ 11.208461][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208465][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208468][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208471][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.208474][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 11.208476][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.208480][ C1] ? mark_usage+0x61/0x170 [ 11.208483][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 11.208486][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208488][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 11.208491][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.208495][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.208497][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.208500][ C1] ip_local_deliver+0x184/0x4c0 [ 11.208503][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 11.208505][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 11.208509][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.208512][ C1] ip_rcv+0xdc/0x3d0 [ 11.208514][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 11.208517][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208519][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 11.208523][ C1] ? mark_usage+0x61/0x170 [ 11.208525][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208528][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 11.208531][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.208534][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208536][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.208539][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 11.208542][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208546][ C1] process_backlog+0x431/0x14c0 [ 11.208550][ C1] __napi_poll+0xa7/0x3b0 [ 11.208553][ C1] net_rx_action+0x513/0xf50 [ 11.208556][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208559][ C1] ? __napi_poll+0x3b0/0x3b0 [ 11.208564][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 11.208568][ C1] ? mark_held_locks+0x40/0x70 [ 11.208571][ C1] handle_softirqs+0x1d3/0x900 [ 11.208574][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.208576][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.208579][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208582][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 11.208584][ C1] do_softirq+0xac/0xe0 [ 11.208587][ C1] [ 11.208588][ C1] [ 11.208589][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.208591][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.208594][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.208600][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 11.208603][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208605][ C1] ? find_held_lock+0x2b/0x80 [ 11.208607][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.208609][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208612][ C1] ? mark_held_locks+0x40/0x70 [ 11.208615][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.208617][ C1] ? neigh_hh_output+0x152/0x4c0 [ 11.208621][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.208624][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 11.208626][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208629][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 11.208633][ C1] ip_output+0x1ca/0x660 [ 11.208636][ C1] ? ip_finish_output+0x460/0x460 [ 11.208638][ C1] ? find_held_lock+0x2b/0x80 [ 11.208640][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.208643][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 11.208646][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.208650][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.208655][ C1] ? __tcp_select_window+0xf20/0xf20 [ 11.208658][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.208660][ C1] ? ktime_get+0x18e/0x2d0 [ 11.208662][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 11.208667][ C1] ? ktime_get+0x1dd/0x2d0 [ 11.208670][ C1] tcp_connect+0x1024/0x1e20 [ 11.208673][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.208677][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 11.208680][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.208683][ C1] ? find_held_lock+0x2b/0x80 [ 11.208685][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.208688][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.208691][ C1] inet_stream_connect+0x59/0xb0 [ 11.208693][ C1] __sys_connect+0x1cf/0x2e0 [ 11.208697][ C1] ? do_fcntl+0x36f/0xc50 [ 11.208701][ C1] ? __sys_connect_file+0x250/0x250 [ 11.208705][ C1] ? fput+0x1f/0xa0 [ 11.208709][ C1] __x64_sys_connect+0x72/0xd0 [ 11.208711][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.208713][ C1] ? do_syscall_64+0xa6/0x530 [ 11.208716][ C1] do_syscall_64+0xff/0x530 [ 11.208718][ C1] ? irq_exit_rcu+0x1a/0x30 [ 11.208721][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.208724][ C1] RIP: 0033:0x7f3079ae0312 [ 11.208729][ 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.208731][ C1] RSP: 002b:00007f307925d988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 11.208736][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007f3079ae0312 [ 11.208738][ C1] RDX: 0000000000000010 RSI: 00007f307925dc40 RDI: 0000000000000009 [ 11.208739][ C1] RBP: 00007f307925d9b0 R08: 0000000000000000 R09: 0000000000000000 [ 11.208741][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f307925dc40 [ 11.208742][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 11.208746][ C1] [ 11.208752][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.208754][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 168, name: connect-deny_ip [ 11.208756][ C1] preempt_count: 302, expected: 0 [ 11.208757][ C1] RCU nest depth: 6, expected: 0 [ 11.208758][ C1] INFO: lockdep is turned off. [ 11.208760][ C1] irq event stamp: 10613 [ 11.208761][ C1] hardirqs last enabled at (10612): [] __down_trylock_console_sem+0x86/0xa0 [ 11.208764][ C1] hardirqs last disabled at (10613): [] console_emit_next_record+0x3d4/0x4c0 [ 11.208767][ C1] softirqs last enabled at (10444): [] __dev_queue_xmit+0x964/0x1b80 [ 11.208770][ C1] softirqs last disabled at (10445): [] do_softirq+0xac/0xe0 [ 11.208772][ C1] Preemption disabled at: [ 11.208773][ C1] [] __dev_queue_xmit+0x204/0x1b80 [ 11.208778][ C1] CPU: 1 UID: 0 PID: 168 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.208781][ C1] Tainted: [W]=WARN [ 11.208782][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.208784][ C1] Call Trace: [ 11.208785][ C1] [ 11.208786][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.208790][ C1] ? __dev_queue_xmit+0x204/0x1b80 [ 11.208792][ C1] __might_resched.cold+0x1fe/0x2c1 [ 11.208796][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.208800][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208803][ C1] __kmalloc_noprof+0x443/0x760 [ 11.208807][ C1] ? __rwlock_init+0x150/0x150 [ 11.208809][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 11.208813][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.208816][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.208819][ C1] put_chars+0x1e1/0x2f0 [ 11.208822][ C1] ? __send_to_port+0x420/0x420 [ 11.208826][ C1] hvc_console_print+0x292/0x780 [ 11.208829][ C1] ? __lock_acquire+0x388/0xc20 [ 11.208833][ C1] ? hvc_write+0x3a0/0x3a0 [ 11.208835][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208838][ C1] ? lock_acquire+0x13c/0x160 [ 11.208841][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.208845][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.208847][ C1] ? console_flush_one_record+0x106/0x710 [ 11.208850][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208852][ C1] ? lock_acquire+0x13c/0x160 [ 11.208860][ C1] console_flush_one_record+0x46f/0x710 [ 11.208864][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.208866][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208870][ C1] console_unlock+0xee/0x1f0 [ 11.208872][ C1] ? console_flush_one_record+0x710/0x710 [ 11.208875][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208877][ C1] ? lock_acquire+0x60/0x160 [ 11.208880][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.208883][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.208886][ C1] vprintk_emit+0x37c/0x3e0 [ 11.208889][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.208891][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.208895][ C1] _printk+0xc7/0x100 [ 11.208898][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.208900][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.208903][ C1] ? idr_get_free+0x830/0x830 [ 11.208907][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.208911][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.208913][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x9a/0x160 [ 11.208916][ C1] ? _raw_spin_unlock_irqrestore+0x53/0x80 [ 11.208919][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.208922][ C1] ? add_timer_on+0x580/0x580 [ 11.208926][ C1] tcp_v4_send_synack+0x103/0xb20 [ 11.208929][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 11.208932][ C1] ? tcp_fastopen_add_skb+0xc0/0xc0 [ 11.208936][ C1] ? secure_tcpv6_seq_and_ts_off+0x300/0x300 [ 11.208939][ C1] ? inet_csk_route_req+0x747/0xc30 [ 11.208942][ C1] ? inet_csk_reqsk_queue_hash_add+0x4c/0x60 [ 11.208944][ C1] tcp_conn_request+0x1f15/0x2d20 [ 11.208947][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 11.208952][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 11.208954][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208958][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208960][ C1] ? __lock_acquire+0x518/0xc20 [ 11.208962][ C1] ? down_read_nested+0xe7/0x500 [ 11.208966][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.208970][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208972][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 11.208975][ C1] tcp_v4_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 11.208978][ C1] ? tcp_v4_fill_cb+0x33/0x430 [ 11.208981][ C1] tcp_v4_rcv+0x253c/0x2b70 [ 11.208985][ C1] ? mark_usage+0x61/0x170 [ 11.208987][ C1] ? tcp_add_backlog+0x1e30/0x1e30 [ 11.208991][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.208993][ C1] ? ip_local_deliver_finish+0x2ba/0x610 [ 11.208996][ C1] ip_protocol_deliver_rcu+0x82/0x350 [ 11.208999][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.209002][ C1] ip_local_deliver_finish+0x36f/0x610 [ 11.209004][ C1] ip_local_deliver+0x184/0x4c0 [ 11.209007][ C1] ? ip_local_deliver_finish+0x610/0x610 [ 11.209009][ C1] ? ip_rcv_finish_core+0x6ed/0x14c0 [ 11.209013][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.209016][ C1] ip_rcv+0xdc/0x3d0 [ 11.209018][ C1] ? ip_local_deliver+0x4c0/0x4c0 [ 11.209021][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.209023][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 11.209026][ C1] ? mark_usage+0x61/0x170 [ 11.209028][ C1] ? __lock_acquire+0x518/0xc20 [ 11.209031][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 11.209034][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 11.209037][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.209039][ C1] ? process_backlog+0x3f1/0x14c0 [ 11.209042][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 11.209045][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.209049][ C1] process_backlog+0x431/0x14c0 [ 11.209053][ C1] __napi_poll+0xa7/0x3b0 [ 11.209056][ C1] net_rx_action+0x513/0xf50 [ 11.209060][ C1] ? __lock_acquire+0x518/0xc20 [ 11.209062][ C1] ? __napi_poll+0x3b0/0x3b0 [ 11.209068][ C1] ? ktime_get_update_offsets_now+0x2a8/0x490 [ 11.209070][ C1] ? mark_held_locks+0x40/0x70 [ 11.209073][ C1] handle_softirqs+0x1d3/0x900 [ 11.209077][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.209079][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.209082][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.209084][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 11.209087][ C1] do_softirq+0xac/0xe0 [ 11.209089][ C1] [ 11.209090][ C1] [ 11.209091][ C1] __local_bh_enable_ip+0x118/0x150 [ 11.209094][ C1] __dev_queue_xmit+0x979/0x1b80 [ 11.209097][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.209100][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 11.209103][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.209105][ C1] ? find_held_lock+0x2b/0x80 [ 11.209107][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.209110][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.209113][ C1] ? mark_held_locks+0x40/0x70 [ 11.209115][ C1] ? __asan_memcpy+0x3c/0x60 [ 11.209117][ C1] ? neigh_hh_output+0x152/0x4c0 [ 11.209121][ C1] ip_finish_output2+0xd9b/0x1bc0 [ 11.209124][ C1] ? ip_dst_mtu_maybe_forward+0x261/0x670 [ 11.209126][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 11.209128][ C1] ? ip_fragment.constprop.0+0x2c0/0x2c0 [ 11.209132][ C1] ip_output+0x1ca/0x660 [ 11.209135][ C1] ? ip_finish_output+0x460/0x460 [ 11.209138][ C1] ? find_held_lock+0x2b/0x80 [ 11.209140][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 11.209143][ C1] ? ip4_dst_hoplimit+0x15b/0x320 [ 11.209146][ C1] __ip_queue_xmit+0x774/0x1650 [ 11.209149][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 11.209154][ C1] ? __tcp_select_window+0xf20/0xf20 [ 11.209157][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.209159][ C1] ? ktime_get+0x18e/0x2d0 [ 11.209161][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 11.209164][ C1] ? ktime_get+0x1dd/0x2d0 [ 11.209167][ C1] tcp_connect+0x1024/0x1e20 [ 11.209171][ C1] tcp_v4_connect+0x12bd/0x1960 [ 11.209175][ C1] ? tcp_v4_ao_sign_reset+0x8c0/0x8c0 [ 11.209177][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.209180][ C1] ? find_held_lock+0x2b/0x80 [ 11.209183][ C1] __inet_stream_connect+0x2ed/0xd00 [ 11.209185][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.209188][ C1] inet_stream_connect+0x59/0xb0 [ 11.209190][ C1] __sys_connect+0x1cf/0x2e0 [ 11.209194][ C1] ? do_fcntl+0x36f/0xc50 [ 11.209197][ C1] ? __sys_connect_file+0x250/0x250 [ 11.209202][ C1] ? fput+0x1f/0xa0 [ 11.209205][ C1] __x64_sys_connect+0x72/0xd0 [ 11.209208][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 11.209210][ C1] ? do_syscall_64+0xa6/0x530 [ 11.209212][ C1] do_syscall_64+0xff/0x530 [ 11.209215][ C1] ? irq_exit_rcu+0x1a/0x30 [ 11.209217][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 11.209220][ C1] RIP: 0033:0x7f3079ae0312 [ 11.209222][ 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.209224][ C1] RSP: 002b:00007f307925d988 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 11.209227][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007f3079ae0312 [ 11.209229][ C1] RDX: 0000000000000010 RSI: 00007f307925dc40 RDI: 0000000000000009 [ 11.209230][ C1] RBP: 00007f307925d9b0 R08: 0000000000000000 R09: 0000000000000000 [ 11.209231][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f307925dc40 [ 11.209233][ C1] R13: 0000000000000010 R14: 0000000000000001 R15: 0000000000412230 [ 11.209236][ C1] [ 12.210110][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.210129][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.210132][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 12.210134][ C1] preempt_count: 102, expected: 0 [ 12.210136][ C1] RCU nest depth: 0, expected: 0 [ 12.210137][ C1] INFO: lockdep is turned off. [ 12.210139][ C1] irq event stamp: 334622 [ 12.210140][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 12.210150][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 12.210154][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 12.210159][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 12.210162][ C1] Preemption disabled at: [ 12.210163][ C1] [<0000000000000000>] 0x0 [ 12.210172][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.210177][ C1] Tainted: [W]=WARN [ 12.210179][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.210181][ C1] Call Trace: [ 12.210184][ C1] [ 12.210187][ C1] dump_stack_lvl+0x6f/0xa0 [ 12.210194][ C1] __might_resched.cold+0x1fe/0x2c1 [ 12.210198][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.210203][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210208][ C1] __kmalloc_noprof+0x443/0x760 [ 12.210212][ C1] ? __rwlock_init+0x150/0x150 [ 12.210216][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 12.210221][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.210223][ C1] alloc_buf.isra.0+0x4b/0x260 [ 12.210227][ C1] put_chars+0x1e1/0x2f0 [ 12.210230][ C1] ? __send_to_port+0x420/0x420 [ 12.210232][ C1] ? printk_get_next_message+0x240/0x650 [ 12.210237][ C1] hvc_console_print+0x292/0x780 [ 12.210242][ C1] ? hvc_write+0x3a0/0x3a0 [ 12.210245][ C1] ? __rwlock_init+0x150/0x150 [ 12.210247][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210250][ C1] ? lock_acquire+0x13c/0x160 [ 12.210254][ C1] console_emit_next_record+0x22f/0x4c0 [ 12.210257][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 12.210260][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210263][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210265][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210267][ C1] ? lock_acquire+0x13c/0x160 [ 12.210270][ C1] ? console_flush_one_record+0x111/0x710 [ 12.210273][ C1] console_flush_one_record+0x46f/0x710 [ 12.210276][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 12.210280][ C1] console_unlock+0xee/0x1f0 [ 12.210283][ C1] ? lock_acquire+0x13c/0x160 [ 12.210285][ C1] ? console_flush_one_record+0x710/0x710 [ 12.210287][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210290][ C1] ? lock_release+0x184/0x1f0 [ 12.210292][ C1] ? lock_acquire+0x60/0x160 [ 12.210294][ C1] ? __rcu_read_lock+0x30/0x70 [ 12.210297][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.210299][ C1] ? vprintk_emit+0x320/0x3e0 [ 12.210302][ C1] vprintk_emit+0x37c/0x3e0 [ 12.210306][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 12.210308][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 12.210311][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210313][ C1] ? lock_acquire+0x13c/0x160 [ 12.210316][ C1] _printk+0xc7/0x100 [ 12.210320][ C1] ? snapshot_read.cold+0x21/0x21 [ 12.210322][ C1] ? ___ratelimit+0x4e7/0xa00 [ 12.210326][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.210330][ C1] ? idr_get_free+0x830/0x830 [ 12.210333][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.210335][ C1] tcp_make_synack.cold+0x36/0xb6 [ 12.210340][ C1] ? tcp_send_synack+0x1570/0x1570 [ 12.210345][ C1] ? lock_release+0x184/0x1f0 [ 12.210347][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210351][ C1] ? inet_csk_route_req+0x747/0xc30 [ 12.210355][ C1] tcp_v4_send_synack+0x103/0xb20 [ 12.210358][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 12.210360][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 12.210364][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.210367][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.210369][ C1] ? get_random_u16+0x740/0x740 [ 12.210373][ C1] tcp_rtx_synack+0x150/0x440 [ 12.210376][ C1] ? tcp_send_probe0+0x590/0x590 [ 12.210380][ C1] ? sched_balance_rq+0x324/0x1e30 [ 12.210382][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.210385][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 12.210388][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.210390][ C1] ? lock_acquire+0x6a/0x160 [ 12.210393][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.210395][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.210397][ C1] call_timer_fn+0x160/0x4d0 [ 12.210401][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 12.210404][ C1] ? debug_object_active_state+0x430/0x430 [ 12.210409][ C1] ? __rwlock_init+0x150/0x150 [ 12.210411][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.210413][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210417][ C1] __run_timers+0x68f/0xaa0 [ 12.210419][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.210423][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.210426][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.210430][ C1] ? __rwlock_init+0x150/0x150 [ 12.210433][ C1] run_timer_softirq+0xf0/0x160 [ 12.210436][ C1] ? __run_timers+0xaa0/0xaa0 [ 12.210439][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.210441][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210444][ C1] handle_softirqs+0x1d3/0x900 [ 12.210447][ C1] ? _local_bh_enable+0xc0/0xc0 [ 12.210449][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210452][ C1] ? lock_release+0x184/0x1f0 [ 12.210455][ C1] __irq_exit_rcu+0x145/0x1c0 [ 12.210457][ C1] irq_exit_rcu+0xe/0x30 [ 12.210459][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.210462][ C1] [ 12.210463][ C1] [ 12.210464][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 12.210467][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.210471][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.210474][ 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.210477][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 12.210481][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 12.210483][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 12.210484][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 12.210485][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 12.210487][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.210489][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.210492][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.210496][ C1] default_idle+0x9/0x10 [ 12.210498][ C1] default_idle_call+0x6e/0xb0 [ 12.210500][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.210503][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 12.210505][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 12.210509][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210511][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.210514][ C1] do_idle+0xd8/0x190 [ 12.210517][ C1] cpu_startup_entry+0x53/0x70 [ 12.210519][ C1] start_secondary+0x204/0x2b0 [ 12.210522][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.210525][ C1] common_startup_64+0x13e/0x148 [ 12.210531][ C1] [ 12.403123][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.426006][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.426021][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.426024][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 13.426026][ C1] preempt_count: 102, expected: 0 [ 13.426027][ C1] RCU nest depth: 0, expected: 0 [ 13.426028][ C1] INFO: lockdep is turned off. [ 13.426029][ C1] irq event stamp: 334622 [ 13.426030][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 13.426038][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 13.426040][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 13.426044][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 13.426046][ C1] Preemption disabled at: [ 13.426047][ C1] [<0000000000000000>] 0x0 [ 13.426055][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.426058][ C1] Tainted: [W]=WARN [ 13.426059][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.426061][ C1] Call Trace: [ 13.426063][ C1] [ 13.426065][ C1] dump_stack_lvl+0x6f/0xa0 [ 13.426071][ C1] __might_resched.cold+0x1fe/0x2c1 [ 13.426075][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.426078][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426082][ C1] __kmalloc_noprof+0x443/0x760 [ 13.426085][ C1] ? __rwlock_init+0x150/0x150 [ 13.426088][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 13.426092][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.426094][ C1] alloc_buf.isra.0+0x4b/0x260 [ 13.426096][ C1] put_chars+0x1e1/0x2f0 [ 13.426098][ C1] ? __send_to_port+0x420/0x420 [ 13.426099][ C1] ? printk_get_next_message+0x240/0x650 [ 13.426103][ C1] hvc_console_print+0x292/0x780 [ 13.426107][ C1] ? hvc_write+0x3a0/0x3a0 [ 13.426108][ C1] ? __rwlock_init+0x150/0x150 [ 13.426110][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426112][ C1] ? lock_acquire+0x13c/0x160 [ 13.426114][ C1] console_emit_next_record+0x22f/0x4c0 [ 13.426117][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 13.426119][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426120][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426122][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426124][ C1] ? lock_acquire+0x13c/0x160 [ 13.426126][ C1] ? console_flush_one_record+0x111/0x710 [ 13.426127][ C1] console_flush_one_record+0x46f/0x710 [ 13.426130][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 13.426132][ C1] console_unlock+0xee/0x1f0 [ 13.426134][ C1] ? lock_acquire+0x13c/0x160 [ 13.426136][ C1] ? console_flush_one_record+0x710/0x710 [ 13.426137][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426139][ C1] ? lock_release+0x184/0x1f0 [ 13.426140][ C1] ? lock_acquire+0x60/0x160 [ 13.426142][ C1] ? __rcu_read_lock+0x30/0x70 [ 13.426144][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.426146][ C1] ? vprintk_emit+0x320/0x3e0 [ 13.426148][ C1] vprintk_emit+0x37c/0x3e0 [ 13.426150][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 13.426152][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 13.426154][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426156][ C1] ? lock_acquire+0x13c/0x160 [ 13.426157][ C1] _printk+0xc7/0x100 [ 13.426161][ C1] ? snapshot_read.cold+0x21/0x21 [ 13.426162][ C1] ? ___ratelimit+0x4e7/0xa00 [ 13.426165][ C1] ? trace_hardirqs_on+0x36/0x40 [ 13.426167][ C1] ? idr_get_free+0x830/0x830 [ 13.426169][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.426171][ C1] tcp_make_synack.cold+0x36/0xb6 [ 13.426175][ C1] ? tcp_send_synack+0x1570/0x1570 [ 13.426178][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426180][ C1] ? inet_csk_route_req+0x747/0xc30 [ 13.426183][ C1] tcp_v4_send_synack+0x103/0xb20 [ 13.426185][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 13.426187][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 13.426190][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.426191][ C1] ? trace_hardirqs_on+0x36/0x40 [ 13.426193][ C1] ? get_random_u16+0x740/0x740 [ 13.426195][ C1] tcp_rtx_synack+0x150/0x440 [ 13.426197][ C1] ? tcp_send_probe0+0x590/0x590 [ 13.426199][ C1] ? sched_balance_rq+0x324/0x1e30 [ 13.426201][ C1] ? do_raw_spin_lock+0x131/0x280 [ 13.426203][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 13.426205][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.426206][ C1] ? lock_acquire+0x6a/0x160 [ 13.426207][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.426209][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.426210][ C1] call_timer_fn+0x160/0x4d0 [ 13.426213][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 13.426215][ C1] ? debug_object_active_state+0x430/0x430 [ 13.426219][ C1] ? __rwlock_init+0x150/0x150 [ 13.426221][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.426222][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426224][ C1] __run_timers+0x68f/0xaa0 [ 13.426226][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.426228][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.426230][ C1] ? do_raw_spin_lock+0x131/0x280 [ 13.426233][ C1] ? __rwlock_init+0x150/0x150 [ 13.426235][ C1] run_timer_softirq+0xf0/0x160 [ 13.426237][ C1] ? __run_timers+0xaa0/0xaa0 [ 13.426239][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.426240][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426242][ C1] handle_softirqs+0x1d3/0x900 [ 13.426244][ C1] ? _local_bh_enable+0xc0/0xc0 [ 13.426245][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426247][ C1] ? lock_release+0x184/0x1f0 [ 13.426249][ C1] __irq_exit_rcu+0x145/0x1c0 [ 13.426250][ C1] irq_exit_rcu+0xe/0x30 [ 13.426251][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.426253][ C1] [ 13.426254][ C1] [ 13.426254][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 13.426256][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.426259][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.426262][ C1] Code: 48 8b 3d 94 12 06 02 e8 1f 00 00 00 48 2b 05 58 13 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 b6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 13.426263][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 13.426266][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 13.426268][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 13.426269][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 13.426270][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 13.426270][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.426272][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.426273][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.426276][ C1] default_idle+0x9/0x10 [ 13.426277][ C1] default_idle_call+0x6e/0xb0 [ 13.426279][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.426280][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 13.426282][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 13.426284][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426286][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.426288][ C1] do_idle+0xd8/0x190 [ 13.426289][ C1] cpu_startup_entry+0x53/0x70 [ 13.426291][ C1] start_secondary+0x204/0x2b0 [ 13.426292][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.426294][ C1] common_startup_64+0x13e/0x148 [ 13.426298][ C1] [ 13.449558][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.451023][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.451039][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.451041][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 14.451043][ C1] preempt_count: 102, expected: 0 [ 14.451044][ C1] RCU nest depth: 0, expected: 0 [ 14.451045][ C1] INFO: lockdep is turned off. [ 14.451046][ C1] irq event stamp: 334622 [ 14.451047][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 14.451054][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 14.451056][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 14.451060][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 14.451062][ C1] Preemption disabled at: [ 14.451063][ C1] [<0000000000000000>] 0x0 [ 14.451070][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.451074][ C1] Tainted: [W]=WARN [ 14.451075][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.451076][ C1] Call Trace: [ 14.451078][ C1] [ 14.451080][ C1] dump_stack_lvl+0x6f/0xa0 [ 14.451086][ C1] __might_resched.cold+0x1fe/0x2c1 [ 14.451090][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.451093][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451097][ C1] __kmalloc_noprof+0x443/0x760 [ 14.451101][ C1] ? __rwlock_init+0x150/0x150 [ 14.451103][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 14.451107][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.451109][ C1] alloc_buf.isra.0+0x4b/0x260 [ 14.451111][ C1] put_chars+0x1e1/0x2f0 [ 14.451113][ C1] ? __send_to_port+0x420/0x420 [ 14.451115][ C1] ? printk_get_next_message+0x240/0x650 [ 14.451118][ C1] hvc_console_print+0x292/0x780 [ 14.451122][ C1] ? hvc_write+0x3a0/0x3a0 [ 14.451123][ C1] ? __rwlock_init+0x150/0x150 [ 14.451125][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451127][ C1] ? lock_acquire+0x13c/0x160 [ 14.451129][ C1] console_emit_next_record+0x22f/0x4c0 [ 14.451131][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 14.451133][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451135][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451137][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451138][ C1] ? lock_acquire+0x13c/0x160 [ 14.451140][ C1] ? console_flush_one_record+0x111/0x710 [ 14.451142][ C1] console_flush_one_record+0x46f/0x710 [ 14.451144][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 14.451147][ C1] console_unlock+0xee/0x1f0 [ 14.451148][ C1] ? lock_acquire+0x13c/0x160 [ 14.451150][ C1] ? console_flush_one_record+0x710/0x710 [ 14.451152][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451153][ C1] ? lock_release+0x184/0x1f0 [ 14.451155][ C1] ? lock_acquire+0x60/0x160 [ 14.451156][ C1] ? __rcu_read_lock+0x30/0x70 [ 14.451158][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.451160][ C1] ? vprintk_emit+0x320/0x3e0 [ 14.451162][ C1] vprintk_emit+0x37c/0x3e0 [ 14.451164][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 14.451166][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 14.451168][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451169][ C1] ? lock_acquire+0x13c/0x160 [ 14.451171][ C1] _printk+0xc7/0x100 [ 14.451174][ C1] ? snapshot_read.cold+0x21/0x21 [ 14.451176][ C1] ? ___ratelimit+0x4e7/0xa00 [ 14.451179][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.451181][ C1] ? idr_get_free+0x830/0x830 [ 14.451183][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.451184][ C1] tcp_make_synack.cold+0x36/0xb6 [ 14.451188][ C1] ? tcp_send_synack+0x1570/0x1570 [ 14.451192][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451194][ C1] ? inet_csk_route_req+0x747/0xc30 [ 14.451197][ C1] tcp_v4_send_synack+0x103/0xb20 [ 14.451199][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 14.451201][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.451203][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.451204][ C1] ? get_random_u16+0x740/0x740 [ 14.451206][ C1] tcp_rtx_synack+0x150/0x440 [ 14.451208][ C1] ? tcp_send_probe0+0x590/0x590 [ 14.451210][ C1] ? sched_balance_rq+0x324/0x1e30 [ 14.451213][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.451215][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 14.451217][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.451218][ C1] ? lock_acquire+0x6a/0x160 [ 14.451219][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.451221][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.451223][ C1] call_timer_fn+0x160/0x4d0 [ 14.451226][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 14.451227][ C1] ? debug_object_active_state+0x430/0x430 [ 14.451231][ C1] ? __rwlock_init+0x150/0x150 [ 14.451233][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 14.451235][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451237][ C1] __run_timers+0x68f/0xaa0 [ 14.451239][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.451241][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.451243][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.451245][ C1] ? __rwlock_init+0x150/0x150 [ 14.451247][ C1] run_timer_softirq+0xf0/0x160 [ 14.451249][ C1] ? __run_timers+0xaa0/0xaa0 [ 14.451251][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.451252][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451254][ C1] handle_softirqs+0x1d3/0x900 [ 14.451256][ C1] ? _local_bh_enable+0xc0/0xc0 [ 14.451258][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451259][ C1] ? lock_release+0x184/0x1f0 [ 14.451261][ C1] __irq_exit_rcu+0x145/0x1c0 [ 14.451262][ C1] irq_exit_rcu+0xe/0x30 [ 14.451264][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.451266][ C1] [ 14.451267][ C1] [ 14.451267][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 14.451269][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.451272][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.451274][ 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.451276][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 14.451279][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 14.451280][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 14.451281][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 14.451282][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 14.451283][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.451284][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.451286][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.451288][ C1] default_idle+0x9/0x10 [ 14.451289][ C1] default_idle_call+0x6e/0xb0 [ 14.451291][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.451292][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 14.451294][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 14.451297][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451298][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.451300][ C1] do_idle+0xd8/0x190 [ 14.451302][ C1] cpu_startup_entry+0x53/0x70 [ 14.451303][ C1] start_secondary+0x204/0x2b0 [ 14.451305][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.451307][ C1] common_startup_64+0x13e/0x148 [ 14.451311][ C1] [ 14.474712][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.539011][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 15.539026][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 15.539028][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 15.539030][ C1] preempt_count: 102, expected: 0 [ 15.539031][ C1] RCU nest depth: 0, expected: 0 [ 15.539032][ C1] INFO: lockdep is turned off. [ 15.539033][ C1] irq event stamp: 334622 [ 15.539034][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 15.539041][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 15.539044][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 15.539047][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 15.539050][ C1] Preemption disabled at: [ 15.539050][ C1] [<0000000000000000>] 0x0 [ 15.539057][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 15.539060][ C1] Tainted: [W]=WARN [ 15.539061][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 15.539063][ C1] Call Trace: [ 15.539065][ C1] [ 15.539067][ C1] dump_stack_lvl+0x6f/0xa0 [ 15.539073][ C1] __might_resched.cold+0x1fe/0x2c1 [ 15.539077][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 15.539080][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539084][ C1] __kmalloc_noprof+0x443/0x760 [ 15.539088][ C1] ? __rwlock_init+0x150/0x150 [ 15.539090][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 15.539094][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.539096][ C1] alloc_buf.isra.0+0x4b/0x260 [ 15.539098][ C1] put_chars+0x1e1/0x2f0 [ 15.539100][ C1] ? __send_to_port+0x420/0x420 [ 15.539102][ C1] ? printk_get_next_message+0x240/0x650 [ 15.539105][ C1] hvc_console_print+0x292/0x780 [ 15.539109][ C1] ? hvc_write+0x3a0/0x3a0 [ 15.539110][ C1] ? __rwlock_init+0x150/0x150 [ 15.539112][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539114][ C1] ? lock_acquire+0x13c/0x160 [ 15.539116][ C1] console_emit_next_record+0x22f/0x4c0 [ 15.539119][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 15.539121][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539122][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539124][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539125][ C1] ? lock_acquire+0x13c/0x160 [ 15.539127][ C1] ? console_flush_one_record+0x111/0x710 [ 15.539129][ C1] console_flush_one_record+0x46f/0x710 [ 15.539131][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 15.539134][ C1] console_unlock+0xee/0x1f0 [ 15.539136][ C1] ? lock_acquire+0x13c/0x160 [ 15.539137][ C1] ? console_flush_one_record+0x710/0x710 [ 15.539139][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539141][ C1] ? lock_release+0x184/0x1f0 [ 15.539142][ C1] ? lock_acquire+0x60/0x160 [ 15.539144][ C1] ? __rcu_read_lock+0x30/0x70 [ 15.539146][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 15.539148][ C1] ? vprintk_emit+0x320/0x3e0 [ 15.539150][ C1] vprintk_emit+0x37c/0x3e0 [ 15.539152][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 15.539154][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 15.539156][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539157][ C1] ? lock_acquire+0x13c/0x160 [ 15.539159][ C1] _printk+0xc7/0x100 [ 15.539162][ C1] ? snapshot_read.cold+0x21/0x21 [ 15.539164][ C1] ? ___ratelimit+0x4e7/0xa00 [ 15.539166][ C1] ? trace_hardirqs_on+0x36/0x40 [ 15.539169][ C1] ? idr_get_free+0x830/0x830 [ 15.539171][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 15.539172][ C1] tcp_make_synack.cold+0x36/0xb6 [ 15.539176][ C1] ? tcp_send_synack+0x1570/0x1570 [ 15.539180][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539182][ C1] ? inet_csk_route_req+0x747/0xc30 [ 15.539185][ C1] tcp_v4_send_synack+0x103/0xb20 [ 15.539187][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 15.539189][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 15.539192][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.539193][ C1] ? trace_hardirqs_on+0x36/0x40 [ 15.539194][ C1] ? get_random_u16+0x740/0x740 [ 15.539197][ C1] tcp_rtx_synack+0x150/0x440 [ 15.539198][ C1] ? tcp_send_probe0+0x590/0x590 [ 15.539201][ C1] ? sched_balance_rq+0x324/0x1e30 [ 15.539203][ C1] ? do_raw_spin_lock+0x131/0x280 [ 15.539204][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 15.539206][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.539208][ C1] ? lock_acquire+0x6a/0x160 [ 15.539209][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 15.539211][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.539212][ C1] call_timer_fn+0x160/0x4d0 [ 15.539215][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 15.539217][ C1] ? debug_object_active_state+0x430/0x430 [ 15.539221][ C1] ? __rwlock_init+0x150/0x150 [ 15.539223][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 15.539224][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539226][ C1] __run_timers+0x68f/0xaa0 [ 15.539228][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 15.539230][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 15.539232][ C1] ? do_raw_spin_lock+0x131/0x280 [ 15.539235][ C1] ? __rwlock_init+0x150/0x150 [ 15.539237][ C1] run_timer_softirq+0xf0/0x160 [ 15.539239][ C1] ? __run_timers+0xaa0/0xaa0 [ 15.539241][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 15.539242][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539244][ C1] handle_softirqs+0x1d3/0x900 [ 15.539246][ C1] ? _local_bh_enable+0xc0/0xc0 [ 15.539247][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539249][ C1] ? lock_release+0x184/0x1f0 [ 15.539251][ C1] __irq_exit_rcu+0x145/0x1c0 [ 15.539252][ C1] irq_exit_rcu+0xe/0x30 [ 15.539254][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 15.539256][ C1] [ 15.539256][ C1] [ 15.539257][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 15.539259][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 15.539262][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 15.539264][ 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.539266][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 15.539269][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 15.539271][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 15.539271][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 15.539272][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 15.539273][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 15.539274][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 15.539276][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.539278][ C1] default_idle+0x9/0x10 [ 15.539280][ C1] default_idle_call+0x6e/0xb0 [ 15.539281][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 15.539283][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 15.539284][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 15.539287][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539288][ C1] ? rcu_is_watching+0x16/0xd0 [ 15.539291][ C1] do_idle+0xd8/0x190 [ 15.539292][ C1] cpu_startup_entry+0x53/0x70 [ 15.539294][ C1] start_secondary+0x204/0x2b0 [ 15.539296][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 15.539297][ C1] common_startup_64+0x13e/0x148 [ 15.539302][ C1] [ 15.558096][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.562010][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 16.562026][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 16.562028][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 16.562030][ C1] preempt_count: 102, expected: 0 [ 16.562031][ C1] RCU nest depth: 0, expected: 0 [ 16.562032][ C1] INFO: lockdep is turned off. [ 16.562033][ C1] irq event stamp: 334622 [ 16.562034][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 16.562042][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 16.562045][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 16.562048][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 16.562051][ C1] Preemption disabled at: [ 16.562052][ C1] [<0000000000000000>] 0x0 [ 16.562059][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 16.562062][ C1] Tainted: [W]=WARN [ 16.562063][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 16.562065][ C1] Call Trace: [ 16.562067][ C1] [ 16.562069][ C1] dump_stack_lvl+0x6f/0xa0 [ 16.562075][ C1] __might_resched.cold+0x1fe/0x2c1 [ 16.562079][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 16.562082][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562086][ C1] __kmalloc_noprof+0x443/0x760 [ 16.562090][ C1] ? __rwlock_init+0x150/0x150 [ 16.562092][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 16.562096][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 16.562098][ C1] alloc_buf.isra.0+0x4b/0x260 [ 16.562100][ C1] put_chars+0x1e1/0x2f0 [ 16.562102][ C1] ? __send_to_port+0x420/0x420 [ 16.562104][ C1] ? printk_get_next_message+0x240/0x650 [ 16.562107][ C1] hvc_console_print+0x292/0x780 [ 16.562111][ C1] ? hvc_write+0x3a0/0x3a0 [ 16.562113][ C1] ? __rwlock_init+0x150/0x150 [ 16.562114][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562116][ C1] ? lock_acquire+0x13c/0x160 [ 16.562119][ C1] console_emit_next_record+0x22f/0x4c0 [ 16.562122][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 16.562124][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562126][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562128][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562129][ C1] ? lock_acquire+0x13c/0x160 [ 16.562131][ C1] ? console_flush_one_record+0x111/0x710 [ 16.562133][ C1] console_flush_one_record+0x46f/0x710 [ 16.562135][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 16.562138][ C1] console_unlock+0xee/0x1f0 [ 16.562140][ C1] ? lock_acquire+0x13c/0x160 [ 16.562142][ C1] ? console_flush_one_record+0x710/0x710 [ 16.562144][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562146][ C1] ? lock_release+0x184/0x1f0 [ 16.562147][ C1] ? lock_acquire+0x60/0x160 [ 16.562149][ C1] ? __rcu_read_lock+0x30/0x70 [ 16.562151][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 16.562153][ C1] ? vprintk_emit+0x320/0x3e0 [ 16.562155][ C1] vprintk_emit+0x37c/0x3e0 [ 16.562158][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 16.562160][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 16.562161][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562163][ C1] ? lock_acquire+0x13c/0x160 [ 16.562165][ C1] _printk+0xc7/0x100 [ 16.562168][ C1] ? snapshot_read.cold+0x21/0x21 [ 16.562170][ C1] ? ___ratelimit+0x4e7/0xa00 [ 16.562173][ C1] ? idr_get_free+0x830/0x830 [ 16.562175][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 16.562178][ C1] tcp_make_synack.cold+0x36/0xb6 [ 16.562181][ C1] ? tcp_send_synack+0x1570/0x1570 [ 16.562185][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562188][ C1] ? inet_csk_route_req+0x747/0xc30 [ 16.562191][ C1] tcp_v4_send_synack+0x103/0xb20 [ 16.562193][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 16.562195][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 16.562198][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.562200][ C1] ? trace_hardirqs_on+0x36/0x40 [ 16.562201][ C1] ? get_random_u16+0x740/0x740 [ 16.562204][ C1] tcp_rtx_synack+0x150/0x440 [ 16.562206][ C1] ? tcp_send_probe0+0x590/0x590 [ 16.562208][ C1] ? sched_balance_rq+0x324/0x1e30 [ 16.562210][ C1] ? do_raw_spin_lock+0x131/0x280 [ 16.562212][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 16.562214][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.562215][ C1] ? lock_acquire+0x6a/0x160 [ 16.562217][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 16.562219][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.562220][ C1] call_timer_fn+0x160/0x4d0 [ 16.562223][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 16.562225][ C1] ? debug_object_active_state+0x430/0x430 [ 16.562229][ C1] ? __rwlock_init+0x150/0x150 [ 16.562231][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 16.562233][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562235][ C1] __run_timers+0x68f/0xaa0 [ 16.562237][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 16.562239][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 16.562241][ C1] ? do_raw_spin_lock+0x131/0x280 [ 16.562243][ C1] ? __rwlock_init+0x150/0x150 [ 16.562246][ C1] run_timer_softirq+0xf0/0x160 [ 16.562248][ C1] ? __run_timers+0xaa0/0xaa0 [ 16.562250][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 16.562251][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562253][ C1] handle_softirqs+0x1d3/0x900 [ 16.562255][ C1] ? _local_bh_enable+0xc0/0xc0 [ 16.562256][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562258][ C1] ? lock_release+0x184/0x1f0 [ 16.562260][ C1] __irq_exit_rcu+0x145/0x1c0 [ 16.562262][ C1] irq_exit_rcu+0xe/0x30 [ 16.562263][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 16.562265][ C1] [ 16.562266][ C1] [ 16.562266][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 16.562268][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 16.562271][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 16.562273][ 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.562275][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 16.562278][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 16.562280][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 16.562281][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 16.562281][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 16.562282][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 16.562284][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 16.562285][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.562287][ C1] default_idle+0x9/0x10 [ 16.562289][ C1] default_idle_call+0x6e/0xb0 [ 16.562290][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 16.562292][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 16.562294][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 16.562296][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562298][ C1] ? rcu_is_watching+0x16/0xd0 [ 16.562300][ C1] do_idle+0xd8/0x190 [ 16.562302][ C1] cpu_startup_entry+0x53/0x70 [ 16.562303][ C1] start_secondary+0x204/0x2b0 [ 16.562305][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 16.562307][ C1] common_startup_64+0x13e/0x148 [ 16.562311][ C1] [ 16.586841][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.650029][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 17.650045][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 17.650047][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 17.650049][ C1] preempt_count: 102, expected: 0 [ 17.650050][ C1] RCU nest depth: 0, expected: 0 [ 17.650050][ C1] INFO: lockdep is turned off. [ 17.650052][ C1] irq event stamp: 334622 [ 17.650053][ C1] hardirqs last enabled at (334621): [] default_idle_call+0x98/0xb0 [ 17.650061][ C1] hardirqs last disabled at (334622): [] __schedule+0x1246/0x20e0 [ 17.650063][ C1] softirqs last enabled at (334612): [] handle_softirqs+0x67c/0x900 [ 17.650067][ C1] softirqs last disabled at (334605): [] __irq_exit_rcu+0x145/0x1c0 [ 17.650069][ C1] Preemption disabled at: [ 17.650070][ C1] [<0000000000000000>] 0x0 [ 17.650078][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 17.650081][ C1] Tainted: [W]=WARN [ 17.650082][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 17.650084][ C1] Call Trace: [ 17.650085][ C1] [ 17.650088][ C1] dump_stack_lvl+0x6f/0xa0 [ 17.650093][ C1] __might_resched.cold+0x1fe/0x2c1 [ 17.650097][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 17.650100][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650105][ C1] __kmalloc_noprof+0x443/0x760 [ 17.650108][ C1] ? __rwlock_init+0x150/0x150 [ 17.650111][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 17.650115][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 17.650117][ C1] alloc_buf.isra.0+0x4b/0x260 [ 17.650119][ C1] put_chars+0x1e1/0x2f0 [ 17.650121][ C1] ? __send_to_port+0x420/0x420 [ 17.650123][ C1] ? printk_get_next_message+0x240/0x650 [ 17.650126][ C1] hvc_console_print+0x292/0x780 [ 17.650130][ C1] ? hvc_write+0x3a0/0x3a0 [ 17.650132][ C1] ? __rwlock_init+0x150/0x150 [ 17.650134][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650135][ C1] ? lock_acquire+0x13c/0x160 [ 17.650138][ C1] console_emit_next_record+0x22f/0x4c0 [ 17.650141][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 17.650143][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650144][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650146][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650148][ C1] ? lock_acquire+0x13c/0x160 [ 17.650150][ C1] ? console_flush_one_record+0x111/0x710 [ 17.650151][ C1] console_flush_one_record+0x46f/0x710 [ 17.650154][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 17.650156][ C1] console_unlock+0xee/0x1f0 [ 17.650158][ C1] ? lock_acquire+0x13c/0x160 [ 17.650160][ C1] ? console_flush_one_record+0x710/0x710 [ 17.650162][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650163][ C1] ? lock_release+0x184/0x1f0 [ 17.650165][ C1] ? lock_acquire+0x60/0x160 [ 17.650166][ C1] ? __rcu_read_lock+0x30/0x70 [ 17.650168][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 17.650170][ C1] ? vprintk_emit+0x320/0x3e0 [ 17.650172][ C1] vprintk_emit+0x37c/0x3e0 [ 17.650174][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 17.650176][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 17.650178][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650180][ C1] ? lock_acquire+0x13c/0x160 [ 17.650182][ C1] _printk+0xc7/0x100 [ 17.650185][ C1] ? snapshot_read.cold+0x21/0x21 [ 17.650186][ C1] ? ___ratelimit+0x4e7/0xa00 [ 17.650189][ C1] ? trace_hardirqs_on+0x36/0x40 [ 17.650192][ C1] ? idr_get_free+0x830/0x830 [ 17.650193][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 17.650195][ C1] tcp_make_synack.cold+0x36/0xb6 [ 17.650199][ C1] ? tcp_send_synack+0x1570/0x1570 [ 17.650203][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650205][ C1] ? inet_csk_route_req+0x747/0xc30 [ 17.650208][ C1] tcp_v4_send_synack+0x103/0xb20 [ 17.650210][ C1] ? tcp_v4_timewait_ack+0x870/0x870 [ 17.650212][ C1] ? sched_balance_find_src_group+0xda/0x760 [ 17.650215][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.650216][ C1] ? trace_hardirqs_on+0x36/0x40 [ 17.650217][ C1] ? get_random_u16+0x740/0x740 [ 17.650220][ C1] tcp_rtx_synack+0x150/0x440 [ 17.650222][ C1] ? tcp_send_probe0+0x590/0x590 [ 17.650224][ C1] ? sched_balance_rq+0x324/0x1e30 [ 17.650226][ C1] ? do_raw_spin_lock+0x131/0x280 [ 17.650228][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 17.650230][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.650231][ C1] ? lock_acquire+0x6a/0x160 [ 17.650233][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 17.650235][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.650236][ C1] call_timer_fn+0x160/0x4d0 [ 17.650239][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 17.650241][ C1] ? debug_object_active_state+0x430/0x430 [ 17.650245][ C1] ? __rwlock_init+0x150/0x150 [ 17.650246][ C1] ? timer_recalc_next_expiry+0x71/0x210 [ 17.650248][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650250][ C1] __run_timers+0x68f/0xaa0 [ 17.650252][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 17.650254][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 17.650257][ C1] ? do_raw_spin_lock+0x131/0x280 [ 17.650259][ C1] ? __rwlock_init+0x150/0x150 [ 17.650261][ C1] run_timer_softirq+0xf0/0x160 [ 17.650263][ C1] ? __run_timers+0xaa0/0xaa0 [ 17.650265][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 17.650266][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650268][ C1] handle_softirqs+0x1d3/0x900 [ 17.650270][ C1] ? _local_bh_enable+0xc0/0xc0 [ 17.650272][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650273][ C1] ? lock_release+0x184/0x1f0 [ 17.650275][ C1] __irq_exit_rcu+0x145/0x1c0 [ 17.650277][ C1] irq_exit_rcu+0xe/0x30 [ 17.650278][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 17.650280][ C1] [ 17.650281][ C1] [ 17.650281][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 17.650284][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 17.650286][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 17.650288][ 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 [ 17.650290][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 17.650293][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 17.650295][ C1] RDX: 0000000000000001 RSI: ffffffff8b68dc60 RDI: ffffffff88cfa307 [ 17.650296][ C1] RBP: 0000000000000000 R08: ffffffff8b31e421 R09: 1fe2200006a563a2 [ 17.650296][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 17.650297][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 17.650298][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 17.650300][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.650302][ C1] default_idle+0x9/0x10 [ 17.650304][ C1] default_idle_call+0x6e/0xb0 [ 17.650305][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 17.650307][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 17.650309][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 17.650311][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650313][ C1] ? rcu_is_watching+0x16/0xd0 [ 17.650315][ C1] do_idle+0xd8/0x190 [ 17.650316][ C1] cpu_startup_entry+0x53/0x70 [ 17.650318][ C1] start_secondary+0x204/0x2b0 [ 17.650320][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 17.650322][ C1] common_startup_64+0x13e/0x148 [ 17.650326][ C1]