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
# timeout set to 10800
# selftests: net/forwarding: tc_actions.sh
[ 1858.479014][T12583] veth1: left promiscuous mode
# TEST: gact drop and ok (skip_hw) [ OK ]
[ 1869.221559][T12688] Mirror/redirect action on
# TEST: mirred egress flower redirect (skip_hw) [ OK ]
# TEST: mirred egress flower mirror (skip_hw) [ OK ]
# TEST: mirred egress matchall mirror (skip_hw) [ OK ]
[ 1877.470295][T12827] ping (12827) used greatest stack depth: 23352 bytes left
# TEST: mirred_egress_to_ingress (skip_hw) [ OK ]
# [ 1880.762304][ C1]
[ 1880.762466][ C1] ============================================
[ 1880.762792][ C1] WARNING: possible recursive locking detected
[ 1880.763109][ C1] 6.8.0-rc2-virtme #1 Not tainted
[ 1880.763401][ C1] --------------------------------------------
[ 1880.763739][ C1] swapper/1/0 is trying to acquire lock:
[ 1880.764056][ C1] ffff88800a279b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 1880.764570][ C1]
[ 1880.764570][ C1] but task is already holding lock:
[ 1880.764965][ C1] ffff88800a278e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 1880.765483][ C1]
[ 1880.765483][ C1] other info that might help us debug this:
[ 1880.765913][ C1] Possible unsafe locking scenario:
[ 1880.765913][ C1]
[ 1880.766320][ C1] CPU0
[ 1880.766520][ C1] ----
[ 1880.766699][ C1] lock(slock-AF_INET/1);
[ 1880.766968][ C1] lock(slock-AF_INET/1);
[ 1880.767222][ C1]
[ 1880.767222][ C1] *** DEADLOCK ***
[ 1880.767222][ C1]
[ 1880.767672][ C1] May be due to missing lock nesting notation
[ 1880.767672][ C1]
[ 1880.768120][ C1] 8 locks held by swapper/1/0:
[ 1880.768403][ C1] #0: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0
[ 1880.768929][ C1] #1: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450
[ 1880.769513][ C1] #2: ffff88800a278e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 1880.770035][ C1] #3: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x1910
[ 1880.770576][ C1] #4: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0
[ 1880.771104][ C1] #5: ffffffffa5b44780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1c1/0x1ca0
[ 1880.771666][ C1] #6: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300
[ 1880.772248][ C1] #7: ffffffffa5b447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450
[ 1880.772819][ C1]
[ 1880.772819][ C1] stack backtrace:
[ 1880.773146][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.8.0-rc2-virtme #1
[ 1880.773580][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 1880.774236][ C1] Call Trace:
[ 1880.774426][ C1]
[ 1880.774584][ C1] dump_stack_lvl+0x64/0xb0
[ 1880.774837][ C1] validate_chain+0x525/0xa00
[ 1880.775088][ C1] ? __pfx_validate_chain+0x10/0x10
[ 1880.775374][ C1] ? hlock_class+0x4e/0x130
[ 1880.775610][ C1] ? mark_lock+0x38/0x3e0
[ 1880.775844][ C1] __lock_acquire+0xb67/0x1610
[ 1880.776106][ C1] ? lock_downgrade+0xa0/0x110
[ 1880.776360][ C1] ? mark_lock+0x38/0x3e0
[ 1880.776620][ C1] lock_acquire.part.0+0xe5/0x330
[ 1880.776888][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 1880.777165][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 1880.777489][ C1] ? __pfx_sk_filter_trim_cap+0x10/0x10
[ 1880.777815][ C1] ? lock_acquire+0x1c1/0x220
[ 1880.778079][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 1880.778360][ C1] _raw_spin_lock_nested+0x33/0x80
[ 1880.778652][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 1880.778913][ C1] tcp_v4_rcv+0x2161/0x29c0
[ 1880.779183][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 1880.779469][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 1880.779739][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 1880.780054][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 1880.780342][ C1] ip_local_deliver_finish+0x2ae/0x450
[ 1880.780650][ C1] ip_local_deliver+0x19d/0x480
[ 1880.780906][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 1880.781220][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 1880.781568][ C1] ip_rcv+0x564/0x740
[ 1880.781800][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 1880.782057][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 1880.782359][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 1880.782669][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 1880.782920][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 1880.783246][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 1880.783609][ C1] ? lock_acquire+0x1c1/0x220
[ 1880.783873][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 1880.784210][ C1] netif_receive_skb_internal+0xb0/0x300
[ 1880.784525][ C1] ? __pfx_netif_receive_skb_internal+0x10/0x10
[ 1880.784868][ C1] ? __copy_skb_header+0xaf/0x490
[ 1880.785136][ C1] ? __skb_clone+0x57a/0x760
[ 1880.785397][ C1] netif_receive_skb+0x55/0x280
[ 1880.785674][ C1] tcf_mirred_to_dev+0x444/0xd70 [act_mirred]
[ 1880.786037][ C1] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit]
[ 1880.786397][ C1] tcf_mirred_act+0x338/0x780 [act_mirred]
[ 1880.786757][ C1] tcf_action_exec.part.0+0x115/0x3d0
[ 1880.787043][ C1] fl_classify+0x4dc/0x650 [cls_flower]
[ 1880.787347][ C1] ? __pfx_fl_classify+0x10/0x10 [cls_flower]
[ 1880.787698][ C1] ? hlock_class+0x4e/0x130
[ 1880.787953][ C1] ? hlock_class+0x4e/0x130
[ 1880.788215][ C1] ? validate_chain+0x130/0xa00
[ 1880.788482][ C1] ? __lock_acquire+0xb67/0x1610
[ 1880.788772][ C1] ? hlock_class+0x4e/0x130
[ 1880.789007][ C1] ? validate_chain+0x130/0xa00
[ 1880.789274][ C1] ? hlock_class+0x4e/0x130
[ 1880.789514][ C1] ? validate_chain+0x130/0xa00
[ 1880.789803][ C1] ? __pfx_validate_chain+0x10/0x10
[ 1880.790095][ C1] ? hlock_class+0x4e/0x130
[ 1880.790351][ C1] ? mark_lock+0x38/0x3e0
[ 1880.790582][ C1] ? __lock_acquire+0xb67/0x1610
[ 1880.790861][ C1] __tcf_classify+0x32c/0x7d0
[ 1880.791113][ C1] tcf_classify+0x283/0x930
[ 1880.791368][ C1] ? hlock_class+0x4e/0x130
[ 1880.791609][ C1] ? __pfx_tcf_classify+0x10/0x10
[ 1880.791876][ C1] ? trace_rcu_dyntick+0x10a/0x150
[ 1880.792161][ C1] tc_run+0x2e4/0x5d0
[ 1880.792390][ C1] ? __pfx_tc_run+0x10/0x10
[ 1880.792656][ C1] __dev_queue_xmit+0x8eb/0x1ca0
[ 1880.792952][ C1] ? mark_lock+0x38/0x3e0
[ 1880.793204][ C1] ? mark_held_locks+0xa5/0xf0
[ 1880.793468][ C1] ? __pfx___dev_queue_xmit+0x10/0x10
[ 1880.793782][ C1] ? neigh_hh_output+0x348/0x590
[ 1880.794042][ C1] ? vrf_ip_local_out+0x781/0x860 [vrf]
[ 1880.794355][ C1] ip_finish_output2+0x786/0x18e0
[ 1880.794643][ C1] ? __pfx_ip_finish_output2+0x10/0x10
[ 1880.794952][ C1] ? __ip_finish_output+0x3dd/0x770
[ 1880.795238][ C1] ip_output+0x16b/0x4f0
[ 1880.795482][ C1] ? __pfx_ip_output+0x10/0x10
[ 1880.795746][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 1880.796060][ C1] ? ip_local_out+0x114/0x3b0
[ 1880.796334][ C1] __ip_queue_xmit+0x672/0x1910
[ 1880.796621][ C1] __tcp_transmit_skb+0x22b1/0x2d20
[ 1880.796924][ C1] ? __pfx___tcp_transmit_skb+0x10/0x10
[ 1880.797251][ C1] ? tcp_small_queue_check.isra.0+0xe9/0x380
[ 1880.797593][ C1] tcp_write_xmit+0xe42/0x24c0
[ 1880.797852][ C1] ? ipv4_mtu+0x37/0x360
[ 1880.798088][ C1] ? __pfx_tcp_write_xmit+0x10/0x10
[ 1880.798382][ C1] ? __pfx_tcp_current_mss+0x10/0x10
[ 1880.798692][ C1] ? ktime_get+0x157/0x190
[ 1880.798941][ C1] __tcp_push_pending_frames+0x96/0x320
[ 1880.799247][ C1] tcp_rcv_state_process+0x862/0x21c0
[ 1880.799534][ C1] ? __pfx_tcp_rcv_state_process+0x10/0x10
[ 1880.799852][ C1] ? find_held_lock+0x33/0x120
[ 1880.800105][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 1880.800415][ C1] ? hlock_class+0x4e/0x130
[ 1880.800670][ C1] tcp_v4_do_rcv+0x1ac/0x8e0
[ 1880.800940][ C1] ? __pfx_tcp_v4_do_rcv+0x10/0x10
[ 1880.801223][ C1] tcp_v4_rcv+0x2362/0x29c0
[ 1880.801490][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 1880.801783][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 1880.802066][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 1880.802377][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 1880.802657][ C1] ip_local_deliver_finish+0x2ae/0x450
[ 1880.802958][ C1] ip_local_deliver+0x19d/0x480
[ 1880.803218][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 1880.803517][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 1880.803851][ C1] ip_rcv+0x564/0x740
[ 1880.804087][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 1880.804346][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 1880.804658][ C1] ? process_backlog+0x1ed/0x5e0
[ 1880.804931][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 1880.805202][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 1880.805522][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 1880.805894][ C1] ? lock_acquire+0x1c1/0x220
[ 1880.806141][ C1] ? process_backlog+0x1ed/0x5e0
[ 1880.806429][ C1] process_backlog+0xd3/0x5e0
[ 1880.806712][ C1] __napi_poll.constprop.0+0xa5/0x450
[ 1880.806998][ C1] net_rx_action+0x440/0xb40
[ 1880.807261][ C1] ? __pfx_net_rx_action+0x10/0x10
[ 1880.807531][ C1] __do_softirq+0x1bc/0x7ff
[ 1880.807784][ C1] irq_exit_rcu+0x98/0xc0
[ 1880.808016][ C1] sysvec_apic_timer_interrupt+0x75/0x80
[ 1880.808349][ C1]
[ 1880.808504][ C1]
[ 1880.808691][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20
[ 1880.809023][ C1] RIP: 0010:default_idle+0xf/0x20
[ 1880.809302][ C1] Code: 4c 01 c7 4c 29 c2 e9 72 ff ff ff 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 f3 0f 1e fa eb 07 0f 00 2d 73 82 41 00 fb f4 c3 cc cc cc cc 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90
[ 1880.810315][ C1] RSP: 0018:ffffc9000013fdf8 EFLAGS: 00000202
[ 1880.810654][ C1] RAX: 000000000159de97 RBX: 1ffff92000027fc1 RCX: ffffffffa4848942
[ 1880.811070][ C1] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa22968b6
[ 1880.811505][ C1] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006afeea4
[ 1880.811922][ C1] R10: ffff8880357f7523 R11: ffff8880357fc348 R12: 0000000000000000
[ 1880.812336][ C1] R13: ffff888001d0bec0 R14: dffffc0000000000 R15: 0000000000000000
[ 1880.812770][ C1] ? ct_kernel_exit.constprop.0+0xc2/0xe0
[ 1880.813086][ C1] ? cpuidle_idle_call+0x1f6/0x280
[ 1880.813390][ C1] default_idle_call+0x69/0xa0
[ 1880.813653][ C1] cpuidle_idle_call+0x1f6/0x280
[ 1880.813924][ C1] ? __pfx_cpuidle_idle_call+0x10/0x10
[ 1880.814249][ C1] do_idle+0xfb/0x160
[ 1880.814483][ C1] cpu_startup_entry+0x55/0x60
[ 1880.814732][ C1] start_secondary+0x21c/0x2b0
[ 1880.815005][ C1] ? __pfx_start_secondary+0x10/0x10
[ 1880.815280][ C1] secondary_startup_64_no_verify+0x16d/0x17b
[ 1880.815615][ C1]
[ 1907.326865][ C1] irq 4: nobody cared (try booting with the "irqpoll" option)
[ 1907.327272][ C1] CPU: 1 PID: 12523 Comm: perl Not tainted 6.8.0-rc2-virtme #1
[ 1907.327675][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 1907.328305][ C1] Call Trace:
[ 1907.328495][ C1]
[ 1907.328650][ C1] dump_stack_lvl+0x64/0xb0
[ 1907.328899][ C1] __report_bad_irq+0x5f/0x180
[ 1907.329156][ C1] note_interrupt+0x6b3/0x860
[ 1907.329403][ C1] handle_irq_event+0x16d/0x1c0
[ 1907.329661][ C1] handle_edge_irq+0x1fa/0xb60
[ 1907.329914][ C1] __common_interrupt+0x7f/0x180
[ 1907.330178][ C1] common_interrupt+0x7e/0x90
[ 1907.330423][ C1]
[ 1907.330576][ C1]
[ 1907.330730][ C1] asm_common_interrupt+0x26/0x40
[ 1907.330997][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x43/0x70
[ 1907.331332][ C1] Code: 10 e8 71 8a a6 fd 48 89 ef e8 89 12 a7 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 07 98 5b <74> 0e 5b 5d c3 cc cc cc cc e8 7f 1a c9 fd eb dc 0f 1f 44 00 00 5b
[ 1907.332331][ C1] RSP: 0018:ffffc9000941fa88 EFLAGS: 00000286
[ 1907.332649][ C1] RAX: 0000000000000046 RBX: 0000000000000200 RCX: 1ffffffff4c9c29b
[ 1907.333058][ C1] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffffa487afd1
[ 1907.333466][ C1] RBP: ffffffffa86259a0 R08: 0000000000000000 R09: fffffbfff4c9c052
[ 1907.333876][ C1] R10: ffffffffa64e0297 R11: 0000000000000000 R12: 00000000000008d7
[ 1907.334299][ C1] R13: ffffffffa8625ab0 R14: ffffffffa86259a0 R15: ffff888004f70000
[ 1907.334716][ C1] ? _raw_spin_unlock_irqrestore+0x51/0x70
[ 1907.335026][ C1] uart_write+0x220/0x440
[ 1907.335257][ C1] process_output_block+0x141/0x790
[ 1907.335532][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 1907.335847][ C1] n_tty_write+0x414/0x7a0
[ 1907.336087][ C1] ? __pfx_n_tty_write+0x10/0x10
[ 1907.336346][ C1] ? __pfx_woken_wake_function+0x10/0x10
[ 1907.336646][ C1] ? lock_acquire+0x1c1/0x220
[ 1907.336894][ C1] ? iterate_tty_write+0x95/0x540
[ 1907.337161][ C1] iterate_tty_write+0x22c/0x540
[ 1907.337423][ C1] file_tty_write.constprop.0+0x1db/0x370
[ 1907.337723][ C1] vfs_write+0x9ec/0x10a0
[ 1907.337955][ C1] ? lock_acquire+0x1c1/0x220
[ 1907.338202][ C1] ? __might_fault+0xc6/0x180
[ 1907.338454][ C1] ? __pfx_vfs_write+0x10/0x10
[ 1907.338706][ C1] ? __might_fault+0xc6/0x180
[ 1907.338951][ C1] ? lock_release+0x1d5/0x250
[ 1907.339196][ C1] ? kvm_clock_get_cycles+0x18/0x30
[ 1907.339469][ C1] ? __fget_light+0x54/0x1e0
[ 1907.339718][ C1] ksys_write+0xf5/0x1e0
[ 1907.339941][ C1] ? __pfx_ksys_write+0x10/0x10
[ 1907.340194][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 1907.340511][ C1] do_syscall_64+0xcc/0x1e0
[ 1907.340755][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77
[ 1907.341069][ C1] RIP: 0033:0x7ffac3f87957
[ 1907.341305][ 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
[ 1907.342303][ C1] RSP: 002b:00007fff5370da58 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 1907.342737][ C1] RAX: ffffffffffffffda RBX: 0000564435073ea0 RCX: 00007ffac3f87957
[ 1907.343155][ C1] RDX: 0000000000000001 RSI: 0000564435073ea0 RDI: 0000000000000001
[ 1907.343571][ C1] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000
[ 1907.343993][ C1] R10: 0000000000000001 R11: 0000000000000246 R12: 0000564435060510
[ 1907.344407][ C1] R13: 00005644350412a0 R14: 0000000000000001 R15: 0000564435060510
[ 1907.344821][ C1]
[ 1907.344983][ C1] handlers:
[ 1907.345148][ C1] [] serial8250_interrupt
[ 1907.345467][ C1] Disabling IRQ #4
[ 1908.337842][T12881] ncat (12881) used greatest stack depth: 21056 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