[ 8.629737][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 8.629762][ C1] [ 8.629763][ C1] ======================================================== [ 8.629764][ C1] WARNING: possible irq lock inversion dependency detected [ 8.629766][ C1] 7.2.0-virtme #1 Tainted: G W [ 8.629768][ C1] -------------------------------------------------------- [ 8.629768][ C1] connect-deny_ip/169 just changed the state of lock: [ 8.629769][ C1] ffffffff88c99660 (console_owner){..-.}-{0:0}, at: console_lock_spinning_enable+0x40/0x60 [ 8.629781][ C1] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 8.629782][ C1] (fs_reclaim){+.+.}-{0:0} [ 8.629783][ C1] [ 8.629783][ C1] [ 8.629783][ C1] and interrupts could create inverse lock ordering between them. [ 8.629783][ C1] [ 8.629784][ C1] [ 8.629784][ C1] other info that might help us debug this: [ 8.629785][ C1] Possible interrupt unsafe locking scenario: [ 8.629785][ C1] [ 8.629785][ C1] CPU0 CPU1 [ 8.629786][ C1] ---- ---- [ 8.629786][ C1] lock(fs_reclaim); [ 8.629787][ C1] local_irq_disable(); [ 8.629788][ C1] lock(console_owner); [ 8.629788][ C1] lock(fs_reclaim); [ 8.629789][ C1] [ 8.629790][ C1] lock(console_owner); [ 8.629790][ C1] [ 8.629790][ C1] *** DEADLOCK *** [ 8.629790][ C1] [ 8.629791][ C1] locks held by connect-deny_ip/169: 9, last CPU#1: [ 8.629792][ C1] #0: ff1100001471d690 (sk_lock-AF_INET6){+.+.}-{0:0}, at: inet_stream_connect+0x44/0xb0 [ 8.629798][ C1] #1: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: inet6_csk_xmit+0xfe/0x5f0 [ 8.629802][ C1] #2: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: ip6_xmit+0x26a/0x1ec0 [ 8.629806][ C1] #3: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: ip6_output+0x11d/0x7f0 [ 8.629809][ C1] #4: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: process_backlog+0x3f1/0x14c0 [ 8.629813][ C1] #5: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: ip6_input+0xa1/0x570 [ 8.629816][ C1] #6: ffffffff88d90b00 (rcu_read_lock){....}-{1:3}, at: tcp_rcv_listen_state_process+0x108/0x380 [ 8.629821][ C1] #7: ffffffff88d79cc0 (console_lock){+.+.}-{0:0}, at: vprintk_emit+0x320/0x3e0 [ 8.629824][ C1] #8: ffffffff88d79d38 (console_srcu){....}-{0:0}, at: console_flush_one_record+0x106/0x710 [ 8.629827][ C1] [ 8.629827][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 8.629832][ C1] -> (fs_reclaim){+.+.}-{0:0} { [ 8.629834][ C1] HARDIRQ-ON-W at: [ 8.629835][ C1] __lock_acquire+0x388/0xc20 [ 8.629838][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629839][ C1] fs_reclaim_acquire+0xd5/0x120 [ 8.629842][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 8.629844][ C1] kthread_create_worker_on_node+0xea/0x210 [ 8.629847][ C1] workqueue_init+0x2a/0x680 [ 8.629850][ C1] kernel_init_freeable+0x2fe/0x630 [ 8.629853][ C1] kernel_init+0x21/0x150 [ 8.629855][ C1] ret_from_fork+0x474/0x6b0 [ 8.629858][ C1] ret_from_fork_asm+0x11/0x20 [ 8.629861][ C1] SOFTIRQ-ON-W at: [ 8.629862][ C1] __lock_acquire+0x388/0xc20 [ 8.629863][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629865][ C1] fs_reclaim_acquire+0xd5/0x120 [ 8.629866][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 8.629867][ C1] kthread_create_worker_on_node+0xea/0x210 [ 8.629868][ C1] workqueue_init+0x2a/0x680 [ 8.629869][ C1] kernel_init_freeable+0x2fe/0x630 [ 8.629871][ C1] kernel_init+0x21/0x150 [ 8.629872][ C1] ret_from_fork+0x474/0x6b0 [ 8.629873][ C1] ret_from_fork_asm+0x11/0x20 [ 8.629874][ C1] INITIAL USE at: [ 8.629875][ C1] __lock_acquire+0x388/0xc20 [ 8.629876][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629877][ C1] fs_reclaim_acquire+0xd5/0x120 [ 8.629879][ C1] __kmalloc_cache_noprof+0x6e/0x620 [ 8.629880][ C1] kthread_create_worker_on_node+0xea/0x210 [ 8.629881][ C1] workqueue_init+0x2a/0x680 [ 8.629882][ C1] kernel_init_freeable+0x2fe/0x630 [ 8.629884][ C1] kernel_init+0x21/0x150 [ 8.629885][ C1] ret_from_fork+0x474/0x6b0 [ 8.629886][ C1] ret_from_fork_asm+0x11/0x20 [ 8.629887][ C1] } [ 8.629888][ C1] ... key at: [] __fs_reclaim_map+0x0/0xbe0 [ 8.629891][ C1] ... acquired at: [ 8.629892][ C1] __lock_acquire+0x518/0xc20 [ 8.629893][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629895][ C1] fs_reclaim_acquire+0xd5/0x120 [ 8.629896][ C1] __kmalloc_noprof+0xd3/0x760 [ 8.629897][ C1] alloc_buf.isra.0+0x4b/0x260 [ 8.629900][ C1] put_chars+0x1e1/0x2f0 [ 8.629901][ C1] hvc_console_print+0x292/0x780 [ 8.629904][ C1] console_emit_next_record+0x22f/0x4c0 [ 8.629905][ C1] console_flush_one_record+0x46f/0x710 [ 8.629907][ C1] console_unlock+0xee/0x1f0 [ 8.629908][ C1] vprintk_emit+0x37c/0x3e0 [ 8.629910][ C1] _printk+0xc7/0x100 [ 8.629913][ C1] dm_interface_init+0x50/0x60 [ 8.629916][ C1] dm_init+0x51/0xd0 [ 8.629917][ C1] do_one_initcall+0x124/0x4f0 [ 8.629919][ C1] kernel_init_freeable+0x596/0x630 [ 8.629920][ C1] kernel_init+0x21/0x150 [ 8.629921][ C1] ret_from_fork+0x474/0x6b0 [ 8.629923][ C1] ret_from_fork_asm+0x11/0x20 [ 8.629924][ C1] [ 8.629924][ C1] -> (console_owner){..-.}-{0:0} { [ 8.629926][ C1] IN-SOFTIRQ-W at: [ 8.629926][ C1] __lock_acquire+0x388/0xc20 [ 8.629928][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629929][ C1] console_lock_spinning_enable+0x5c/0x60 [ 8.629930][ C1] console_emit_next_record+0x1d1/0x4c0 [ 8.629932][ C1] console_flush_one_record+0x46f/0x710 [ 8.629933][ C1] console_unlock+0xee/0x1f0 [ 8.629935][ C1] vprintk_emit+0x37c/0x3e0 [ 8.629937][ C1] _printk+0xc7/0x100 [ 8.629938][ C1] tcp_make_synack.cold+0x36/0xb6 [ 8.629941][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 8.629942][ C1] tcp_conn_request+0x1f15/0x2d20 [ 8.629943][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.629945][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.629946][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 8.629947][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 8.629949][ C1] ip6_input_finish+0x196/0x590 [ 8.629950][ C1] ip6_input+0x130/0x570 [ 8.629951][ C1] ipv6_rcv+0x3c1/0x5a0 [ 8.629953][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 8.629955][ C1] process_backlog+0x431/0x14c0 [ 8.629956][ C1] __napi_poll+0xa7/0x3b0 [ 8.629958][ C1] net_rx_action+0x513/0xf50 [ 8.629959][ C1] handle_softirqs+0x1d3/0x900 [ 8.629962][ C1] do_softirq+0xac/0xe0 [ 8.629963][ C1] __local_bh_enable_ip+0x118/0x150 [ 8.629964][ C1] __dev_queue_xmit+0x979/0x1b80 [ 8.629966][ C1] ip6_finish_output2+0x96f/0x12a0 [ 8.629967][ C1] ip6_finish_output+0x646/0xda0 [ 8.629969][ C1] ip6_output+0x23f/0x7f0 [ 8.629970][ C1] ip6_xmit+0xc44/0x1ec0 [ 8.629971][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 8.629972][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.629974][ C1] tcp_connect+0x1024/0x1e20 [ 8.629975][ C1] tcp_v6_connect+0x148b/0x2380 [ 8.629976][ C1] __inet_stream_connect+0x2ed/0xd00 [ 8.629977][ C1] inet_stream_connect+0x59/0xb0 [ 8.629978][ C1] __sys_connect+0x1cf/0x2e0 [ 8.629981][ C1] __x64_sys_connect+0x72/0xd0 [ 8.629982][ C1] do_syscall_64+0xff/0x530 [ 8.629985][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.629986][ C1] INITIAL USE at: [ 8.629987][ C1] } [ 8.629987][ C1] ... key at: [] console_owner_dep_map+0x0/0x60 [ 8.629991][ C1] ... acquired at: [ 8.629991][ C1] mark_lock+0x1d7/0xa00 [ 8.629993][ C1] mark_usage+0x42/0x170 [ 8.629994][ C1] __lock_acquire+0x388/0xc20 [ 8.629995][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.629996][ C1] console_lock_spinning_enable+0x5c/0x60 [ 8.629998][ C1] console_emit_next_record+0x1d1/0x4c0 [ 8.629999][ C1] console_flush_one_record+0x46f/0x710 [ 8.630001][ C1] console_unlock+0xee/0x1f0 [ 8.630002][ C1] vprintk_emit+0x37c/0x3e0 [ 8.630004][ C1] _printk+0xc7/0x100 [ 8.630005][ C1] tcp_make_synack.cold+0x36/0xb6 [ 8.630006][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 8.630007][ C1] tcp_conn_request+0x1f15/0x2d20 [ 8.630009][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.630010][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.630012][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 8.630013][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 8.630014][ C1] ip6_input_finish+0x196/0x590 [ 8.630015][ C1] ip6_input+0x130/0x570 [ 8.630017][ C1] ipv6_rcv+0x3c1/0x5a0 [ 8.630018][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 8.630020][ C1] process_backlog+0x431/0x14c0 [ 8.630021][ C1] __napi_poll+0xa7/0x3b0 [ 8.630023][ C1] net_rx_action+0x513/0xf50 [ 8.630024][ C1] handle_softirqs+0x1d3/0x900 [ 8.630026][ C1] do_softirq+0xac/0xe0 [ 8.630027][ C1] __local_bh_enable_ip+0x118/0x150 [ 8.630028][ C1] __dev_queue_xmit+0x979/0x1b80 [ 8.630029][ C1] ip6_finish_output2+0x96f/0x12a0 [ 8.630031][ C1] ip6_finish_output+0x646/0xda0 [ 8.630032][ C1] ip6_output+0x23f/0x7f0 [ 8.630033][ C1] ip6_xmit+0xc44/0x1ec0 [ 8.630034][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 8.630036][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.630037][ C1] tcp_connect+0x1024/0x1e20 [ 8.630038][ C1] tcp_v6_connect+0x148b/0x2380 [ 8.630039][ C1] __inet_stream_connect+0x2ed/0xd00 [ 8.630040][ C1] inet_stream_connect+0x59/0xb0 [ 8.630041][ C1] __sys_connect+0x1cf/0x2e0 [ 8.630043][ C1] __x64_sys_connect+0x72/0xd0 [ 8.630044][ C1] do_syscall_64+0xff/0x530 [ 8.630046][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.630047][ C1] [ 8.630047][ C1] [ 8.630047][ C1] stack backtrace: [ 8.630050][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.630053][ C1] Tainted: [W]=WARN [ 8.630054][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.630055][ C1] Call Trace: [ 8.630056][ C1] [ 8.630057][ C1] dump_stack_lvl+0x6f/0xa0 [ 8.630061][ C1] print_irq_inversion_bug.part.0.cold+0xe6/0x143 [ 8.630063][ C1] mark_lock_irq+0x989/0x9c0 [ 8.630066][ C1] mark_lock+0x1d7/0xa00 [ 8.630068][ C1] mark_usage+0x42/0x170 [ 8.630069][ C1] __lock_acquire+0x388/0xc20 [ 8.630071][ C1] lock_acquire.part.0+0xd4/0x280 [ 8.630073][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 8.630075][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630078][ C1] ? lock_acquire+0x13c/0x160 [ 8.630080][ C1] console_lock_spinning_enable+0x5c/0x60 [ 8.630082][ C1] ? console_lock_spinning_enable+0x40/0x60 [ 8.630083][ C1] console_emit_next_record+0x1d1/0x4c0 [ 8.630086][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 8.630087][ C1] ? console_flush_one_record+0x106/0x710 [ 8.630089][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630091][ C1] ? lock_acquire+0x13c/0x160 [ 8.630093][ C1] console_flush_one_record+0x46f/0x710 [ 8.630095][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 8.630096][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630098][ C1] console_unlock+0xee/0x1f0 [ 8.630100][ C1] ? console_flush_one_record+0x710/0x710 [ 8.630102][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630103][ C1] ? lock_acquire+0x60/0x160 [ 8.630105][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.630107][ C1] ? vprintk_emit+0x320/0x3e0 [ 8.630109][ C1] vprintk_emit+0x37c/0x3e0 [ 8.630111][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 8.630113][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630115][ C1] _printk+0xc7/0x100 [ 8.630116][ C1] ? snapshot_read.cold+0x21/0x21 [ 8.630118][ C1] ? ___ratelimit+0x4e7/0xa00 [ 8.630121][ C1] ? idr_get_free+0x830/0x830 [ 8.630123][ C1] tcp_make_synack.cold+0x36/0xb6 [ 8.630125][ C1] ? tcp_send_synack+0x1570/0x1570 [ 8.630127][ C1] ? add_timer_on+0x580/0x580 [ 8.630130][ C1] ? lockdep_init_map_type+0x5d/0x250 [ 8.630131][ C1] ? timer_init_key+0x10d/0x280 [ 8.630133][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 8.630135][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 8.630136][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x10/0x160 [ 8.630139][ C1] ? tcp_v6_route_req+0x501/0x640 [ 8.630140][ C1] tcp_conn_request+0x1f15/0x2d20 [ 8.630142][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.630146][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.630147][ C1] ? mark_usage+0x61/0x170 [ 8.630149][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630151][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630152][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630154][ C1] ? down_read_nested+0xe7/0x500 [ 8.630157][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.630159][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.630161][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.630162][ C1] ? tcp_v6_fill_cb+0x33/0x440 [ 8.630164][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 8.630166][ C1] ? tcp_v6_syn_recv_sock+0x1be0/0x1be0 [ 8.630168][ C1] ? ipv6_raw_deliver+0x35f/0x930 [ 8.630170][ C1] ? ipv6_raw_deliver+0x369/0x930 [ 8.630173][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 8.630176][ C1] ip6_input_finish+0x196/0x590 [ 8.630177][ C1] ip6_input+0x130/0x570 [ 8.630179][ C1] ? ip6_input_finish+0x590/0x590 [ 8.630181][ C1] ? ip6_rcv_core+0xe22/0x1be0 [ 8.630183][ C1] ipv6_rcv+0x3c1/0x5a0 [ 8.630185][ C1] ? ip6_rcv_core+0x1be0/0x1be0 [ 8.630186][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.630188][ C1] ? mark_usage+0x61/0x170 [ 8.630190][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630191][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.630194][ C1] ? process_backlog+0x3f1/0x14c0 [ 8.630195][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 8.630197][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630204][ C1] ? process_backlog+0x3f1/0x14c0 [ 8.630205][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.630207][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630210][ C1] process_backlog+0x431/0x14c0 [ 8.630212][ C1] __napi_poll+0xa7/0x3b0 [ 8.630214][ C1] net_rx_action+0x513/0xf50 [ 8.630217][ C1] ? __napi_poll+0x3b0/0x3b0 [ 8.630219][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630221][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630223][ C1] ? clockevents_program_event+0x307/0x7e0 [ 8.630226][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630227][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630229][ C1] ? mark_held_locks+0x40/0x70 [ 8.630231][ C1] handle_softirqs+0x1d3/0x900 [ 8.630233][ C1] ? _local_bh_enable+0xc0/0xc0 [ 8.630234][ C1] ? _local_bh_enable+0xc0/0xc0 [ 8.630236][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 8.630238][ C1] do_softirq+0xac/0xe0 [ 8.630239][ C1] [ 8.630239][ C1] [ 8.630240][ C1] __local_bh_enable_ip+0x118/0x150 [ 8.630241][ C1] __dev_queue_xmit+0x979/0x1b80 [ 8.630244][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.630246][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630248][ C1] ? find_held_lock+0x2b/0x80 [ 8.630249][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630250][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630252][ C1] ? mark_held_locks+0x40/0x70 [ 8.630254][ C1] ? __asan_memcpy+0x3c/0x60 [ 8.630256][ C1] ? neigh_hh_output+0x152/0x4c0 [ 8.630258][ C1] ip6_finish_output2+0x96f/0x12a0 [ 8.630260][ C1] ? ip6_dst_lookup+0x80/0x80 [ 8.630261][ C1] ? find_held_lock+0x2b/0x80 [ 8.630263][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630264][ C1] ? ip6_mtu+0x15d/0x310 [ 8.630267][ C1] ip6_finish_output+0x646/0xda0 [ 8.630269][ C1] ip6_output+0x23f/0x7f0 [ 8.630271][ C1] ? ip6_finish_output+0xda0/0xda0 [ 8.630272][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630274][ C1] ? find_held_lock+0x2b/0x80 [ 8.630275][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630277][ C1] ip6_xmit+0xc44/0x1ec0 [ 8.630278][ C1] ? mark_usage+0x61/0x170 [ 8.630280][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630282][ C1] ? ip6_autoflowlabel+0x120/0x120 [ 8.630283][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630285][ C1] ? mark_usage+0x61/0x170 [ 8.630286][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630288][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630290][ C1] ? inet6_csk_xmit+0xfe/0x5f0 [ 8.630291][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630293][ C1] ? lock_acquire+0x13c/0x160 [ 8.630295][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 8.630297][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.630299][ C1] ? __tcp_select_window+0xf20/0xf20 [ 8.630301][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630303][ C1] ? ktime_get+0x18e/0x2d0 [ 8.630305][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 8.630308][ C1] ? ktime_get+0x1dd/0x2d0 [ 8.630309][ C1] tcp_connect+0x1024/0x1e20 [ 8.630311][ C1] ? inet6_hash_connect+0xca/0x170 [ 8.630313][ C1] tcp_v6_connect+0x148b/0x2380 [ 8.630315][ C1] ? inet6_sk_rx_dst_set+0x230/0x230 [ 8.630317][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630318][ C1] ? do_raw_spin_lock+0x131/0x280 [ 8.630320][ C1] ? find_held_lock+0x2b/0x80 [ 8.630322][ C1] __inet_stream_connect+0x2ed/0xd00 [ 8.630323][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630325][ C1] inet_stream_connect+0x59/0xb0 [ 8.630326][ C1] __sys_connect+0x1cf/0x2e0 [ 8.630328][ C1] ? do_fcntl+0x36f/0xc50 [ 8.630331][ C1] ? __sys_connect_file+0x250/0x250 [ 8.630334][ C1] ? fput+0x1f/0xa0 [ 8.630336][ C1] __x64_sys_connect+0x72/0xd0 [ 8.630337][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630339][ C1] ? do_syscall_64+0xa6/0x530 [ 8.630340][ C1] do_syscall_64+0xff/0x530 [ 8.630341][ C1] ? irq_exit_rcu+0x1a/0x30 [ 8.630343][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.630344][ C1] RIP: 0033:0x7f97db0e7312 [ 8.630348][ 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 [ 8.630349][ C1] RSP: 002b:00007f97da864968 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.630352][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007f97db0e7312 [ 8.630353][ C1] RDX: 000000000000001c RSI: 00007f97da864c30 RDI: 0000000000000009 [ 8.630354][ C1] RBP: 00007f97da864990 R08: 0000000000000000 R09: 0000000000000000 [ 8.630355][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f97da864c30 [ 8.630356][ C1] R13: 000000000000001c R14: 0000000000000001 R15: 0000000000412230 [ 8.630358][ C1] [ 8.630362][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 8.630363][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 169, name: connect-deny_ip [ 8.630365][ C1] preempt_count: 302, expected: 0 [ 8.630365][ C1] RCU nest depth: 6, expected: 0 [ 8.630366][ C1] INFO: lockdep is turned off. [ 8.630367][ C1] irq event stamp: 10109 [ 8.630367][ C1] hardirqs last enabled at (10108): [] __down_trylock_console_sem+0x86/0xa0 [ 8.630369][ C1] hardirqs last disabled at (10109): [] console_emit_next_record+0x3d4/0x4c0 [ 8.630371][ C1] softirqs last enabled at (9932): [] __dev_queue_xmit+0x964/0x1b80 [ 8.630373][ C1] softirqs last disabled at (9933): [] do_softirq+0xac/0xe0 [ 8.630375][ C1] Preemption disabled at: [ 8.630375][ C1] [] __dev_queue_xmit+0x204/0x1b80 [ 8.630378][ C1] CPU: 1 UID: 0 PID: 169 Comm: connect-deny_ip Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 8.630380][ C1] Tainted: [W]=WARN [ 8.630381][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 8.630381][ C1] Call Trace: [ 8.630382][ C1] [ 8.630383][ C1] dump_stack_lvl+0x6f/0xa0 [ 8.630385][ C1] ? __dev_queue_xmit+0x204/0x1b80 [ 8.630386][ C1] __might_resched.cold+0x1fe/0x2c1 [ 8.630389][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 8.630392][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630394][ C1] __kmalloc_noprof+0x443/0x760 [ 8.630395][ C1] ? __rwlock_init+0x150/0x150 [ 8.630397][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 8.630399][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 8.630400][ C1] alloc_buf.isra.0+0x4b/0x260 [ 8.630402][ C1] put_chars+0x1e1/0x2f0 [ 8.630404][ C1] ? __send_to_port+0x420/0x420 [ 8.630406][ C1] hvc_console_print+0x292/0x780 [ 8.630408][ C1] ? __lock_acquire+0x388/0xc20 [ 8.630410][ C1] ? hvc_write+0x3a0/0x3a0 [ 8.630412][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630414][ C1] ? lock_acquire+0x13c/0x160 [ 8.630415][ C1] console_emit_next_record+0x22f/0x4c0 [ 8.630418][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 8.630419][ C1] ? console_flush_one_record+0x106/0x710 [ 8.630421][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630423][ C1] ? lock_acquire+0x13c/0x160 [ 8.630424][ C1] console_flush_one_record+0x46f/0x710 [ 8.630430][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 8.630431][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630433][ C1] console_unlock+0xee/0x1f0 [ 8.630435][ C1] ? console_flush_one_record+0x710/0x710 [ 8.630437][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630438][ C1] ? lock_acquire+0x60/0x160 [ 8.630440][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 8.630442][ C1] ? vprintk_emit+0x320/0x3e0 [ 8.630444][ C1] vprintk_emit+0x37c/0x3e0 [ 8.630446][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 8.630447][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630449][ C1] _printk+0xc7/0x100 [ 8.630451][ C1] ? snapshot_read.cold+0x21/0x21 [ 8.630453][ C1] ? ___ratelimit+0x4e7/0xa00 [ 8.630454][ C1] ? idr_get_free+0x830/0x830 [ 8.630456][ C1] tcp_make_synack.cold+0x36/0xb6 [ 8.630459][ C1] ? tcp_send_synack+0x1570/0x1570 [ 8.630461][ C1] ? add_timer_on+0x580/0x580 [ 8.630463][ C1] ? lockdep_init_map_type+0x5d/0x250 [ 8.630464][ C1] ? timer_init_key+0x10d/0x280 [ 8.630466][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 8.630468][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 8.630469][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x10/0x160 [ 8.630471][ C1] ? tcp_v6_route_req+0x501/0x640 [ 8.630473][ C1] tcp_conn_request+0x1f15/0x2d20 [ 8.630475][ C1] ? tcp_ao_calc_traffic_key+0x2a0/0x2a0 [ 8.630477][ C1] ? tcp_get_syncookie_mss+0x300/0x300 [ 8.630479][ C1] ? mark_usage+0x61/0x170 [ 8.630480][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630482][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630484][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630485][ C1] ? down_read_nested+0xe7/0x500 [ 8.630488][ C1] ? tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.630490][ C1] tcp_rcv_listen_state_process+0x1ab/0x380 [ 8.630492][ C1] tcp_v6_rcv_listen.constprop.0.isra.0+0x13f/0x4f0 [ 8.630493][ C1] ? tcp_v6_fill_cb+0x33/0x440 [ 8.630494][ C1] tcp_v6_rcv+0x2806/0x2dd0 [ 8.630497][ C1] ? tcp_v6_syn_recv_sock+0x1be0/0x1be0 [ 8.630498][ C1] ? ipv6_raw_deliver+0x35f/0x930 [ 8.630500][ C1] ? ipv6_raw_deliver+0x369/0x930 [ 8.630502][ C1] ip6_protocol_deliver_rcu+0x15c/0x1480 [ 8.630505][ C1] ip6_input_finish+0x196/0x590 [ 8.630507][ C1] ip6_input+0x130/0x570 [ 8.630509][ C1] ? ip6_input_finish+0x590/0x590 [ 8.630510][ C1] ? ip6_rcv_core+0xe22/0x1be0 [ 8.630513][ C1] ipv6_rcv+0x3c1/0x5a0 [ 8.630514][ C1] ? ip6_rcv_core+0x1be0/0x1be0 [ 8.630516][ C1] ? rcu_read_lock_any_held+0x3c/0x90 [ 8.630517][ C1] ? mark_usage+0x61/0x170 [ 8.630519][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630520][ C1] ? trace_raw_output_rcu_invoke_kfree_bulk_callback+0x57/0x130 [ 8.630522][ C1] ? process_backlog+0x3f1/0x14c0 [ 8.630524][ C1] __netif_receive_skb_one_core+0xfc/0x180 [ 8.630525][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630527][ C1] ? process_backlog+0x3f1/0x14c0 [ 8.630529][ C1] ? __netif_receive_skb_list_core+0x9e0/0x9e0 [ 8.630530][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630533][ C1] process_backlog+0x431/0x14c0 [ 8.630535][ C1] __napi_poll+0xa7/0x3b0 [ 8.630537][ C1] net_rx_action+0x513/0xf50 [ 8.630540][ C1] ? __napi_poll+0x3b0/0x3b0 [ 8.630542][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630544][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630546][ C1] ? clockevents_program_event+0x307/0x7e0 [ 8.630548][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630549][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630551][ C1] ? mark_held_locks+0x40/0x70 [ 8.630553][ C1] handle_softirqs+0x1d3/0x900 [ 8.630554][ C1] ? _local_bh_enable+0xc0/0xc0 [ 8.630556][ C1] ? _local_bh_enable+0xc0/0xc0 [ 8.630557][ C1] ? __dev_queue_xmit+0x964/0x1b80 [ 8.630559][ C1] do_softirq+0xac/0xe0 [ 8.630561][ C1] [ 8.630561][ C1] [ 8.630562][ C1] __local_bh_enable_ip+0x118/0x150 [ 8.630563][ C1] __dev_queue_xmit+0x979/0x1b80 [ 8.630566][ C1] ? netdev_core_pick_tx+0x2c0/0x2c0 [ 8.630568][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630569][ C1] ? find_held_lock+0x2b/0x80 [ 8.630570][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630572][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630573][ C1] ? mark_held_locks+0x40/0x70 [ 8.630575][ C1] ? __asan_memcpy+0x3c/0x60 [ 8.630576][ C1] ? neigh_hh_output+0x152/0x4c0 [ 8.630578][ C1] ip6_finish_output2+0x96f/0x12a0 [ 8.630580][ C1] ? ip6_dst_lookup+0x80/0x80 [ 8.630582][ C1] ? find_held_lock+0x2b/0x80 [ 8.630583][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630585][ C1] ? ip6_mtu+0x15d/0x310 [ 8.630586][ C1] ip6_finish_output+0x646/0xda0 [ 8.630588][ C1] ip6_output+0x23f/0x7f0 [ 8.630590][ C1] ? ip6_finish_output+0xda0/0xda0 [ 8.630591][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630593][ C1] ? find_held_lock+0x2b/0x80 [ 8.630594][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630596][ C1] ip6_xmit+0xc44/0x1ec0 [ 8.630598][ C1] ? mark_usage+0x61/0x170 [ 8.630599][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630601][ C1] ? ip6_autoflowlabel+0x120/0x120 [ 8.630603][ C1] ? __lock_release.isra.0+0x69/0x1a0 [ 8.630604][ C1] ? mark_usage+0x61/0x170 [ 8.630605][ C1] ? __lock_acquire+0x518/0xc20 [ 8.630607][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630609][ C1] ? inet6_csk_xmit+0xfe/0x5f0 [ 8.630610][ C1] ? rcu_is_watching+0x16/0xd0 [ 8.630612][ C1] ? lock_acquire+0x13c/0x160 [ 8.630614][ C1] inet6_csk_xmit+0x2f6/0x5f0 [ 8.630616][ C1] __tcp_transmit_skb+0x1b6e/0x3c10 [ 8.630618][ C1] ? __tcp_select_window+0xf20/0xf20 [ 8.630620][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630622][ C1] ? ktime_get+0x18e/0x2d0 [ 8.630623][ C1] ? kvm_clock_get_cycles+0x19/0x30 [ 8.630624][ C1] ? ktime_get+0x1dd/0x2d0 [ 8.630626][ C1] tcp_connect+0x1024/0x1e20 [ 8.630628][ C1] ? inet6_hash_connect+0xca/0x170 [ 8.630629][ C1] tcp_v6_connect+0x148b/0x2380 [ 8.630631][ C1] ? inet6_sk_rx_dst_set+0x230/0x230 [ 8.630633][ C1] ? lock_acquire.part.0+0xd4/0x280 [ 8.630634][ C1] ? do_raw_spin_lock+0x131/0x280 [ 8.630636][ C1] ? find_held_lock+0x2b/0x80 [ 8.630637][ C1] __inet_stream_connect+0x2ed/0xd00 [ 8.630639][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630640][ C1] inet_stream_connect+0x59/0xb0 [ 8.630642][ C1] __sys_connect+0x1cf/0x2e0 [ 8.630643][ C1] ? do_fcntl+0x36f/0xc50 [ 8.630645][ C1] ? __sys_connect_file+0x250/0x250 [ 8.630648][ C1] ? fput+0x1f/0xa0 [ 8.630649][ C1] __x64_sys_connect+0x72/0xd0 [ 8.630651][ C1] ? lockdep_hardirqs_on+0x91/0x130 [ 8.630652][ C1] ? do_syscall_64+0xa6/0x530 [ 8.630653][ C1] do_syscall_64+0xff/0x530 [ 8.630655][ C1] ? irq_exit_rcu+0x1a/0x30 [ 8.630656][ C1] entry_SYSCALL_64_after_hwframe+0x4b/0x53 [ 8.630658][ C1] RIP: 0033:0x7f97db0e7312 [ 8.630659][ 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 [ 8.630660][ C1] RSP: 002b:00007f97da864968 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 8.630661][ C1] RAX: ffffffffffffffda RBX: 0000000000000009 RCX: 00007f97db0e7312 [ 8.630662][ C1] RDX: 000000000000001c RSI: 00007f97da864c30 RDI: 0000000000000009 [ 8.630663][ C1] RBP: 00007f97da864990 R08: 0000000000000000 R09: 0000000000000000 [ 8.630663][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f97da864c30 [ 8.630664][ C1] R13: 000000000000001c R14: 0000000000000001 R15: 0000000000412230 [ 8.630666][ C1] [ 9.639473][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 9.639478][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 9.639480][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 9.639481][ C1] preempt_count: 102, expected: 0 [ 9.639482][ C1] RCU nest depth: 0, expected: 0 [ 9.639483][ C1] INFO: lockdep is turned off. [ 9.639483][ C1] irq event stamp: 264516 [ 9.639484][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 9.639490][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 9.639492][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 9.639495][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 9.639496][ C1] Preemption disabled at: [ 9.639497][ C1] [<0000000000000000>] 0x0 [ 9.639501][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 9.639504][ C1] Tainted: [W]=WARN [ 9.639505][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.639506][ C1] Call Trace: [ 9.639507][ C1] [ 9.639508][ C1] dump_stack_lvl+0x6f/0xa0 [ 9.639513][ C1] __might_resched.cold+0x1fe/0x2c1 [ 9.639516][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 9.639519][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639523][ C1] __kmalloc_noprof+0x443/0x760 [ 9.639526][ C1] ? __rwlock_init+0x150/0x150 [ 9.639528][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 9.639531][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.639533][ C1] alloc_buf.isra.0+0x4b/0x260 [ 9.639535][ C1] put_chars+0x1e1/0x2f0 [ 9.639537][ C1] ? __send_to_port+0x420/0x420 [ 9.639538][ C1] ? printk_get_next_message+0x240/0x650 [ 9.639541][ C1] ? console_prepend_replay+0x20/0x20 [ 9.639543][ C1] hvc_console_print+0x292/0x780 [ 9.639546][ C1] ? hvc_write+0x3a0/0x3a0 [ 9.639548][ C1] ? __rwlock_init+0x150/0x150 [ 9.639549][ C1] ? lock_acquire+0x13c/0x160 [ 9.639551][ C1] console_emit_next_record+0x22f/0x4c0 [ 9.639554][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 9.639556][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639557][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639559][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639560][ C1] ? lock_acquire+0x13c/0x160 [ 9.639562][ C1] ? console_flush_one_record+0x111/0x710 [ 9.639564][ C1] console_flush_one_record+0x46f/0x710 [ 9.639566][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 9.639568][ C1] console_unlock+0xee/0x1f0 [ 9.639570][ C1] ? lock_acquire+0x13c/0x160 [ 9.639572][ C1] ? console_flush_one_record+0x710/0x710 [ 9.639573][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639575][ C1] ? lock_release+0x184/0x1f0 [ 9.639576][ C1] ? lock_acquire+0x60/0x160 [ 9.639577][ C1] ? __rcu_read_lock+0x30/0x70 [ 9.639580][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 9.639581][ C1] ? vprintk_emit+0x320/0x3e0 [ 9.639583][ C1] vprintk_emit+0x37c/0x3e0 [ 9.639585][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 9.639587][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 9.639589][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639590][ C1] ? lock_acquire+0x13c/0x160 [ 9.639592][ C1] _printk+0xc7/0x100 [ 9.639594][ C1] ? snapshot_read.cold+0x21/0x21 [ 9.639596][ C1] ? ___ratelimit+0x4e7/0xa00 [ 9.639598][ C1] ? trace_hardirqs_on+0x36/0x40 [ 9.639601][ C1] ? idr_get_free+0x830/0x830 [ 9.639602][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 9.639604][ C1] tcp_make_synack.cold+0x36/0xb6 [ 9.639608][ C1] ? tcp_send_synack+0x1570/0x1570 [ 9.639610][ C1] ? lock_release+0x184/0x1f0 [ 9.639612][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 9.639616][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 9.639617][ C1] ? lock_acquire+0x13c/0x160 [ 9.639619][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 9.639620][ C1] ? trace_hardirqs_on+0x36/0x40 [ 9.639621][ C1] ? get_random_u16+0x740/0x740 [ 9.639624][ C1] tcp_rtx_synack+0x150/0x440 [ 9.639625][ C1] ? trace_pelt_cfs_tp+0x9b/0x190 [ 9.639628][ C1] ? tcp_send_probe0+0x590/0x590 [ 9.639629][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 9.639632][ C1] ? update_cfs_rq_load_avg+0x4b/0x660 [ 9.639634][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 9.639637][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.639638][ C1] ? lock_acquire+0x6a/0x160 [ 9.639640][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 9.639641][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.639643][ C1] call_timer_fn+0x160/0x4d0 [ 9.639645][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 9.639647][ C1] ? debug_object_active_state+0x430/0x430 [ 9.639651][ C1] ? trace_sched_wakeup+0x9b/0x160 [ 9.639653][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 9.639655][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639657][ C1] __run_timers+0x68f/0xaa0 [ 9.639658][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 9.639660][ C1] ? debug_object_deactivate+0x2f7/0x440 [ 9.639662][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 9.639664][ C1] ? do_raw_spin_lock+0x131/0x280 [ 9.639667][ C1] ? __rwlock_init+0x150/0x150 [ 9.639669][ C1] run_timer_softirq+0xf0/0x160 [ 9.639671][ C1] ? __run_timers+0xaa0/0xaa0 [ 9.639672][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.639674][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639675][ C1] handle_softirqs+0x1d3/0x900 [ 9.639677][ C1] ? _local_bh_enable+0xc0/0xc0 [ 9.639679][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639680][ C1] ? lock_release+0x184/0x1f0 [ 9.639682][ C1] __irq_exit_rcu+0x145/0x1c0 [ 9.639683][ C1] irq_exit_rcu+0xe/0x30 [ 9.639685][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 9.639687][ C1] [ 9.639687][ C1] [ 9.639688][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 9.639690][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 9.639692][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 9.639694][ C1] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 9.639695][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 9.639697][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 9.639698][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 9.639699][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 9.639700][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 9.639700][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 9.639702][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 9.639703][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.639705][ C1] default_idle+0x9/0x10 [ 9.639706][ C1] default_idle_call+0x6e/0xb0 [ 9.639708][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 9.639709][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 9.639711][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 9.639713][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 9.639714][ C1] ? rcu_is_watching+0x16/0xd0 [ 9.639716][ C1] do_idle+0xd8/0x190 [ 9.639718][ C1] cpu_startup_entry+0x53/0x70 [ 9.639719][ C1] start_secondary+0x204/0x2b0 [ 9.639721][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 9.639723][ C1] common_startup_64+0x13e/0x148 [ 9.639727][ C1] [ 9.766699][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.791473][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 10.791479][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 10.791481][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 10.791482][ C1] preempt_count: 102, expected: 0 [ 10.791483][ C1] RCU nest depth: 0, expected: 0 [ 10.791484][ C1] INFO: lockdep is turned off. [ 10.791485][ C1] irq event stamp: 264516 [ 10.791486][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 10.791492][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 10.791494][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 10.791497][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 10.791499][ C1] Preemption disabled at: [ 10.791500][ C1] [<0000000000000000>] 0x0 [ 10.791504][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 10.791507][ C1] Tainted: [W]=WARN [ 10.791508][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.791509][ C1] Call Trace: [ 10.791510][ C1] [ 10.791511][ C1] dump_stack_lvl+0x6f/0xa0 [ 10.791516][ C1] __might_resched.cold+0x1fe/0x2c1 [ 10.791519][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 10.791522][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791526][ C1] __kmalloc_noprof+0x443/0x760 [ 10.791529][ C1] ? __rwlock_init+0x150/0x150 [ 10.791531][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 10.791534][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.791536][ C1] alloc_buf.isra.0+0x4b/0x260 [ 10.791538][ C1] put_chars+0x1e1/0x2f0 [ 10.791540][ C1] ? __send_to_port+0x420/0x420 [ 10.791541][ C1] ? printk_get_next_message+0x240/0x650 [ 10.791544][ C1] ? console_prepend_replay+0x20/0x20 [ 10.791546][ C1] hvc_console_print+0x292/0x780 [ 10.791549][ C1] ? hvc_write+0x3a0/0x3a0 [ 10.791550][ C1] ? __rwlock_init+0x150/0x150 [ 10.791552][ C1] ? lock_acquire+0x13c/0x160 [ 10.791554][ C1] console_emit_next_record+0x22f/0x4c0 [ 10.791556][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 10.791558][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791560][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791561][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791563][ C1] ? lock_acquire+0x13c/0x160 [ 10.791565][ C1] ? console_flush_one_record+0x111/0x710 [ 10.791566][ C1] console_flush_one_record+0x46f/0x710 [ 10.791568][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 10.791571][ C1] console_unlock+0xee/0x1f0 [ 10.791573][ C1] ? lock_acquire+0x13c/0x160 [ 10.791574][ C1] ? console_flush_one_record+0x710/0x710 [ 10.791576][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791577][ C1] ? lock_release+0x184/0x1f0 [ 10.791579][ C1] ? lock_acquire+0x60/0x160 [ 10.791580][ C1] ? __rcu_read_lock+0x30/0x70 [ 10.791582][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 10.791584][ C1] ? vprintk_emit+0x320/0x3e0 [ 10.791586][ C1] vprintk_emit+0x37c/0x3e0 [ 10.791588][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 10.791590][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 10.791591][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791593][ C1] ? lock_acquire+0x13c/0x160 [ 10.791595][ C1] _printk+0xc7/0x100 [ 10.791597][ C1] ? snapshot_read.cold+0x21/0x21 [ 10.791598][ C1] ? ___ratelimit+0x4e7/0xa00 [ 10.791601][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.791603][ C1] ? idr_get_free+0x830/0x830 [ 10.791605][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 10.791607][ C1] tcp_make_synack.cold+0x36/0xb6 [ 10.791610][ C1] ? tcp_send_synack+0x1570/0x1570 [ 10.791613][ C1] ? lock_release+0x184/0x1f0 [ 10.791615][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 10.791617][ C1] ? sched_clock+0x11/0x30 [ 10.791619][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791622][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 10.791623][ C1] ? lock_acquire+0x13c/0x160 [ 10.791625][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 10.791626][ C1] ? trace_hardirqs_on+0x36/0x40 [ 10.791627][ C1] ? get_random_u16+0x740/0x740 [ 10.791630][ C1] tcp_rtx_synack+0x150/0x440 [ 10.791631][ C1] ? trace_pelt_cfs_tp+0x9b/0x190 [ 10.791634][ C1] ? tcp_send_probe0+0x590/0x590 [ 10.791635][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 10.791637][ C1] ? update_cfs_rq_load_avg+0x4b/0x660 [ 10.791639][ C1] ? do_raw_spin_lock+0x131/0x280 [ 10.791641][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 10.791644][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.791645][ C1] ? lock_acquire+0x6a/0x160 [ 10.791647][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 10.791648][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.791650][ C1] call_timer_fn+0x160/0x4d0 [ 10.791652][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 10.791654][ C1] ? debug_object_active_state+0x430/0x430 [ 10.791658][ C1] ? trace_sched_wakeup+0x9b/0x160 [ 10.791659][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 10.791661][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791663][ C1] __run_timers+0x68f/0xaa0 [ 10.791665][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 10.791666][ C1] ? debug_object_deactivate+0x2f7/0x440 [ 10.791668][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 10.791671][ C1] ? do_raw_spin_lock+0x131/0x280 [ 10.791673][ C1] ? __rwlock_init+0x150/0x150 [ 10.791675][ C1] run_timer_softirq+0xf0/0x160 [ 10.791677][ C1] ? __run_timers+0xaa0/0xaa0 [ 10.791679][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.791680][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791682][ C1] handle_softirqs+0x1d3/0x900 [ 10.791684][ C1] ? _local_bh_enable+0xc0/0xc0 [ 10.791685][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791687][ C1] ? lock_release+0x184/0x1f0 [ 10.791688][ C1] __irq_exit_rcu+0x145/0x1c0 [ 10.791690][ C1] irq_exit_rcu+0xe/0x30 [ 10.791691][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 10.791693][ C1] [ 10.791694][ C1] [ 10.791694][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 10.791696][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 10.791698][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 10.791700][ C1] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 10.791701][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 10.791704][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 10.791705][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 10.791706][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 10.791706][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 10.791707][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 10.791709][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 10.791710][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.791712][ C1] default_idle+0x9/0x10 [ 10.791714][ C1] default_idle_call+0x6e/0xb0 [ 10.791715][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 10.791716][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 10.791718][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 10.791720][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 10.791721][ C1] ? rcu_is_watching+0x16/0xd0 [ 10.791723][ C1] do_idle+0xd8/0x190 [ 10.791725][ C1] cpu_startup_entry+0x53/0x70 [ 10.791726][ C1] start_secondary+0x204/0x2b0 [ 10.791728][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 10.791730][ C1] common_startup_64+0x13e/0x148 [ 10.791733][ C1] [ 10.815945][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.878465][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 11.878469][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 11.878471][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 11.878472][ C1] preempt_count: 102, expected: 0 [ 11.878473][ C1] RCU nest depth: 0, expected: 0 [ 11.878473][ C1] INFO: lockdep is turned off. [ 11.878474][ C1] irq event stamp: 264516 [ 11.878475][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 11.878479][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 11.878481][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 11.878483][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 11.878485][ C1] Preemption disabled at: [ 11.878486][ C1] [<0000000000000000>] 0x0 [ 11.878489][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 11.878492][ C1] Tainted: [W]=WARN [ 11.878493][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 11.878494][ C1] Call Trace: [ 11.878495][ C1] [ 11.878496][ C1] dump_stack_lvl+0x6f/0xa0 [ 11.878500][ C1] __might_resched.cold+0x1fe/0x2c1 [ 11.878503][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 11.878506][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878509][ C1] __kmalloc_noprof+0x443/0x760 [ 11.878512][ C1] ? __rwlock_init+0x150/0x150 [ 11.878514][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 11.878517][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.878518][ C1] alloc_buf.isra.0+0x4b/0x260 [ 11.878520][ C1] put_chars+0x1e1/0x2f0 [ 11.878522][ C1] ? __send_to_port+0x420/0x420 [ 11.878523][ C1] ? printk_get_next_message+0x240/0x650 [ 11.878526][ C1] ? console_prepend_replay+0x20/0x20 [ 11.878528][ C1] hvc_console_print+0x292/0x780 [ 11.878531][ C1] ? hvc_write+0x3a0/0x3a0 [ 11.878532][ C1] ? __rwlock_init+0x150/0x150 [ 11.878534][ C1] ? lock_acquire+0x13c/0x160 [ 11.878536][ C1] console_emit_next_record+0x22f/0x4c0 [ 11.878538][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 11.878540][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878542][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878543][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878545][ C1] ? lock_acquire+0x13c/0x160 [ 11.878547][ C1] ? console_flush_one_record+0x111/0x710 [ 11.878548][ C1] console_flush_one_record+0x46f/0x710 [ 11.878550][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 11.878553][ C1] console_unlock+0xee/0x1f0 [ 11.878555][ C1] ? lock_acquire+0x13c/0x160 [ 11.878556][ C1] ? console_flush_one_record+0x710/0x710 [ 11.878558][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878559][ C1] ? lock_release+0x184/0x1f0 [ 11.878561][ C1] ? lock_acquire+0x60/0x160 [ 11.878562][ C1] ? __rcu_read_lock+0x30/0x70 [ 11.878564][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 11.878566][ C1] ? vprintk_emit+0x320/0x3e0 [ 11.878568][ C1] vprintk_emit+0x37c/0x3e0 [ 11.878570][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 11.878571][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 11.878573][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878575][ C1] ? lock_acquire+0x13c/0x160 [ 11.878577][ C1] _printk+0xc7/0x100 [ 11.878579][ C1] ? snapshot_read.cold+0x21/0x21 [ 11.878580][ C1] ? ___ratelimit+0x4e7/0xa00 [ 11.878582][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.878584][ C1] ? idr_get_free+0x830/0x830 [ 11.878586][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 11.878588][ C1] tcp_make_synack.cold+0x36/0xb6 [ 11.878591][ C1] ? tcp_send_synack+0x1570/0x1570 [ 11.878593][ C1] ? lock_release+0x184/0x1f0 [ 11.878595][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 11.878597][ C1] ? sched_clock+0x11/0x30 [ 11.878599][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878601][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 11.878602][ C1] ? lock_acquire+0x13c/0x160 [ 11.878604][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 11.878605][ C1] ? trace_hardirqs_on+0x36/0x40 [ 11.878607][ C1] ? get_random_u16+0x740/0x740 [ 11.878609][ C1] tcp_rtx_synack+0x150/0x440 [ 11.878610][ C1] ? trace_pelt_cfs_tp+0x9b/0x190 [ 11.878613][ C1] ? tcp_send_probe0+0x590/0x590 [ 11.878614][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 11.878616][ C1] ? update_cfs_rq_load_avg+0x4b/0x660 [ 11.878619][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 11.878621][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.878622][ C1] ? lock_acquire+0x6a/0x160 [ 11.878624][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 11.878626][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.878627][ C1] call_timer_fn+0x160/0x4d0 [ 11.878629][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 11.878631][ C1] ? debug_object_active_state+0x430/0x430 [ 11.878635][ C1] ? trace_sched_wakeup+0x9b/0x160 [ 11.878636][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 11.878638][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878640][ C1] __run_timers+0x68f/0xaa0 [ 11.878642][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 11.878643][ C1] ? debug_object_deactivate+0x2f7/0x440 [ 11.878645][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 11.878647][ C1] ? do_raw_spin_lock+0x131/0x280 [ 11.878650][ C1] ? __rwlock_init+0x150/0x150 [ 11.878652][ C1] run_timer_softirq+0xf0/0x160 [ 11.878654][ C1] ? __run_timers+0xaa0/0xaa0 [ 11.878655][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.878657][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878658][ C1] handle_softirqs+0x1d3/0x900 [ 11.878660][ C1] ? _local_bh_enable+0xc0/0xc0 [ 11.878662][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878663][ C1] ? lock_release+0x184/0x1f0 [ 11.878665][ C1] __irq_exit_rcu+0x145/0x1c0 [ 11.878667][ C1] irq_exit_rcu+0xe/0x30 [ 11.878668][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 11.878670][ C1] [ 11.878670][ C1] [ 11.878671][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 11.878672][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 11.878674][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 11.878676][ C1] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 11.878677][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 11.878679][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 11.878680][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 11.878680][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 11.878681][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 11.878682][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 11.878683][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 11.878685][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.878686][ C1] default_idle+0x9/0x10 [ 11.878688][ C1] default_idle_call+0x6e/0xb0 [ 11.878689][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 11.878691][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 11.878692][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 11.878694][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 11.878696][ C1] ? rcu_is_watching+0x16/0xd0 [ 11.878698][ C1] do_idle+0xd8/0x190 [ 11.878699][ C1] cpu_startup_entry+0x53/0x70 [ 11.878700][ C1] start_secondary+0x204/0x2b0 [ 11.878702][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 11.878704][ C1] common_startup_64+0x13e/0x148 [ 11.878707][ C1] [ 11.896250][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.902461][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 12.902464][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 12.902466][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 12.902467][ C1] preempt_count: 102, expected: 0 [ 12.902468][ C1] RCU nest depth: 0, expected: 0 [ 12.902468][ C1] INFO: lockdep is turned off. [ 12.902469][ C1] irq event stamp: 264516 [ 12.902469][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 12.902473][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 12.902474][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 12.902477][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 12.902478][ C1] Preemption disabled at: [ 12.902479][ C1] [<0000000000000000>] 0x0 [ 12.902482][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 12.902484][ C1] Tainted: [W]=WARN [ 12.902484][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 12.902486][ C1] Call Trace: [ 12.902486][ C1] [ 12.902487][ C1] dump_stack_lvl+0x6f/0xa0 [ 12.902490][ C1] __might_resched.cold+0x1fe/0x2c1 [ 12.902492][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 12.902494][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902497][ C1] __kmalloc_noprof+0x443/0x760 [ 12.902499][ C1] ? __rwlock_init+0x150/0x150 [ 12.902501][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 12.902503][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.902505][ C1] alloc_buf.isra.0+0x4b/0x260 [ 12.902507][ C1] put_chars+0x1e1/0x2f0 [ 12.902508][ C1] ? __send_to_port+0x420/0x420 [ 12.902509][ C1] ? printk_get_next_message+0x240/0x650 [ 12.902511][ C1] ? console_prepend_replay+0x20/0x20 [ 12.902514][ C1] hvc_console_print+0x292/0x780 [ 12.902516][ C1] ? hvc_write+0x3a0/0x3a0 [ 12.902517][ C1] ? __rwlock_init+0x150/0x150 [ 12.902519][ C1] ? lock_acquire+0x13c/0x160 [ 12.902521][ C1] console_emit_next_record+0x22f/0x4c0 [ 12.902523][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 12.902525][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902527][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902528][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902530][ C1] ? lock_acquire+0x13c/0x160 [ 12.902532][ C1] ? console_flush_one_record+0x111/0x710 [ 12.902533][ C1] console_flush_one_record+0x46f/0x710 [ 12.902535][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 12.902538][ C1] console_unlock+0xee/0x1f0 [ 12.902540][ C1] ? lock_acquire+0x13c/0x160 [ 12.902541][ C1] ? console_flush_one_record+0x710/0x710 [ 12.902543][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902544][ C1] ? lock_release+0x184/0x1f0 [ 12.902545][ C1] ? lock_acquire+0x60/0x160 [ 12.902547][ C1] ? __rcu_read_lock+0x30/0x70 [ 12.902549][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 12.902550][ C1] ? vprintk_emit+0x320/0x3e0 [ 12.902552][ C1] vprintk_emit+0x37c/0x3e0 [ 12.902554][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 12.902556][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 12.902557][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902559][ C1] ? lock_acquire+0x13c/0x160 [ 12.902561][ C1] _printk+0xc7/0x100 [ 12.902563][ C1] ? snapshot_read.cold+0x21/0x21 [ 12.902564][ C1] ? ___ratelimit+0x4e7/0xa00 [ 12.902567][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.902569][ C1] ? idr_get_free+0x830/0x830 [ 12.902570][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 12.902572][ C1] tcp_make_synack.cold+0x36/0xb6 [ 12.902575][ C1] ? tcp_send_synack+0x1570/0x1570 [ 12.902576][ C1] ? lock_release+0x184/0x1f0 [ 12.902578][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 12.902580][ C1] ? sched_clock+0x11/0x30 [ 12.902582][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902584][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 12.902585][ C1] ? lock_acquire+0x13c/0x160 [ 12.902587][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 12.902588][ C1] ? trace_hardirqs_on+0x36/0x40 [ 12.902590][ C1] ? get_random_u16+0x740/0x740 [ 12.902592][ C1] tcp_rtx_synack+0x150/0x440 [ 12.902593][ C1] ? trace_pelt_cfs_tp+0x9b/0x190 [ 12.902595][ C1] ? tcp_send_probe0+0x590/0x590 [ 12.902596][ C1] ? __update_load_avg_cfs_rq+0x36c/0x10c0 [ 12.902599][ C1] ? update_cfs_rq_load_avg+0x4b/0x660 [ 12.902601][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 12.902603][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.902604][ C1] ? lock_acquire+0x6a/0x160 [ 12.902605][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 12.902607][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.902608][ C1] call_timer_fn+0x160/0x4d0 [ 12.902611][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 12.902612][ C1] ? debug_object_active_state+0x430/0x430 [ 12.902615][ C1] ? trace_sched_wakeup+0x9b/0x160 [ 12.902617][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 12.902618][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902621][ C1] __run_timers+0x68f/0xaa0 [ 12.902622][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 12.902624][ C1] ? debug_object_deactivate+0x2f7/0x440 [ 12.902626][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 12.902628][ C1] ? do_raw_spin_lock+0x131/0x280 [ 12.902630][ C1] ? __rwlock_init+0x150/0x150 [ 12.902632][ C1] run_timer_softirq+0xf0/0x160 [ 12.902634][ C1] ? __run_timers+0xaa0/0xaa0 [ 12.902636][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.902637][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902638][ C1] handle_softirqs+0x1d3/0x900 [ 12.902640][ C1] ? _local_bh_enable+0xc0/0xc0 [ 12.902642][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902644][ C1] ? lock_release+0x184/0x1f0 [ 12.902645][ C1] __irq_exit_rcu+0x145/0x1c0 [ 12.902647][ C1] irq_exit_rcu+0xe/0x30 [ 12.902648][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 12.902650][ C1] [ 12.902650][ C1] [ 12.902651][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 12.902652][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 12.902654][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 12.902655][ C1] Code: 48 8b 3d 94 02 06 02 e8 1f 00 00 00 48 2b 05 58 03 a0 00 c3 0f 1f 80 00 00 00 00 f3 0f 1e fa eb 07 0f 00 2d 13 a6 17 00 fb f4 0f 1f 40 d6 48 83 ec 20 8b 17 49 89 f8 83 e2 fe 41 89 d2 0f 01 [ 12.902656][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 12.902658][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 12.902658][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 12.902659][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 12.902660][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 12.902660][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 12.902662][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 12.902663][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.902665][ C1] default_idle+0x9/0x10 [ 12.902666][ C1] default_idle_call+0x6e/0xb0 [ 12.902668][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 12.902669][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 12.902671][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 12.902672][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 12.902673][ C1] ? rcu_is_watching+0x16/0xd0 [ 12.902675][ C1] do_idle+0xd8/0x190 [ 12.902677][ C1] cpu_startup_entry+0x53/0x70 [ 12.902678][ C1] start_secondary+0x204/0x2b0 [ 12.902680][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 12.902681][ C1] common_startup_64+0x13e/0x148 [ 12.902684][ C1] [ 12.924764][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.927464][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 13.927469][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 13.927471][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 13.927472][ C1] preempt_count: 102, expected: 0 [ 13.927473][ C1] RCU nest depth: 0, expected: 0 [ 13.927474][ C1] INFO: lockdep is turned off. [ 13.927474][ C1] irq event stamp: 264516 [ 13.927475][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 13.927479][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 13.927481][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 13.927483][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 13.927484][ C1] Preemption disabled at: [ 13.927485][ C1] [<0000000000000000>] 0x0 [ 13.927488][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 13.927490][ C1] Tainted: [W]=WARN [ 13.927491][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 13.927492][ C1] Call Trace: [ 13.927493][ C1] [ 13.927494][ C1] dump_stack_lvl+0x6f/0xa0 [ 13.927497][ C1] __might_resched.cold+0x1fe/0x2c1 [ 13.927499][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 13.927501][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927504][ C1] __kmalloc_noprof+0x443/0x760 [ 13.927506][ C1] ? __rwlock_init+0x150/0x150 [ 13.927508][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 13.927510][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.927512][ C1] alloc_buf.isra.0+0x4b/0x260 [ 13.927513][ C1] put_chars+0x1e1/0x2f0 [ 13.927515][ C1] ? __send_to_port+0x420/0x420 [ 13.927516][ C1] ? printk_get_next_message+0x240/0x650 [ 13.927518][ C1] ? console_prepend_replay+0x20/0x20 [ 13.927521][ C1] hvc_console_print+0x292/0x780 [ 13.927523][ C1] ? hvc_write+0x3a0/0x3a0 [ 13.927524][ C1] ? __rwlock_init+0x150/0x150 [ 13.927526][ C1] ? lock_acquire+0x13c/0x160 [ 13.927528][ C1] console_emit_next_record+0x22f/0x4c0 [ 13.927530][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 13.927532][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927534][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927535][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927537][ C1] ? lock_acquire+0x13c/0x160 [ 13.927539][ C1] ? console_flush_one_record+0x111/0x710 [ 13.927540][ C1] console_flush_one_record+0x46f/0x710 [ 13.927542][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 13.927545][ C1] console_unlock+0xee/0x1f0 [ 13.927547][ C1] ? lock_acquire+0x13c/0x160 [ 13.927548][ C1] ? console_flush_one_record+0x710/0x710 [ 13.927550][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927551][ C1] ? lock_release+0x184/0x1f0 [ 13.927553][ C1] ? lock_acquire+0x60/0x160 [ 13.927554][ C1] ? __rcu_read_lock+0x30/0x70 [ 13.927556][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 13.927558][ C1] ? vprintk_emit+0x320/0x3e0 [ 13.927560][ C1] vprintk_emit+0x37c/0x3e0 [ 13.927562][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 13.927563][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 13.927565][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927567][ C1] ? lock_acquire+0x13c/0x160 [ 13.927569][ C1] _printk+0xc7/0x100 [ 13.927570][ C1] ? snapshot_read.cold+0x21/0x21 [ 13.927572][ C1] ? ___ratelimit+0x4e7/0xa00 [ 13.927574][ C1] ? idr_get_free+0x830/0x830 [ 13.927576][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 13.927578][ C1] tcp_make_synack.cold+0x36/0xb6 [ 13.927581][ C1] ? tcp_send_synack+0x1570/0x1570 [ 13.927582][ C1] ? lock_release+0x184/0x1f0 [ 13.927584][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 13.927587][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 13.927588][ C1] ? lock_acquire+0x13c/0x160 [ 13.927590][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 13.927591][ C1] ? trace_hardirqs_on+0x36/0x40 [ 13.927593][ C1] ? get_random_u16+0x740/0x740 [ 13.927595][ C1] tcp_rtx_synack+0x150/0x440 [ 13.927596][ C1] ? tcp_send_probe0+0x590/0x590 [ 13.927599][ C1] ? sched_balance_rq+0x324/0x1e30 [ 13.927601][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 13.927603][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.927604][ C1] ? lock_acquire+0x6a/0x160 [ 13.927606][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 13.927607][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.927608][ C1] call_timer_fn+0x160/0x4d0 [ 13.927611][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 13.927612][ C1] ? debug_object_active_state+0x430/0x430 [ 13.927615][ C1] ? __rwlock_init+0x150/0x150 [ 13.927616][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 13.927618][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927620][ C1] __run_timers+0x68f/0xaa0 [ 13.927621][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 13.927623][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 13.927625][ C1] ? do_raw_spin_lock+0x131/0x280 [ 13.927628][ C1] ? __rwlock_init+0x150/0x150 [ 13.927630][ C1] run_timer_softirq+0xf0/0x160 [ 13.927632][ C1] ? __run_timers+0xaa0/0xaa0 [ 13.927633][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.927634][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927636][ C1] handle_softirqs+0x1d3/0x900 [ 13.927638][ C1] ? _local_bh_enable+0xc0/0xc0 [ 13.927639][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927641][ C1] ? lock_release+0x184/0x1f0 [ 13.927643][ C1] __irq_exit_rcu+0x145/0x1c0 [ 13.927644][ C1] irq_exit_rcu+0xe/0x30 [ 13.927646][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 13.927647][ C1] [ 13.927647][ C1] [ 13.927648][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 13.927649][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 13.927651][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 13.927652][ C1] 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.927654][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 13.927656][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 13.927656][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 13.927657][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 13.927658][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 13.927659][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 13.927660][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 13.927661][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.927663][ C1] default_idle+0x9/0x10 [ 13.927665][ C1] default_idle_call+0x6e/0xb0 [ 13.927666][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 13.927667][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 13.927669][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 13.927671][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 13.927672][ C1] ? rcu_is_watching+0x16/0xd0 [ 13.927674][ C1] do_idle+0xd8/0x190 [ 13.927675][ C1] cpu_startup_entry+0x53/0x70 [ 13.927677][ C1] start_secondary+0x204/0x2b0 [ 13.927678][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 13.927680][ C1] common_startup_64+0x13e/0x148 [ 13.927683][ C1] [ 13.944993][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.951459][ C1] TCP: TCP-AO: the keyid 100 from SYN packet is not present - not sending SYNACK [ 14.951462][ C1] BUG: sleeping function called from invalid context at ./include/linux/sched/mm.h:322 [ 14.951463][ C1] in_atomic(): 1, irqs_disabled(): 1, non_block: 0, pid: 0, name: swapper/1 [ 14.951464][ C1] preempt_count: 102, expected: 0 [ 14.951465][ C1] RCU nest depth: 0, expected: 0 [ 14.951466][ C1] INFO: lockdep is turned off. [ 14.951467][ C1] irq event stamp: 264516 [ 14.951467][ C1] hardirqs last enabled at (264515): [] default_idle_call+0x98/0xb0 [ 14.951470][ C1] hardirqs last disabled at (264516): [] __schedule+0x1246/0x20e0 [ 14.951472][ C1] softirqs last enabled at (264500): [] handle_softirqs+0x67c/0x900 [ 14.951473][ C1] softirqs last disabled at (264493): [] __irq_exit_rcu+0x145/0x1c0 [ 14.951475][ C1] Preemption disabled at: [ 14.951475][ C1] [<0000000000000000>] 0x0 [ 14.951478][ C1] CPU: 1 UID: 0 PID: 0 Comm: swapper/1 Tainted: G W 7.2.0-virtme #1 PREEMPT(full) [ 14.951480][ C1] Tainted: [W]=WARN [ 14.951481][ C1] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 14.951481][ C1] Call Trace: [ 14.951482][ C1] [ 14.951483][ C1] dump_stack_lvl+0x6f/0xa0 [ 14.951485][ C1] __might_resched.cold+0x1fe/0x2c1 [ 14.951487][ C1] ? perf_trace_sched_switch+0x7c0/0x7c0 [ 14.951490][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951492][ C1] __kmalloc_noprof+0x443/0x760 [ 14.951494][ C1] ? __rwlock_init+0x150/0x150 [ 14.951496][ C1] ? alloc_buf.isra.0+0x4b/0x260 [ 14.951498][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.951499][ C1] alloc_buf.isra.0+0x4b/0x260 [ 14.951501][ C1] put_chars+0x1e1/0x2f0 [ 14.951503][ C1] ? __send_to_port+0x420/0x420 [ 14.951504][ C1] ? printk_get_next_message+0x240/0x650 [ 14.951506][ C1] ? console_prepend_replay+0x20/0x20 [ 14.951509][ C1] hvc_console_print+0x292/0x780 [ 14.951511][ C1] ? hvc_write+0x3a0/0x3a0 [ 14.951512][ C1] ? __rwlock_init+0x150/0x150 [ 14.951514][ C1] ? lock_acquire+0x13c/0x160 [ 14.951516][ C1] console_emit_next_record+0x22f/0x4c0 [ 14.951518][ C1] ? devkmsg_read+0x4b0/0x4b0 [ 14.951520][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951521][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951523][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951524][ C1] ? lock_acquire+0x13c/0x160 [ 14.951526][ C1] ? console_flush_one_record+0x111/0x710 [ 14.951528][ C1] console_flush_one_record+0x46f/0x710 [ 14.951530][ C1] ? console_emit_next_record+0x4c0/0x4c0 [ 14.951533][ C1] console_unlock+0xee/0x1f0 [ 14.951534][ C1] ? lock_acquire+0x13c/0x160 [ 14.951536][ C1] ? console_flush_one_record+0x710/0x710 [ 14.951537][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951539][ C1] ? lock_release+0x184/0x1f0 [ 14.951540][ C1] ? lock_acquire+0x60/0x160 [ 14.951541][ C1] ? __rcu_read_lock+0x30/0x70 [ 14.951543][ C1] ? __down_trylock_console_sem+0x5e/0xa0 [ 14.951545][ C1] ? vprintk_emit+0x320/0x3e0 [ 14.951547][ C1] vprintk_emit+0x37c/0x3e0 [ 14.951549][ C1] ? wake_up_klogd_work_func+0x90/0x90 [ 14.951550][ C1] ? do_raw_spin_trylock+0xb6/0x180 [ 14.951552][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951554][ C1] ? lock_acquire+0x13c/0x160 [ 14.951555][ C1] _printk+0xc7/0x100 [ 14.951557][ C1] ? snapshot_read.cold+0x21/0x21 [ 14.951559][ C1] ? ___ratelimit+0x4e7/0xa00 [ 14.951560][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.951562][ C1] ? idr_get_free+0x830/0x830 [ 14.951563][ C1] ? trace_irq_enable.constprop.0+0x30/0x160 [ 14.951565][ C1] tcp_make_synack.cold+0x36/0xb6 [ 14.951567][ C1] ? tcp_send_synack+0x1570/0x1570 [ 14.951569][ C1] ? lock_release+0x184/0x1f0 [ 14.951570][ C1] ? rt6_get_cookie+0x2d0/0x2d0 [ 14.951572][ C1] ? __trace_set_current_state+0x160/0x160 [ 14.951575][ C1] tcp_v6_send_synack+0xa5/0xe10 [ 14.951576][ C1] ? lock_acquire+0x13c/0x160 [ 14.951578][ C1] ? tcp_v6_md5_lookup+0x200/0x200 [ 14.951579][ C1] ? trace_hardirqs_on+0x36/0x40 [ 14.951581][ C1] ? get_random_u16+0x740/0x740 [ 14.951583][ C1] tcp_rtx_synack+0x150/0x440 [ 14.951584][ C1] ? tcp_send_probe0+0x590/0x590 [ 14.951586][ C1] ? sched_balance_rq+0x324/0x1e30 [ 14.951589][ C1] reqsk_timer_handler+0x8d1/0xe30 [ 14.951591][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.951592][ C1] ? lock_acquire+0x6a/0x160 [ 14.951593][ C1] ? do_raw_spin_unlock+0x59/0x250 [ 14.951595][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.951596][ C1] call_timer_fn+0x160/0x4d0 [ 14.951598][ C1] ? detach_if_pending+0x1d0/0x1d0 [ 14.951600][ C1] ? debug_object_active_state+0x430/0x430 [ 14.951602][ C1] ? __rwlock_init+0x150/0x150 [ 14.951604][ C1] ? timer_recalc_next_expiry+0xf0/0x210 [ 14.951605][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951607][ C1] __run_timers+0x68f/0xaa0 [ 14.951609][ C1] ? __inet_csk_reqsk_queue_drop+0x420/0x420 [ 14.951611][ C1] ? __bpf_trace_itimer_expire+0x10/0x10 [ 14.951613][ C1] ? do_raw_spin_lock+0x131/0x280 [ 14.951615][ C1] ? __rwlock_init+0x150/0x150 [ 14.951617][ C1] run_timer_softirq+0xf0/0x160 [ 14.951619][ C1] ? __run_timers+0xaa0/0xaa0 [ 14.951621][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.951622][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951624][ C1] handle_softirqs+0x1d3/0x900 [ 14.951625][ C1] ? _local_bh_enable+0xc0/0xc0 [ 14.951627][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951628][ C1] ? lock_release+0x184/0x1f0 [ 14.951630][ C1] __irq_exit_rcu+0x145/0x1c0 [ 14.951631][ C1] irq_exit_rcu+0xe/0x30 [ 14.951633][ C1] sysvec_apic_timer_interrupt+0x9d/0xe0 [ 14.951634][ C1] [ 14.951635][ C1] [ 14.951635][ C1] ? _raw_spin_unlock+0x2d/0x50 [ 14.951636][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 14.951638][ C1] RIP: 0010:pv_native_safe_halt+0xf/0x10 [ 14.951639][ C1] 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.951640][ C1] RSP: 0018:ffa0000000147e00 EFLAGS: 00000246 [ 14.951642][ C1] RAX: 0000000000000001 RBX: ff11000001bf2380 RCX: 0000000000000001 [ 14.951643][ C1] RDX: 0000000000000001 RSI: ffffffff8828dc60 RDI: ffffffff858fa307 [ 14.951643][ C1] RBP: 0000000000000000 R08: ffffffff87f1f421 R09: 1fe2200006a563a2 [ 14.951644][ C1] R10: 0000000000000001 R11: 0000000000000000 R12: 1ff4000000028fc3 [ 14.951645][ C1] R13: 0000000000000000 R14: dffffc0000000000 R15: 0000000000000000 [ 14.951646][ C1] ? ct_kernel_exit.constprop.0+0x101/0x160 [ 14.951647][ C1] ? cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.951649][ C1] default_idle+0x9/0x10 [ 14.951651][ C1] default_idle_call+0x6e/0xb0 [ 14.951652][ C1] cpuidle_idle_call.constprop.0+0x237/0x410 [ 14.951653][ C1] ? arch_cpu_idle_exit+0x40/0x40 [ 14.951655][ C1] ? mark_tsc_async_resets+0x30/0x30 [ 14.951656][ C1] ? trace_irq_enable.constprop.0+0x9b/0x160 [ 14.951658][ C1] ? rcu_is_watching+0x16/0xd0 [ 14.951659][ C1] do_idle+0xd8/0x190 [ 14.951661][ C1] cpu_startup_entry+0x53/0x70 [ 14.951662][ C1] start_secondary+0x204/0x2b0 [ 14.951664][ C1] ? set_cpu_sibling_map+0x2130/0x2130 [ 14.951665][ C1] common_startup_64+0x13e/0x148 [ 14.951668][ C1]