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
# 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 ]
[ 2259.184438][ T6425] ping (6425) used greatest stack depth: 23480 bytes left
# TEST: mirred_egress_to_ingress (skip_hw) [ OK ]
[ 2262.462674][ T6463] tc (6463) used greatest stack depth: 23456 bytes left
# [ 2267.026238][ C0]
[ 2267.026411][ C0] ============================================
[ 2267.026743][ C0] WARNING: possible recursive locking detected
[ 2267.027073][ C0] 6.8.0-rc3-virtme #1 Not tainted
[ 2267.027350][ C0] --------------------------------------------
[ 2267.027669][ C0] ncat/6468 is trying to acquire lock:
[ 2267.027950][ C0] ffff888008f61b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 2267.028456][ C0]
[ 2267.028456][ C0] but task is already holding lock:
[ 2267.028858][ C0] ffff888008f60e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 2267.029342][ C0]
[ 2267.029342][ C0] other info that might help us debug this:
[ 2267.029759][ C0] Possible unsafe locking scenario:
[ 2267.029759][ C0]
[ 2267.030143][ C0] CPU0
[ 2267.030332][ C0] ----
[ 2267.030525][ C0] lock(slock-AF_INET/1);
[ 2267.030769][ C0] lock(slock-AF_INET/1);
[ 2267.031010][ C0]
[ 2267.031010][ C0] *** DEADLOCK ***
[ 2267.031010][ C0]
[ 2267.031444][ C0] May be due to missing lock nesting notation
[ 2267.031444][ C0]
[ 2267.031896][ C0] 8 locks held by ncat/6468:
[ 2267.032164][ C0] #0: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0
[ 2267.032713][ C0] #1: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480
[ 2267.033243][ C0] #2: ffff888008f60e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 2267.033744][ C0] #3: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x17b0
[ 2267.034274][ C0] #4: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0
[ 2267.034818][ C0] #5: ffffffffa5346780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1da/0x17e0
[ 2267.035354][ C0] #6: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300
[ 2267.035928][ C0] #7: ffffffffa53467e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480
[ 2267.036471][ C0]
[ 2267.036471][ C0] stack backtrace:
[ 2267.036793][ C0] CPU: 0 PID: 6468 Comm: ncat Not tainted 6.8.0-rc3-virtme #1
[ 2267.037200][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 2267.037879][ C0] Call Trace:
[ 2267.038055][ C0] <IRQ>
[ 2267.038225][ C0] dump_stack_lvl+0x64/0xb0
[ 2267.038488][ C0] validate_chain+0x525/0xa00
[ 2267.038763][ C0] ? __pfx_validate_chain+0x10/0x10
[ 2267.039046][ C0] ? hlock_class+0x4e/0x130
[ 2267.039304][ C0] ? mark_lock+0x38/0x3e0
[ 2267.039545][ C0] __lock_acquire+0xb67/0x1610
[ 2267.039822][ C0] ? lock_downgrade+0xa0/0x110
[ 2267.040097][ C0] ? mark_lock+0x38/0x3e0
[ 2267.040347][
DETECTED CRASH, lowering timeout
C0] lock_acquire.part.0+0xe5/0x330
[ 2267.040633][ C0] ? tcp_v4_rcv+0x221e/0x2ac0
[ 2267.040881][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2267.041190][ C0] ? __pfx_sk_filter_trim_cap+0x10/0x10
[ 2267.041499][ C0] ? lock_acquire+0x1c1/0x220
[ 2267.041767][ C0] ? tcp_v4_rcv+0x221e/0x2ac0
[ 2267.042033][ C0] _raw_spin_lock_nested+0x33/0x80
[ 2267.042345][ C0] ? tcp_v4_rcv+0x221e/0x2ac0
[ 2267.042606][ C0] tcp_v4_rcv+0x221e/0x2ac0
[ 2267.042864][ C0] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 2267.043130][ C0] ? __pfx_raw_v4_input+0x10/0x10
[ 2267.043428][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2267.043724][ C0] ip_protocol_deliver_rcu+0x93/0x360
[ 2267.044009][ C0] ip_local_deliver_finish+0x2ae/0x480
[ 2267.044309][ C0] ip_local_deliver+0x19d/0x480
[ 2267.044586][ C0] ? __pfx_ip_local_deliver+0x10/0x10
[ 2267.044898][ C0] ? tcp_v4_early_demux+0x59a/0x9d0
[ 2267.045178][ C0] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 2267.045509][ C0] ip_rcv+0x564/0x740
[ 2267.045761][ C0] ? __pfx_ip_rcv+0x10/0x10
[ 2267.046001][ C0] ? lock_acquire.part.0+0xe5/0x330
[ 2267.046294][ C0] ? netif_receive_skb_internal+0x84/0x300
[ 2267.046623][ C0] ? __pfx_ip_rcv+0x10/0x10
[ 2267.046886][ C0] __netif_receive_skb_one_core+0x166/0x1b0
[ 2267.047238][ C0] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 2267.047593][ C0] ? mark_held_locks+0xa5/0xf0
[ 2267.047861][ C0] ? lock_acquire+0x1c1/0x220
[ 2267.048130][ C0] ? netif_receive_skb_internal+0x84/0x300
[ 2267.048444][ C0] netif_receive_skb_internal+0xb0/0x300
[ 2267.048758][ C0] ? __pfx_netif_receive_skb_internal+0x10/0x10
[ 2267.049088][ C0] ? __copy_skb_header+0xaf/0x490
[ 2267.049364][ C0] ? __skb_clone+0x57a/0x760
[ 2267.049613][ C0] netif_receive_skb+0x55/0x280
[ 2267.049880][ C0] tcf_mirred_to_dev+0x444/0xd70 [act_mirred]
[ 2267.050226][ C0] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit]
[ 2267.050587][ C0] tcf_mirred_act+0x338/0x780 [act_mirred]
[ 2267.050900][ C0] tcf_action_exec.part.0+0x112/0x3d0
[ 2267.051195][ C0] fl_classify+0x4dc/0x650 [cls_flower]
[ 2267.051511][ C0] ? __pfx_fl_classify+0x10/0x10 [cls_flower]
[ 2267.051836][ C0] ? __pfx_check_irq_usage+0x10/0x10
[ 2267.052120][ C0] ? __bfs+0x247/0x650
[ 2267.052339][ C0] ? __pfx_hlock_conflict+0x10/0x10
[ 2267.052638][ C0] ? check_path.constprop.0+0x24/0x50
[ 2267.052925][ C0] ? check_noncircular+0x14e/0x3e0
[ 2267.053198][ C0] ? __pfx_check_noncircular+0x10/0x10
[ 2267.053482][ C0] ? __pfx_validate_chain+0x10/0x10
[ 2267.053770][ C0] ? hlock_class+0x4e/0x130
[ 2267.054011][ C0] ? hlock_class+0x4e/0x130
[ 2267.054257][ C0] ? check_prev_add+0x773/0xce0
[ 2267.054524][ C0] __tcf_classify+0x329/0x7d0
[ 2267.054778][ C0] tcf_classify+0x283/0x930
[ 2267.055055][ C0] ? __pfx_tcf_classify+0x10/0x10
[ 2267.055324][ C0] ? __dev_queue_xmit+0x1da/0x17e0
[ 2267.055619][ C0] ? __dev_queue_xmit+0x1da/0x17e0
[ 2267.055899][ C0] tc_run+0x2e4/0x5d0
[ 2267.056119][ C0] ? __pfx_tc_run+0x10/0x10
[ 2267.056365][ C0] ? lock_acquire+0x1c1/0x220
[ 2267.056630][ C0] ? __dev_queue_xmit+0x1da/0x17e0
[ 2267.056922][ C0] __dev_queue_xmit+0x686/0x17e0
[ 2267.057181][ C0] ? mark_held_locks+0xa5/0xf0
[ 2267.057432][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370
[ 2267.057819][ C0] ? __pfx___dev_queue_xmit+0x10/0x10
[ 2267.058110][ C0] ? neigh_hh_output+0x348/0x590
[ 2267.058384][ C0] ip_finish_output2+0x786/0x18e0
[ 2267.058671][ C0] ? __pfx_ip_finish_output2+0x10/0x10
[ 2267.058987][ C0] ? __ip_finish_output+0x3dd/0x770
[ 2267.059266][ C0] ip_output+0x16b/0x4f0
[ 2267.059500][ C0] ? mark_held_locks+0xa5/0xf0
[ 2267.059756][ C0] ? __pfx_ip_output+0x10/0x10
[ 2267.060024][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2267.060361][ C0] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370
[ 2267.060732][ C0] ? ip_local_out+0x114/0x3b0
[ 2267.060986][ C0] __ip_queue_xmit+0x672/0x17b0
[ 2267.061258][ C0] ? __skb_clone+0x57a/0x760
[ 2267.061512][ C0] __tcp_transmit_skb+0x22b1/0x2d20
[ 2267.061809][ C0] ? __pfx___tcp_transmit_skb+0x10/0x10
[ 2267.062141][ C0] ? tcp_small_queue_check.isra.0+0xe9/0x380
[ 2267.062464][ C0] tcp_write_xmit+0x94f/0x1cb0
[ 2267.062746][ C0] ? ipv4_mtu+0x37/0x360
[ 2267.063000][ C0] ? __pfx_tcp_write_xmit+0x10/0x10
[ 2267.063278][ C0] ? __pfx_tcp_current_mss+0x10/0x10
[ 2267.063585][ C0] __tcp_push_pending_frames+0x96/0x320
[ 2267.063904][ C0] tcp_rcv_state_process+0x77c/0x1fd0
[ 2267.064211][ C0] ? tcp_v4_rcv+0x221e/0x2ac0
[ 2267.064464][ C0] ? hlock_class+0x4e/0x130
[ 2267.064714][ C0] ? __lock_acquired+0x18a/0x6b0
[ 2267.064976][ C0] ? __pfx_tcp_rcv_state_process+0x10/0x10
[ 2267.065278][ C0] ? __pfx___lock_acquired+0x10/0x10
[ 2267.065573][ C0] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 2267.065883][ C0] tcp_v4_do_rcv+0x154/0x860
[ 2267.066154][ C0] tcp_v4_rcv+0x2449/0x2ac0
[ 2267.066419][ C0] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 2267.066688][ C0] ? __pfx_raw_v4_input+0x10/0x10
[ 2267.066956][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2267.067267][ C0] ip_protocol_deliver_rcu+0x93/0x360
[ 2267.067569][ C0] ip_local_deliver_finish+0x2ae/0x480
[ 2267.067877][ C0] ip_local_deliver+0x19d/0x480
[ 2267.068168][ C0] ? __pfx_ip_local_deliver+0x10/0x10
[ 2267.068467][ C0] ? tcp_v4_early_demux+0x59a/0x9d0
[ 2267.068772][ C0] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 2267.069114][ C0] ip_rcv+0x564/0x740
[ 2267.069327][ C0] ? __pfx_ip_rcv+0x10/0x10
[ 2267.069575][ C0] ? lock_acquire.part.0+0xe5/0x330
[ 2267.069870][ C0] ? process_backlog+0x1ed/0x5e0
[ 2267.070140][ C0] ? __pfx_ip_rcv+0x10/0x10
[ 2267.070384][ C0] __netif_receive_skb_one_core+0x166/0x1b0
[ 2267.070722][ C0] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 2267.071072][ C0] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 2267.071382][ C0] ? lock_acquire+0x1c1/0x220
[ 2267.071651][ C0] ? process_backlog+0x1ed/0x5e0
[ 2267.071926][ C0] process_backlog+0xd3/0x5e0
[ 2267.072190][ C0] __napi_poll.constprop.0+0xa2/0x460
[ 2267.072503][ C0] net_rx_action+0x440/0xb40
[ 2267.072766][ C0] ? __pfx_net_rx_action+0x10/0x10
[ 2267.073051][ C0] ? kvm_clock_get_cycles+0x18/0x30
[ 2267.073341][ C0] ? ktime_get_raw_ts64+0x230/0x240
[ 2267.073636][ C0] ? hrtimer_interrupt+0x30e/0x770
[ 2267.073919][ C0] ? clockevents_program_event+0x1ea/0x300
[ 2267.074226][ C0] __do_softirq+0x1b9/0x7ff
[ 2267.074474][ C0] irq_exit_rcu+0x98/0xc0
[ 2267.074712][ C0] sysvec_apic_timer_interrupt+0x75/0x80
[ 2267.075008][ C0] </IRQ>
[ 2267.075180][ C0] <TASK>
[ 2267.075343][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20
[ 2267.075665][ C0] RIP: 0010:finish_task_switch.isra.0+0x21f/0x8b0
[ 2267.076032][ C0] Code: 89 ff 48 c7 03 00 00 00 00 ff d2 0f 1f 00 4d 85 e4 75 ba 4c 89 ff e8 90 c0 65 02 e8 8b 99 2c 00 fb 65 48 8b 1c 25 c0 b6 1f 00 <66> 90 48 83 7d d0 00 74 56 65 48 8b 1c 25 c0 b6 1f 00 48 8d bb e8
[ 2267.077038][ C0] RSP: 0018:ffffc9000025fa48 EFLAGS: 00000202
[ 2267.077361][ C0] RAX: 000000000009d457 RBX: ffff88800e10cc40 RCX: 1ffffffff4b9c839
[ 2267.077791][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa1a3f7a5
[ 2267.078203][ C0] RBP: ffffc9000025fa88 R08: 0000000000000001 R09: fffffbfff4b9cec2
[ 2267.078626][ C0] R10: ffffffffa5ce7617 R11: ffff8880353fc348 R12: ffff8880353fc198
[ 2267.079071][ C0] R13: ffffffffa501ce00 R14: 0000000000000003 R15: ffff8880353fc180
[ 2267.079491][ C0] ? finish_task_switch.isra.0+0x215/0x8b0
[ 2267.079805][ C0] ? finish_task_switch.isra.0+0x215/0x8b0
[ 2267.080114][ C0] ? __switch_to+0x5df/0xfa0
[ 2267.080370][ C0] __schedule+0x70d/0x1ac0
[ 2267.080605][ C0] ? __pfx___schedule+0x10/0x10
[ 2267.080869][ C0] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2267.081170][ C0] ? schedule+0x1fe/0x280
[ 2267.081398][ C0] schedule+0xeb/0x280
[ 2267.081634][ C0] pipe_write+0xb3b/0x1840
[ 2267.081880][ C0] ? hlock_class+0x4e/0x130
[ 2267.082127][ C0] ? __pfx_pipe_write+0x10/0x10
[ 2267.082386][ C0] ? __mark_inode_dirty+0x6f5/0x900
[ 2267.082669][ C0] ? __pfx_autoremove_wake_function+0x10/0x10
[ 2267.083012][ C0] ? __up_write+0x190/0x520
[ 2267.083263][ C0] vfs_write+0xac1/0x10a0
[ 2267.083497][ C0] ? __pfx_vfs_write+0x10/0x10
[ 2267.083760][ C0] ? __fget_light+0x54/0x1e0
[ 2267.084013][ C0] ksys_write+0x17a/0x1e0
[ 2267.084249][ C0] ? __pfx_ksys_write+0x10/0x10
[ 2267.084514][ C0] do_syscall_64+0xc9/0x1e0
[ 2267.084762][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77
[ 2267.085076][ C0] RIP: 0033:0x7fc81c2df957
[ 2267.085327][ C0] 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
[ 2267.086337][ C0] RSP: 002b:00007fff180b70f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 2267.086782][ C0] RAX: ffffffffffffffda RBX: 0000559b8bbc9a20 RCX: 00007fc81c2df957
[ 2267.087197][ C0] RDX: 0000000000002000 RSI: 00007fff180b7110 RDI: 0000000000000001
[ 2267.087610][ C0] RBP: 0000000000000008 R08: 0000000000000000 R09: 0000000000000000
[ 2267.088035][ C0] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000002000
[ 2267.088444][ C0] R13: 00007fff180b7110 R14: 0000000000000000 R15: 00007fff180b710c
[ 2267.088873][ C0] </TASK>
[ 2282.011579][ T6469] ncat (6469) used greatest stack depth: 20784 bytes left
TEST: mirred_egress_to_ingress_tcp (skip_hw) [ OK ]
# INFO: Could not test offloaded functionality
ok 1 selftests: net/forwarding: tc_actions.sh
make[1]: Leaving directory '/home/virtme/testing-4/tools/testing/selftests/net/forwarding'
make: Leaving directory '/home/virtme/testing-4/tools/testing/selftests'
xx__-> echo $?
0
xx__->