make -C tools/testing/selftests TARGETS=net/forwarding TEST_PROGS=tc_actioons.sh TEST_GEN_PROGS="" run_tests make: Entering directory '/home/virtme/testing-2/tools/testing/selftests' make[1]: Entering directory '/home/virtme/testing-2/tools/testing/selftests/net/forwarding' make[1]: Nothing to be done for 'all'. make[1]: Leaving directory '/home/virtme/testing-2/tools/testing/selftests/net/forwarding' make[1]: Entering directory '/home/virtme/testing-2/tools/testing/selftests/net/forwarding' TAP version 13 1..1 # timeout set to 10800 # 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 ] # TEST: mirred_egress_to_ingress (skip_hw) [ OK ] [ 884.324038] [ 884.324195] ============================================ [ 884.324563] WARNING: possible recursive locking detected [ 884.324907] 6.8.0-rc3-virtme #1 Not tainted [ 884.325154] -------------------------------------------- [ 884.325470] ncat/3047 is trying to acquire lock: [ 884.325706] ffff8e82451580b0 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0xdb5/0xef0 [ 884.326126] [ 884.326126] but task is already holding lock: [ 884.326419] ffff8e8245158cb0 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0xdb5/0xef0 [ 884.326894] [ 884.326894] other info that might help us debug this: [ 884.327219] Possible unsafe locking scenario: [ 884.327219] [ 884.327522] CPU0 [ 884.327662] ---- [ 884.327832] lock(slock-AF_INET/1); [ 884.328066] lock(slock-AF_INET/1); [ 884.328323] [ 884.328323] *** DEADLOCK *** [ 884.328323] [ 884.328651] May be due to missing lock nesting notation [ 884.328651] [ 884.329019] 8 locks held by ncat/3047: [ 884.329278] #0: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x6f/0x260 [ 884.329880] #1: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x6f/0x180 [ 884.330552] #2: ffff8e8245158cb0 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0xdb5/0xef0 [ 884.331175] #3: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x3f/0x6f0 [ 884.331789] #4: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0xc6/0xa20 [ 884.332425] #5: ffffffff8a567880 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x6e/0x1180 [ 884.333079] #6: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb+0x58/0x2c0 [ 884.333677] #7: ffffffff8a5678c0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x6f/0x180 [ 884.334347] [ 884.334347] stack backtrace: [ 884.334664] CPU: 1 PID: 3047 Comm: ncat Not tainted 6.8.0-rc3-virtme #1 [ 884.335142] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 884.335911] Call Trace: [ 884.336101] [ 884.336261] dump_stack_lvl+0x4b/0x80 [ 884.336513] __lock_acquire+0x1215/0x1750 [ 884.3368 DETECTED CRASH, lowering timeout 11] ? sk_filter_trim_cap+0x53/0x360 [ 884.337074] lock_acquire+0xc1/0x2b0 [ 884.337260] ? tcp_v4_rcv+0xdb5/0xef0 [ 884.337452] ? sk_filter_trim_cap+0x11a/0x360 [ 884.337674] _raw_spin_lock_nested+0x2e/0x40 [ 884.337898] ? tcp_v4_rcv+0xdb5/0xef0 [ 884.338087] tcp_v4_rcv+0xdb5/0xef0 [ 884.338272] ip_protocol_deliver_rcu+0x4b/0x1e0 [ 884.338512] ip_local_deliver_finish+0xaf/0x180 [ 884.338744] __netif_receive_skb_one_core+0x8b/0xa0 [ 884.338993] netif_receive_skb+0x87/0x2c0 [ 884.339203] tcf_mirred_to_dev+0x1f6/0x410 [act_mirred] [ 884.339485] tcf_mirred_act+0xee/0x560 [act_mirred] [ 884.339738] ? tcf_skbedit_act+0x1d6/0x410 [act_skbedit] [ 884.340010] tcf_action_exec+0xac/0x230 [ 884.340218] fl_classify+0x20e/0x260 [cls_flower] [ 884.340463] ? __bfs+0xf3/0x240 [ 884.340645] ? check_irq_usage+0x19c/0xc40 [ 884.340857] ? __skb_flow_dissect+0xc9/0x2d60 [ 884.341085] ? check_path.constprop.0+0x24/0x50 [ 884.341321] ? check_noncircular+0x81/0x150 [ 884.341535] ? __skb_flow_dissect+0x2fb/0x2d60 [ 884.341767] ? __lock_acquire+0xa6e/0x1750 [ 884.341979] tcf_classify+0x17a/0x540 [ 884.342172] tc_run+0x9f/0x150 [ 884.342339] __dev_queue_xmit+0x311/0x1180 [ 884.342550] ? mark_held_locks+0x49/0x80 [ 884.342761] ? eth_header+0x2a/0xc0 [ 884.342946] ip_finish_output2+0x22d/0xa20 [ 884.343158] ? ip_skb_dst_mtu+0x51/0x1c0 [ 884.343361] ? __ip_queue_xmit+0x1d5/0x6f0 [ 884.343577] __ip_queue_xmit+0x1d5/0x6f0 [ 884.343789] __tcp_transmit_skb+0xb65/0xd30 [ 884.344004] ? __alloc_skb+0xdc/0x1a0 [ 884.344196] tcp_rcv_state_process+0x4f3/0x11f0 [ 884.344438] ? tcp_v4_rcv+0xdb5/0xef0 [ 884.344630] ? tcp_v4_do_rcv+0x64/0x360 [ 884.344828] tcp_v4_do_rcv+0x64/0x360 [ 884.345019] tcp_v4_rcv+0xe4f/0xef0 [ 884.345202] ? process_backlog+0x6f/0x260 [ 884.345413] ip_protocol_deliver_rcu+0x4b/0x1e0 [ 884.345645] ip_local_deliver_finish+0xaf/0x180 [ 884.345879] __netif_receive_skb_one_core+0x8b/0xa0 [ 884.346127] process_backlog+0x7c/0x260 [ 884.346328] __napi_poll.constprop.0+0x27/0x1e0 [ 884.346561] net_rx_action+0x2be/0x340 [ 884.346756] __do_softirq+0xc8/0x37a [ 884.346948] ? inet_shutdown+0xa8/0x100 [ 884.347147] do_softirq+0x4d/0x90 [ 884.347326] [ 884.347440] [ 884.347555] __local_bh_enable_ip+0xbf/0xe0 [ 884.347777] inet_shutdown+0xa8/0x100 [ 884.347968] __sys_shutdown+0x45/0x90 [ 884.348162] __x64_sys_shutdown+0x14/0x20 [ 884.348369] do_syscall_64+0xc9/0x1e0 [ 884.348560] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 884.348821] RIP: 0033:0x7f45fcd3fbeb [ 884.349009] Code: 73 01 c3 48 8b 0d 15 92 1b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa b8 30 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d e5 91 1b 00 f7 d8 64 89 01 48 [ 884.349932] RSP: 002b:00007fff16acbdf8 EFLAGS: 00000246 ORIG_RAX: 0000000000000030 [ 884.350316] RAX: ffffffffffffffda RBX: 0000000000000008 RCX: 00007f45fcd3fbeb [ 884.350692] RDX: 000055a9c4e58420 RSI: 0000000000000001 RDI: 0000000000000008 [ 884.351049] RBP: 0000000000000008 R08: 0000000000000000 R09: 0000000000000000 [ 884.351412] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000008 [ 884.351835] R13: 0000000000000000 R14: 0000000000000001 R15: 0000000000000000 [ 884.352308] # [ 889.006876] irq 4: nobody cared (try booting with the "irqpoll" option) [ 889.007226] CPU: 1 PID: 2245 Comm: perl Not tainted 6.8.0-rc3-virtme #1 [ 889.007560] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 889.008130] Call Trace: [ 889.008263] [ 889.008375] dump_stack_lvl+0x4b/0x80 [ 889.008574] __report_bad_irq+0x2b/0xc0 [ 889.008775] note_interrupt+0x2a7/0x2f0 [ 889.008973] handle_irq_event+0x72/0x80 [ 889.009173] handle_edge_irq+0x8b/0x230 [ 889.009372] __common_interrupt+0x4b/0x100 [ 889.009587] common_interrupt+0x81/0xa0 [ 889.009788] [ 889.009902] [ 889.010016] asm_common_interrupt+0x26/0x40 [ 889.010234] RIP: 0010:_raw_spin_unlock_irqrestore+0x39/0x50 [ 889.010519] Code: c7 18 53 48 89 f3 48 8b 74 24 10 e8 81 bc 38 ff 48 89 ef e8 39 ed 38 ff 80 e7 02 74 06 e8 4f 16 46 ff fb 65 ff 0d cf 68 7f 76 <74> 07 5b 5d c3 cc cc cc cc 0f 1f 44 00 00 5b 5d c3 cc cc cc cc 66 [ 889.011439] RSP: 0018:ffffad3c80707d18 EFLAGS: 00000286 [ 889.011703] RAX: 0000000000000001 RBX: 0000000000000282 RCX: 0000000000000017 [ 889.012059] RDX: ffffffff893c77e2 RSI: ffffffff89838671 RDI: ffffffff89838671 [ 889.012416] RBP: ffffffff8ba02f20 R08: 0000000000000000 R09: 0000000000000000 [ 889.012773] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001 [ 889.013128] R13: 0000000000000000 R14: ffff8e8242518c01 R15: ffff8e82421f0000 [ 889.013485] ? rpm_suspend+0x232/0x700 [ 889.013679] ? _raw_spin_unlock_irqrestore+0x31/0x50 [ 889.013931] ? _raw_spin_unlock_irqrestore+0x31/0x50 [ 889.014187] ? _raw_spin_unlock_irqrestore+0x31/0x50 [ 889.014440] uart_write+0x103/0x1d0 [ 889.014624] n_tty_write+0x1a6/0x530 [ 889.014812] ? __pfx_woken_wake_function+0x10/0x10 [ 889.015058] file_tty_write.constprop.0+0x164/0x340 [ 889.015310] vfs_write+0x38d/0x550 [ 889.015491] ksys_write+0x69/0xf0 [ 889.015666] do_syscall_64+0xc9/0x1e0 [ 889.015856] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 889.016113] RIP: 0033:0x7fc2c452a957 [ 889.016299] 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 [ 889.017215] RSP: 002b:00007ffd2bd7ecf8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 889.017593] RAX: ffffffffffffffda RBX: 00005622fc34ed80 RCX: 00007fc2c452a957 [ 889.017950] RDX: 0000000000000001 RSI: 00005622fc34ed80 RDI: 0000000000000001 [ 889.018307] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000 [ 889.018663] R10: 0000000000000001 R11: 0000000000000246 R12: 00005622fc33b500 [ 889.019020] R13: 00005622fc31c2a0 R14: 0000000000000001 R15: 00005622fc33b500 [ 889.019378] [ 889.019496] handlers: [ 889.019618] [<000000006b9684de>] serial8250_interrupt [ 889.019882] Disabling IRQ #4 [ 899.923842] ncat (3048) used greatest stack depth: 10680 bytes left 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