make -C tools/testing/selftests TARGETS=net/forwarding TEST_PROGS=tc_actioons.sh TEST_GEN_PROGS="" run_tests make: Entering directory '/home/virtme/testing-4/tools/testing/selftests' make[1]: Entering directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding' make[1]: Nothing to be done for 'all'. make[1]: Leaving directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding' make[1]: Entering directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding' TAP version 13 1..1 # overriding timeout to 21600.0 # selftests: net/forwarding: tc_actions.sh # TEST: gact drop and ok (skip_hw) [ OK ] # TEST: mirred egress flower redirect (skip_hw) [ OK ] # TEST: mirred egress flower mirror (skip_hw) [ OK ] # TEST: mirred egress matchall mirror (skip_hw) [ OK ] [ 1366.483011][ T7401] ping (7401) used greatest stack depth: 23480 bytes left # TEST: mirred_egress_to_ingress (skip_hw) [ OK ] # [ 1376.078299][ C2] [ 1376.078461][ C2] ============================================ [ 1376.078797][ C2] WARNING: possible recursive locking detected [ 1376.079105][ C2] 6.8.0-rc2-virtme #1 Not tainted [ 1376.079377][ C2] -------------------------------------------- [ 1376.079692][ C2] ksoftirqd/2/27 is trying to acquire lock: [ 1376.079986][ C2] ffff888009c71b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0 [ 1376.080456][ C2] [ 1376.080456][ C2] but task is already holding lock: [ 1376.080827][ C2] ffff888009c70e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0 [ 1376.081293][ C2] [ 1376.081293][ C2] other info that might help us debug this: [ 1376.081700][ C2] Possible unsafe locking scenario: [ 1376.081700][ C2] [ 1376.082070][ C2] CPU0 [ 1376.082262][ C2] ---- [ 1376.082434][ C2] lock(slock-AF_INET/1); [ 1376.082701][ C2] lock(slock-AF_INET/1); [ 1376.082928][ C2] [ 1376.082928][ C2] *** DEADLOCK *** [ 1376.082928][ C2] [ 1376.083358][ C2] May be due to missing lock nesting notation [ 1376.083358][ C2] [ 1376.083796][ C2] 8 locks held by ksoftirqd/2/27: [ 1376.084053][ C2] #0: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0 [ 1376.084546][ C2] #1: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480 [ 1376.085089][ C2] #2: ffff888009c70e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0 [ 1376.085587][ C2] #3: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x1910 [ 1376.086085][ C2] #4: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0 [ 1376.086593][ C2] #5: ffffffff8c544780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1da/0x17e0 [ 1376.087089][ C2] #6: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300 [ 1376.087619][ C2] #7: ffffffff8c5447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480 [ 1376.088128][ C2] [ 1376.088128][ C2] stack backtrace: [ 1376.088462][ C2] CPU: 2 PID: 27 Comm: ksoftirqd/2 Not tainted 6.8.0-rc2-virtme #1 [ 1376.088872][ C2] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 1376.089485][ C2] Call Trace: [ 1376.089678][ C2] [ 1376.089829][ C2] dump_stack_lvl+0x64/0xb0 [ 1376.090079][ C2] validate_chain+0x525/0xa00 [ 1376.090336][ C2] ? __pfx_validate_chain+0x10/0x10 [ 1376.090601][ C2] ? hlock_class+0x4e/0x130 [ 1376.090864][ C2] ? mark_lock+0x38/0x3e0 [ 1376.091131][ C2] __lock_acquire+0xb67/0x1610 [ 1376.091412][ C2] ? lock_downgrade+0xa0/0x110 [ 1376.091657][ C2] ? mark_lock+0x38/0x3e0 [ 1376.091875][ C2] lock_acquire.part.0+0xe5/0x330 [ 1376.092167][ C2] ? tcp_v4_rcv+0x221e/0x2ac0 [ 1376.092402][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1376.092709][ C2] ? __pfx_sk_filter_trim_cap+0x10/0x10 [ 1376.092992][ C2] ? lock_acquire+0x1c1/0x220 [ 1376.093267][ C2] ? tcp_v4_rcv+0x221e/0x2ac0 [ 1376.093513][ C2] _raw_spin_lock_nested+0x33/0x80 [ 1376.093795][ C2] ? tcp_v4_rcv+0x221e/0x2ac0 [ 1376.094029][ C2] tcp_v4_rcv+0x221e/0x2ac0 [ 1376.094297][ C2] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 1376.094581][ C2] ? __pfx_raw_v4_input+0x10/0x10 [ 1376.094872][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1376.095153][ C2] ip_protocol_deliver_rcu+0x93/0x360 [ 1376.095476][ C2] ip_local_deliver_finish+0x2ae/0x480 [ 1376.095797][ C2] ip_local_deliver+0x19d/0x480 [ 1376.096048][ C2] ? __pfx_ip_local_deliver+0x10/0x10 [ 1376.096352][ C2] ? tcp_v4_early_demux+0x59a/0x9d0 [ 1376.096615][ C2] ? ip_rcv_finish_core.constprop.0+0x522/0x1300 [ 1376.096933][ C2] ip_rcv+0x564/0x740 [ 1376.097152][ C2] ? __pfx_ip_rcv+0x10/0x10 [ 1376.097386][ C2] ? lock_acquire.part.0+0xe5/0x330 [ 1376.097682][ C2] ? netif_receive_skb_internal+0x84/0x300 [ 1376.097976][ C2] ? __pfx_ip_rcv+0x10/0x10 [ 1376.098227][ C2] __netif_receive_skb_one_core+0x166/0x1b0 [ 1376.098529][ C2] ? __pfx___netif_receive_skb_one_core+0x10/0x10 [ 1376.098874][ C2] ? mark_held_locks+0xa5/0xf0 [ 1376.099120][ C2] ? lock_acquire+0x1c1/0x220 [ 1376.099390][ C2] ? netif_receive_skb_internal+0x84/0x300 [ 1376.099720][ C2] netif_receive_skb_internal+0xb0/0x300 [ 1376.100005][ C2] ? __pfx_netif_receive_skb_internal+0x10/0x10 [ 1376.100341][ C2] ? __copy_skb_header+0xaf/0x490 [ 1376.100596][ C2] ? __skb_clone+0x57a/0x760 [ 1376.100831][ C2] netif_receive_skb+0x55/0x280 [ 1376.101112][ C2] tcf_mirred_to_dev+0x444/0xd70 [act_mirred] [ 1376.101445][ C2] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit] [ 1376.101804][ C2] tcf_mirred_act+0x338/0x780 [act_mirred] [ 1376.102101][ C2] tcf_action_exec.part.0+0x112/0x3d0 [ 1376.102398][ C2] fl_classify+0x4dc/0x650 [cls_flower] [ 1376.102716][ C2] ? __pfx_fl_classify+0x10/0x10 [cls_flower] [ 1376.103026][ C2] ? __lock_release+0x40f/0x880 [ 1376.103297][ C2] ? __pfx_check_irq_usage+0x10/0x10 [ 1376.103587][ C2] ? __bfs+0x247/0x650 [ 1376.103800][ C2] ? __pfx_hlock_conflict+0x10/0x10 [ 1376.104082][ C2] ? check_path.constprop.0+0x24/0x50 [ 1376.104357][ C2] ? check_noncircular+0x14e/0x3e0 [ 1376.104651][ C2] ? __pfx_check_noncircular+0x10/0x10 [ 1376.104925][ C2] ? __pfx_validate_chain+0x10/0x10 [ 1376.105232][ C2] ? hlock_class+0x4e/0x130 [ 1376.105465][ C2] ? hlock_class+0x4e/0x130 [ 1376.105711][ C2] ? check_prev_add+0x773/0xce0 [ 1376.105964][ C2] __tcf_classify+0x329/0x7d0 [ 1376.106239][ C2] tcf_classify+0x283/0x930 [ 1376.106497][ C2] ? __pfx_tcf_classify+0x10/0x10 [ 1376.106786][ C2] ? __dev_queue_xmit+0x1da/0x17e0 [ 1376.107043][ C2] ? __dev_queue_xmit+0x1da/0x17e0 [ 1376.107333][ C2] tc_run+0x2e4/0x5d0 [ 1376.107551][ C2] ? __pfx_tc_run+0x10/0x10 [ 1376.107784][ C2] ? lock_acquire+0x1c1/0x220 [ 1376.108021][ C2] ? __dev_queue_xmit+0x1da/0x17e0 [ 1376.108300][ C2] __dev_queue_xmit+0x686/0x17e0 [ 1376.108575][ C2] ? mark_held_locks+0xa5/0xf0 [ 1376.108853][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370 [ 1376.109207][ C2] ? __pfx___dev_queue_xmit+0x10/0x10 [ 1376.109479][ C2] ? __pfx_vrf_output_direct_finish+0x1/0x10 [vrf] [ 1376.109826][ C2] ip_finish_output2+0x786/0x18e0 [ 1376.110081][ C2] ? __pfx_ip_finish_output2+0x10/0x10 [ 1376.110395][ C2] ? __ip_finish_output+0x3dd/0x770 [ 1376.110697][ C2] ip_output+0x16b/0x4f0 [ 1376.110948][ C2] ? __pfx_ip_output+0x10/0x10 [ 1376.111217][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1376.111501][ C2] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370 [ 1376.111860][ C2] ? ip_local_out+0x114/0x3b0 [ 1376.112103][ C2] __ip_queue_xmit+0x672/0x1910 [ 1376.112383][ C2] ? __skb_clone+0x57a/0x760 [ 1376.112646][ C2] __tcp_transmit_skb+0x22b1/0x2d20 [ 1376.112917][ C2] ? __pfx___tcp_transmit_skb+0x10/0x10 [ 1376.113219][ C2] ? tcp_small_queue_check.isra.0+0xe9/0x380 [ 1376.113527][ C2] tcp_write_xmit+0x94f/0x1cb0 [ 1376.113796][ C2] ? ipv4_mtu+0x37/0x360 [ 1376.114012][ C2] ? __pfx_tcp_write_xmit+0x10/0x10 [ 1376.114316][ C2] ? __pfx_tcp_current_mss+0x10/0x10 [ 1376.114621][ C2] __tcp_push_pending_frames+0x96/0x320 [ 1376.114899][ C2] tcp_rcv_state_process+0x786/0x1fe0 [ 1376.115194][ C2] ? tcp_v4_rcv+0x221e/0x2ac0 [ 1376.115441][ C2] ? hlock_class+0x4e/0x130 [ 1376.115697][ C2] ? __lock_acquired+0x18a/0x6b0 [ 1376.115948][ C2] ? __pfx_tcp_rcv_state_process+0x10/0x10 [ 1376.116259][ C2] ? __pfx___lock_acquired+0x10/0x10 [ 1376.116527][ C2] ? __pfx_do_raw_spin_trylock+0x10/0x10 [ 1376.116843][ C2] tcp_v4_do_rcv+0x154/0x860 [ 1376.117078][ C2] tcp_v4_rcv+0x2449/0x2ac0 [ 1376.117344][ C2] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 1376.117591][ C2] ? __pfx_raw_v4_input+0x10/0x10 [ 1376.117842][ C2] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1376.118147][ C2] ip_protocol_deliver_rcu+0x93/0x360 [ 1376.118423][ C2] ip_local_deliver_finish+0x2ae/0x480 [ 1376.118715][ C2] ip_local_deliver+0x19d/0x480 [ 1376.118962][ C2] ? __pfx_ip_local_deliver+0x10/0x10 [ 1376.119257][ C2] ? tcp_v4_early_demux+0x59a/0x9d0 [ 1376.119526][ C2] ? ip_rcv_finish_core.constprop.0+0x522/0x1300 [ 1376.119869][ C2] ip_rcv+0x564/0x740 [ 1376.120075][ C2] ? __pfx_ip_rcv+0x10/0x10 [ 1376.120337][ C2] ? lock_acquire.part.0+0xe5/0x330 [ 1376.120637][ C2] ? process_backlog+0x1ed/0x5e0 [ 1376.120921][ C2] ? __pfx_ip_rcv+0x10/0x10 [ 1376.121154][ C2] __netif_receive_skb_one_core+0x166/0x1b0 [ 1376.121482][ C2] ? __pfx___netif_receive_skb_one_core+0x10/0x10 [ 1376.121839][ C2] ? __pfx_do_raw_spin_trylock+0x10/0x10 [ 1376.122122][ C2] ? lock_acquire+0x1c1/0x220 [ 1376.122390][ C2] ? process_backlog+0x1ed/0x5e0 [ 1376.122642][ C2] process_backlog+0xd3/0x5e0 [ 1376.122879][ C2] __napi_poll.constprop.0+0xa2/0x460 [ 1376.123189][ C2] net_rx_action+0x440/0xb40 [ 1376.123465][ C2] ? __pfx_net_rx_action+0x10/0x10 [ 1376.123725][ C2] ? __pfx___schedule+0x10/0x10 [ 1376.124007][ C2] ? __pfx___lock_release+0x10/0x10 [ 1376.124304][ C2] __do_softirq+0x1b9/0x7ff [ 1376.124564][ C2] ? __pfx_run_ksoftirqd+0x10/0x10 [ 1376.124850][ C2] run_ksoftirqd+0x2e/0x60 [ 1376.125081][ C2] smpboot_thread_fn+0x30b/0x840 [ 1376.125371][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 1376.125648][ C2] ? __pfx_smpboot_thread_fn+0x10/0x10 [ 1376.125919][ C2] kthread+0x28f/0x360 [ 1376.126149][ C2] ? __pfx_kthread+0x10/0x10 [ 1376.126385][ C2] ret_from_fork+0x31/0x70 [ 1376.126651][ C2] ? __pfx_kthread+0x10/0x10 [ 1376.126880][ C2] ret_from_fork_asm+0x1b/0x30 [ 1376.127157][ C2] [ 1402.098624][ T7445] ncat (7445) used greatest stack depth: 21312 bytes left [ 1424.979524][ C1] irq 4: nobody cared (try booting with the "irqpoll" option) [ 1424.979914][ C1] CPU: 1 PID: 7144 Comm: perl Not tainted 6.8.0-rc2-virtme #1 [ 1424.980283][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 1424.980885][ C1] Call Trace: [ 1424.981052][ C1] [ 1424.981200][ C1] dump_stack_lvl+0x64/0xb0 [ 1424.981436][ C1] __report_bad_irq+0x5f/0x180 [ 1424.981679][ C1] note_interrupt+0x6b3/0x860 [ 1424.981916][ C1] handle_irq_event+0x16d/0x1c0 [ 1424.982162][ C1] handle_edge_irq+0x1fa/0xb60 [ 1424.982402][ C1] __common_interrupt+0x7c/0x180 [ 1424.982652][ C1] common_interrupt+0x7e/0x90 [ 1424.982893][ C1] [ 1424.983041][ C1] [ 1424.983189][ C1] asm_common_interrupt+0x26/0x40 [ 1424.983445][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x43/0x70 [ 1424.983765][ C1] Code: 10 e8 71 81 a4 fd 48 89 ef e8 89 09 a5 fd 81 e3 00 02 00 00 75 1d 9c 58 f6 c4 02 75 29 48 85 db 74 01 fb 65 ff 0d 05 fe f5 74 <74> 0e 5b 5d c3 cc cc cc cc e8 0f ca c6 fd eb dc 0f 1f 44 00 00 5b [ 1424.984715][ C1] RSP: 0018:ffffc9000085fa88 EFLAGS: 00000286 [ 1424.985024][ C1] RAX: 0000000000000046 RBX: 0000000000000200 RCX: 1ffffffff19dcb93 [ 1424.985415][ C1] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff8b29b8d1 [ 1424.985805][ C1] RBP: ffffffff8f02f860 R08: 0000000000000000 R09: fffffbfff19dc94a [ 1424.986198][ C1] R10: ffffffff8cee4a57 R11: 0000000000000000 R12: 0000000000000e12 [ 1424.986589][ C1] R13: ffffffff8f02f970 R14: ffffffff8f02f860 R15: ffff8880054b0000 [ 1424.986986][ C1] ? _raw_spin_unlock_irqrestore+0x51/0x70 [ 1424.987279][ C1] uart_write+0x220/0x440 [ 1424.987498][ C1] process_output_block+0x13e/0x790 [ 1424.987760][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100 [ 1424.988068][ C1] n_tty_write+0x414/0x7a0 [ 1424.988294][ C1] ? __pfx_n_tty_write+0x10/0x10 [ 1424.988541][ C1] ? __pfx_woken_wake_function+0x10/0x10 [ 1424.988823][ C1] ? lock_acquire+0x1c1/0x220 [ 1424.989060][ C1] ? iterate_tty_write+0x95/0x540 [ 1424.989312][ C1] iterate_tty_write+0x229/0x540 [ 1424.989561][ C1] file_tty_write.constprop.0+0x1db/0x370 [ 1424.989843][ C1] vfs_write+0x9e9/0x10a0 [ 1424.990066][ C1] ? lock_acquire+0x1c1/0x220 [ 1424.990298][ C1] ? __might_fault+0xc6/0x180 [ 1424.990536][ C1] ? __pfx_vfs_write+0x10/0x10 [ 1424.990775][ C1] ? __might_fault+0xc6/0x180 [ 1424.991010][ C1] ? lock_release+0x1d5/0x250 [ 1424.991244][ C1] ? kvm_clock_get_cycles+0x18/0x30 [ 1424.991507][ C1] ? __fget_light+0x54/0x1e0 [ 1424.991740][ C1] ksys_write+0xf5/0x1e0 [ 1424.991955][ C1] ? __pfx_ksys_write+0x10/0x10 [ 1424.992198][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100 [ 1424.992495][ C1] do_syscall_64+0xc9/0x1e0 [ 1424.992724][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 1424.993019][ C1] RIP: 0033:0x7f01d98f8957 [ 1424.993242][ C1] Code: 0b 00 f7 d8 64 89 02 48 c7 c0 ff ff ff ff eb b7 0f 1f 00 f3 0f 1e fa 64 8b 04 25 18 00 00 00 85 c0 75 10 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 51 c3 48 83 ec 28 48 89 54 24 18 48 89 74 24 [ 1424.994202][ C1] RSP: 002b:00007ffdba8d81c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 1424.994618][ C1] RAX: ffffffffffffffda RBX: 000055a15d8a4f90 RCX: 00007f01d98f8957 [ 1424.995022][ C1] RDX: 0000000000000001 RSI: 000055a15d8a4f90 RDI: 0000000000000001 [ 1424.995414][ C1] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000 [ 1424.995806][ C1] R10: 0000000000000001 R11: 0000000000000246 R12: 000055a15d891570 [ 1424.996197][ C1] R13: 000055a15d8722a0 R14: 0000000000000001 R15: 000055a15d891570 [ 1424.996591][ C1] [ 1424.996746][ C1] handlers: [ 1424.996902][ C1] [] serial8250_interrupt [ 1424.997209][ C1] Disabling IRQ #4 TEST: mirred_egress_to_ingress_tcp (skip_hw) [ OK ] # INFO: Could not test offloaded functionality ok 1 selftests: WAIT TIMEOUT stdout Ctrl-C stdout Ctrl-C stdout WAIT TIMEOUT stdout