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
# TEST: gact drop and ok (skip_hw) [ OK ]
[ 2363.562801][T18708] 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 ]
[ 2374.520985][T18822] ping (18822) used greatest stack depth: 23352 bytes left
# TEST: mirred_egress_to_ingress (skip_hw) [ OK ]
# [ 2379.072223][ C1]
[ 2379.072383][ C1] ============================================
[ 2379.072691][ C1] WARNING: possible recursive locking detected
[ 2379.073024][ C1] 6.8.0-rc2-virtme #1 Not tainted
[ 2379.073284][ C1] --------------------------------------------
[ 2379.073609][ C1] ncat/18865 is trying to acquire lock:
[ 2379.073884][ C1] ffff88800a9b0e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 2379.074361][ C1]
[ 2379.074361][ C1] but task is already holding lock:
[ 2379.074743][ C1] ffff88800a9b1b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 2379.075228][ C1]
[ 2379.075228][ C1] other info that might help us debug this:
[ 2379.075626][ C1] Possible unsafe locking scenario:
[ 2379.075626][ C1]
[ 2379.075995][ C1] CPU0
[ 2379.076178][ C1] ----
[ 2379.076346][ C1] lock(slock-AF_INET/1);
[ 2379.076583][ C1] lock(slock-AF_INET/1);
[ 2379.076815][ C1]
[ 2379.076815][ C1] *** DEADLOCK ***
[ 2379.076815][ C1]
[ 2379.077241][ C1] May be due to missing lock nesting notation
[ 2379.077241][ C1]
[ 2379.077658][ C1] 8 locks held by ncat/18865:
[ 2379.077898][ C1] #0: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0
[ 2379.078392][ C1] #1: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450
[ 2379.078938][ C1] #2: ffff88800a9b1b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2161/0x29c0
[ 2379.079426][ C1] #3: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x1910
[ 2379.079919][ C1] #4: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0
[ 2379.080421][ C1] #5: ffffffff89d44780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1c1/0x1ca0
[ 2379.080941][ C1] #6: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300
[ 2379.081475][ C1] #7: ffffffff89d447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450
[ 2379.081985][ C1]
[ 2379.081985][ C1] stack backtrace:
[ 2379.082311][ C1] CPU: 1 PID: 18865 Comm: ncat Not tainted 6.8.0-rc2-virtme #1
[ 2379.082712][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 2379.083327][ C1] Call Trace:
[ 2379.083508][ C1]
[ 2379.083656][ C1] dump_stack_lvl+0x64/0xb0
[ 2379.083905][ C1] validate_chain+0x525/0xa00
[ 2379.084162][ C1] ? __pfx_validate_chain+0x10/0x10
[ 2379.084437][ C1] ? hlock_class+0x4e/0x130
[ 2379.084667][ C1] ? mark_lock+0x38/0x3e0
[ 2379.084900][ C1] __lock_acquire+0xb67/0x1610
[ 2379.085159][ C1] ? lock_downgrade+0xa0/0x110
[ 2379.085415][ C1] ? mark_lock+0x38/0x3e0
[ 2379.085634][ C1] lock_acquire.part.0+0xe5/0x330
[ 2379.085901][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 2379.086157][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2379.086454][ C1] ? __pfx_sk_filter_trim_cap+0x10/0x10
[ 2379.086735][ C1] ? lock_acquire+0x1c1/0x220
[ 2379.086982][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 2379.087235][ C1] _raw_spin_lock_nested+0x33/0x80
[ 2379.087510][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 2379.087747][ C1] tcp_v4_rcv+0x2161/0x29c0
[ 2379.087993][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 2379.088249][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 2379.088519][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2379.088806][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 2379.089089][ C1] ip_local_deliver_finish+0x2ae/0x450
[ 2379.089375][ C1] ip_local_deliver+0x19d/0x480
[ 2379.089637][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 2379.089925][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 2379.090256][ C1] ip_rcv+0x564/0x740
[ 2379.090473][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 2379.090706][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 2379.090979][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 2379.091288][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 2379.091533][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 2379.091831][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 2379.092167][ C1] ? lock_acquire+0x1c1/0x220
[ 2379.092431][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 2379.092726][ C1] netif_receive_skb_internal+0xb0/0x300
[ 2379.093018][ C1] ? __pfx_netif_receive_skb_internal+0x10/0x10
[ 2379.093352][ C1] ? __copy_skb_header+0xaf/0x490
[ 2379.093621][ C1] ? __skb_clone+0x57a/0x760
[ 2379.093855][ C1] netif_receive_skb+0x55/0x280
[ 2379.094114][ C1] tcf_mirred_to_dev+0x444/0xd70 [act_mirred]
[ 2379.094436][ C1] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit]
[ 2379.094783][ C1] tcf_mirred_act+0x338/0x780 [act_mirred]
[ 2379.095095][ C1] tcf_action_exec.part.0+0x112/0x3d0
[ 2379.095383][ C1] fl_classify+0x4dc/0x650 [cls_flower]
[ 2379.095691][ C1] ? __pfx_fl_classify+0x10/0x10 [cls_flower]
[ 2379.096008][ C1] ? __pfx_usage_match+0x10/0x10
[ 2379.096274][ C1] ? check_irq_usage+0x27e/0x850
[ 2379.096543][ C1] ? __pfx_check_irq_usage+0x10/0x10
[ 2379.096808][ C1] ? __bfs+0x247/0x650
[ 2379.097026][ C1] ? __pfx_hlock_conflict+0x10/0x10
[ 2379.097303][ C1] ? check_path.constprop.0+0x24/0x50
[ 2379.097588][ C1] ? check_noncircular+0x14e/0x3e0
[ 2379.097846][ C1] ? find_held_lock+0x33/0x120
[ 2379.098100][ C1] ? __pfx_check_noncircular+0x10/0x10
[ 2379.098391][ C1] ? hlock_class+0x4e/0x130
[ 2379.098618][ C1] ? __lock_acquired+0x18a/0x6b0
[ 2379.098888][ C1] ? __lock_release+0x40f/0x880
[ 2379.099154][ C1] __tcf_classify+0x329/0x7d0
[ 2379.099413][ C1] tcf_classify+0x283/0x930
[ 2379.099643][ C1] ? __pfx_tcf_classify+0x10/0x10
[ 2379.099908][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 2379.100184][ C1] ? __dev_queue_xmit+0x1c1/0x1ca0
[ 2379.100465][ C1] tc_run+0x2e4/0x5d0
[ 2379.100670][ C1] ? __pfx_tc_run+0x10/0x10
[ 2379.100914][ C1] ? lock_acquire+0x1c1/0x220
[ 2379.101170][ C1] ? __dev_queue_xmit+0x1c1/0x1ca0
[ 2379.101427][ C1] __dev_queue_xmit+0x8eb/0x1ca0
[ 2379.101693][ C1] ? hlock_class+0x4e/0x130
[ 2379.101923][ C1] ? mark_lock+0x38/0x3e0
[ 2379.102159][ C1] ? __pfx___dev_queue_xmit+0x10/0x10
[ 2379.102464][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370
[ 2379.102793][ C1] ? neigh_hh_output+0x348/0x590
[ 2379.103060][ C1] ip_finish_output2+0x786/0x18e0
[ 2379.103329][ C1] ? __pfx_ip_finish_output2+0x10/0x10
[ 2379.103616][ C1] ? __ip_finish_output+0x10f/0x770
[ 2379.103879][ C1] ip_output+0x16b/0x4f0
[ 2379.104106][ C1] ? __pfx_ip_output+0x10/0x10
[ 2379.104362][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2379.104661][ C1] ? kmem_cache_alloc_node+0x2b6/0x2e0
[ 2379.104951][ C1] ? ip_local_out+0x114/0x3b0
[ 2379.105205][ C1] __ip_queue_xmit+0x672/0x1910
[ 2379.105467][ C1] ? __create_object+0x5e/0xb0
[ 2379.105712][ C1] __tcp_transmit_skb+0x22b1/0x2d20
[ 2379.105989][ C1] ? __pfx___tcp_transmit_skb+0x10/0x10
[ 2379.106280][ C1] ? __tcp_send_ack.part.0+0x66/0x6e0
[ 2379.106567][ C1] tcp_rcv_state_process+0x8a7/0x21c0
[ 2379.106841][ C1] ? __pfx_tcp_rcv_state_process+0x10/0x10
[ 2379.107143][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 2379.107396][ C1] ? tcp_v4_rcv+0x2161/0x29c0
[ 2379.107633][ C1] ? hlock_class+0x4e/0x130
[ 2379.107877][ C1] tcp_v4_do_rcv+0x1ac/0x8e0
[ 2379.108126][ C1] ? __pfx_tcp_v4_do_rcv+0x10/0x10
[ 2379.108401][ C1] tcp_v4_rcv+0x2362/0x29c0
[ 2379.108635][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 2379.108891][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 2379.109160][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 2379.109458][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 2379.109730][ C1] ip_local_deliver_finish+0x2ae/0x450
[ 2379.110015][ C1] ip_local_deliver+0x19d/0x480
[ 2379.110276][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 2379.110562][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 2379.110880][ C1] ip_rcv+0x564/0x740
[ 2379.111091][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 2379.111337][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 2379.111612][ C1] ? process_backlog+0x1ed/0x5e0
[ 2379.111860][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 2379.112098][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 2379.112419][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 2379.112741][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 2379.113037][ C1] ? lock_acquire+0x1c1/0x220
[ 2379.113289][ C1] ? process_backlog+0x1ed/0x5e0
[ 2379.113538][ C1] process_backlog+0xd3/0x5e0
[ 2379.113783][ C1] __napi_poll.constprop.0+0xa2/0x450
[ 2379.114066][ C1] net_rx_action+0x440/0xb40
[ 2379.114320][ C1] ? __pfx_net_rx_action+0x10/0x10
[ 2379.114595][ C1] ? handle_irq_event+0x112/0x1c0
[ 2379.114854][ C1] __do_softirq+0x1b9/0x7ff
[ 2379.115095][ C1] ? tcp_recvmsg+0xf8/0x4f0
[ 2379.115343][ C1] do_softirq+0x4d/0xa0
[ 2379.115568][ C1]
[ 2379.115719][ C1]
[ 2379.115881][ C1] __local_bh_enable_ip+0xf6/0x120
[ 2379.116155][ C1] tcp_recvmsg+0xf8/0x4f0
[ 2379.116391][ C1] ? __pfx_tcp_recvmsg+0x10/0x10
[ 2379.116639][ C1] ? core_sys_select+0x620/0x710
[ 2379.116902][ C1] inet_recvmsg+0xf9/0x2c0
[ 2379.117138][ C1] ? __pfx_inet_recvmsg+0x10/0x10
[ 2379.117410][ C1] __sys_recvfrom+0x2fb/0x3b0
[ 2379.117649][ C1] ? __pfx___sys_recvfrom+0x10/0x10
[ 2379.117925][ C1] ? do_pselect.constprop.0+0x12b/0x1e0
[ 2379.118213][ C1] ? handle_irq_event+0x112/0x1c0
[ 2379.118484][ C1] ? __pfx_do_pselect.constprop.0+0x10/0x10
[ 2379.118783][ C1] ? handle_irq_event+0x112/0x1c0
[ 2379.119050][ C1] __x64_sys_recvfrom+0xe0/0x1c0
[ 2379.119312][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x1b1/0x370
[ 2379.119656][ C1] do_syscall_64+0xc9/0x1e0
[ 2379.119888][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77
[ 2379.120197][ C1] RIP: 0033:0x7fcbdb3394c0
[ 2379.120438][ C1] Code: 84 00 00 00 00 00 0f 1f 40 00 f3 0f 1e fa 41 89 ca 64 8b 04 25 18 00 00 00 85 c0 75 1d 45 31 c9 45 31 c0 b8 2d 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 68 c3 0f 1f 80 00 00 00 00 41 54 48 83 ec 20
[ 2379.121399][ C1] RSP: 002b:00007ffd752b0c28 EFLAGS: 00000246 ORIG_RAX: 000000000000002d
[ 2379.121836][ C1] RAX: ffffffffffffffda RBX: 0000559dacf53a20 RCX: 00007fcbdb3394c0
[ 2379.122249][ C1] RDX: 0000000000002000 RSI: 00007ffd752b0cb0 RDI: 0000000000000008
[ 2379.122668][ C1] RBP: 00007ffd752b0cb0 R08: 0000000000000000 R09: 0000000000000000
[ 2379.123063][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000008
[ 2379.123473][ C1] R13: 0000559dacf53a20 R14: 0000000000000000 R15: 00007ffd752b0cac
[ 2379.123872][ C1]
[ 2399.005296][ C1] irq 4: nobody cared (try booting with the "irqpoll" option)
[ 2399.005687][ C1] CPU: 1 PID: 18563 Comm: perl Not tainted 6.8.0-rc2-virtme #1
[ 2399.006065][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 2399.006672][ C1] Call Trace:
[ 2399.006842][ C1]
[ 2399.006992][ C1] dump_stack_lvl+0x64/0xb0
[ 2399.007229][ C1] __report_bad_irq+0x5f/0x180
[ 2399.007473][ C1] note_interrupt+0x6b3/0x860
[ 2399.007712][ C1] handle_irq_event+0x16d/0x1c0
[ 2399.007961][ C1] handle_edge_irq+0x1fa/0xb60
[ 2399.008202][ C1] __common_interrupt+0x7c/0x180
[ 2399.008455][ C1] common_interrupt+0x7e/0x90
[ 2399.008697][ C1]
[ 2399.008845][ C1]
[ 2399.008995][ C1] asm_common_interrupt+0x26/0x40
[ 2399.009253][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x43/0x70
[ 2399.009579][ C1] Code: 10 e8 e1 99 a6 fd 48 89 ef e8 f9 21 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 75 16 78 77 <74> 0e 5b 5d c3 cc cc cc cc e8 9f 2b c9 fd eb dc 0f 1f 44 00 00 5b
[ 2399.010540][ C1] RSP: 0018:ffffc90000c7fa88 EFLAGS: 00000286
[ 2399.010847][ C1] RAX: 0000000000000046 RBX: 0000000000000200 RCX: 1ffffffff14dc333
[ 2399.011243][ C1] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff88a7a061
[ 2399.011638][ C1] RBP: ffffffff8c8259a0 R08: 0000000000000000 R09: fffffbfff14dc0ea
[ 2399.012036][ C1] R10: ffffffff8a6e0757 R11: 0000000000000000 R12: 000000000000089e
[ 2399.012439][ C1] R13: ffffffff8c825ab0 R14: ffffffff8c8259a0 R15: ffff888005530000
[ 2399.012838][ C1] ? _raw_spin_unlock_irqrestore+0x51/0x70
[ 2399.013135][ C1] uart_write+0x220/0x440
[ 2399.013358][ C1] process_output_block+0x13e/0x790
[ 2399.013622][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 2399.013927][ C1] n_tty_write+0x414/0x7a0
[ 2399.014154][ C1] ? __pfx_n_tty_write+0x10/0x10
[ 2399.014403][ C1] ? __pfx_woken_wake_function+0x10/0x10
[ 2399.014688][ C1] ? lock_acquire+0x1c1/0x220
[ 2399.014931][ C1] ? iterate_tty_write+0x95/0x540
[ 2399.015186][ C1] iterate_tty_write+0x229/0x540
[ 2399.015439][ C1] file_tty_write.constprop.0+0x1db/0x370
[ 2399.015724][ C1] vfs_write+0x9e9/0x10a0
[ 2399.015946][ C1] ? __run_hrtimer+0x5df/0x710
[ 2399.016185][ C1] ? __pfx_vfs_write+0x10/0x10
[ 2399.016428][ C1] ? lock_acquire+0x1c1/0x220
[ 2399.016664][ C1] ? clockevents_program_event+0xf6/0x300
[ 2399.016954][ C1] ? kvm_clock_get_cycles+0x18/0x30
[ 2399.017220][ C1] ? __fget_light+0x54/0x1e0
[ 2399.017453][ C1] ksys_write+0xf5/0x1e0
[ 2399.017669][ C1] ? __pfx_ksys_write+0x10/0x10
[ 2399.017913][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 2399.018214][ C1] do_syscall_64+0xc9/0x1e0
[ 2399.018448][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77
[ 2399.018746][ C1] RIP: 0033:0x7f40ac1ce957
[ 2399.018971][ 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
[ 2399.019932][ C1] RSP: 002b:00007ffc4a6b17c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 2399.020351][ C1] RAX: ffffffffffffffda RBX: 000055c1ac475e70 RCX: 00007f40ac1ce957
[ 2399.020745][ C1] RDX: 0000000000000001 RSI: 000055c1ac475e70 RDI: 0000000000000001
[ 2399.021140][ C1] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000
[ 2399.021538][ C1] R10: 0000000000000001 R11: 0000000000000246 R12: 000055c1ac462530
[ 2399.021933][ C1] R13: 000055c1ac4432a0 R14: 0000000000000001 R15: 000055c1ac462530
[ 2399.022338][ C1]
[ 2399.022495][ C1] handlers:
[ 2399.022654][ C1] [] serial8250_interrupt
[ 2399.022961][ C1] Disabling IRQ #4
[ 2399.226737][T18866] ncat (18866) used greatest stack depth: 21056 bytes left
[ 2430.624519][T18865] ncat (18865) used greatest stack depth: 20416 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