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
[ 38.323722][ T329] GACT probability NOT on
# TEST: gact drop and ok (skip_hw) [ OK ]
[ 43.879541][ T386] 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 ]
[ 55.150453][ T495] ping (495) used greatest stack depth: 23480 bytes left
# TEST: mirred_egress_to_ingress (skip_hw) [ OK ]
[ 58.354005][ T533] tc (533) used greatest stack depth: 23096 bytes left
# [ 64.444015][ C1]
[ 64.444164][ C1] ============================================
[ 64.444502][ C1] WARNING: possible recursive locking detected
[ 64.444825][ C1] 6.8.0-rc2-virtme #1 Not tainted
[ 64.445091][ C1] --------------------------------------------
[ 64.445428][ C1] swapper/1/0 is trying to acquire lock:
[ 64.445725][ C1] ffff888008361b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 64.446207][ C1]
[ 64.446207][ C1] but task is already holding lock:
[ 64.446592][ C1] ffff888008360e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 64.447076][ C1]
[ 64.447076][ C1] other info that might help us debug this:
[ 64.447494][ C1] Possible unsafe locking scenario:
[ 64.447494][ C1]
[ 64.447906][ C1] CPU0
[ 64.448083][ C1] ----
[ 64.448271][ C1] lock(slock-AF_INET/1);
[ 64.448523][ C1] lock(slock-AF_INET/1);
[ 64.448775][ C1]
[ 64.448775][ C1] *** DEADLOCK ***
[ 64.448775][ C1]
[ 64.449198][ C1] May be due to missing lock nesting notation
[ 64.449198][ C1]
[ 64.449641][ C1] 8 locks held by swapper/1/0:
[ 64.449891][ C1] #0: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0
[ 64.450396][ C1] #1: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480
[ 64.450943][ C1] #2: ffff888008360e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x221e/0x2ac0
[ 64.451434][ C1] #3: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x1910
[ 64.451937][ C1] #4: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0
[ 64.452455][ C1] #5: ffffffff92744780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1da/0x17e0
[ 64.452986][ C1] #6: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300
[ 64.453526][ C1] #7: ffffffff927447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x480
[ 64.454072][ C1]
[ 64.454072][ C1] stack backtrace:
[ 64.454380][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.8.0-rc2-virtme #1
[ 64.454793][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 64.455428][ C1] Call Trace:
[ 64.455617][ C1]
[ 64.455769][ C1] dump_stack_lvl+0x64/0xb0
[ 64.456023][ C1] validate_chain+0x525/0xa00
[ 64.456274][ C1] ? __pfx_validate_chain+0x10/0x10
[ 64.456556][ C1] ? hlock_class+0x4e/0x130
[ 64.456797][ C1] ? mark_lock+0x38/0x3e0
[ 64.457042][ C1] __lock_acquire+0xb67/0x1610
[ 64.457295][ C1] ? lock_downgrade+0xa0/0x110
[ 64.457559][ C1] ? mark_lock+0x38/0x3e0
[ 64.457794][ C1] lock_acquire.part.0+0xe5/0x330
[ 64.458076][ C1] ? tcp_v4_rcv+0x221e/0x2ac0
[ 64.458325][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 64.458635][ C1] ? __pfx_sk_filter_trim_cap+0x10/0x10
[ 64.458926][ C1] ? lock_acquire+0x1c1/0x220
[ 64.459186][ C1] ? tcp_v4_rcv+0x221e/0x2ac0
[ 64.459433][ C1] _raw_spin_lock_nested+0x33/0x80
[ 64.459714][ C1] ? tcp_v4_rcv+0x221e/0x2ac0
[ 64.459959][ C1] tcp_v4_rcv+0x221e/0x2ac0
[ 64.460215][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 64.460487][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 64.460752][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 64.461065][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 64.461350][ C1] ip_local_deliver_finish+0x2ae/0x480
[ 64.461646][ C1] ip_local_deliver+0x19d/0x480
[ 64.461902][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 64.462194][ C1] ? tcp_v4_early_demux+0x59a/0x9d0
[ 64.462468][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 64.462815][ C1] ip_rcv+0x564/0x740
[ 64.463025][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 64.463279][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 64.463551][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 64.463868][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 64.464104][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 64.464429][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 64.464765][ C1] ? lock_acquire+0x1c1/0x220
[ 64.465029][ C1] ? netif_receive_skb_internal+0x84/0x300
[ 64.465334][ C1] netif_receive_skb_internal+0xb0/0x300
[ 64.465641][ C1] ? __pfx_netif_receive_skb_internal+0x10/0x10
[ 64.465969][ C1] ? __copy_skb_header+0xaf/0x490
[ 64.466247][ C1] ? __skb_clone+0x57a/0x760
[ 64.466489][ C1] netif_receive_skb+0x55/0x280
[ 64.466758][ C1] tcf_mirred_to_dev+0x444/0xd70 [act_mirred]
[ 64.467088][ C1] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit]
[ 64.467437][ C1] tcf_mirred_act+0x338/0x780 [act_mirred]
[ 64.467772][ C1] tcf_action_exec.part.0+0x112/0x3d0
[ 64.468056][ C1] fl_classify+0x4dc/0x650 [cls_flower]
[ 64.468361][ C1] ? __pfx_fl_classify+0x10/0x10 [cls_flower]
[ 64.468697][ C1] ? __pfx_check_irq_usage+0x10/0x10
[ 64.468980][ C1] ? __bfs+0x247/0x650
[ 64.469211][ C1] ? __pfx_hlock_conflict+0x10/0x10
[ 64.469485][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 64.469769][ C1] ? check_path.constprop.0+0x24/0x50
[ 64.470051][ C1] ? check_noncircular+0x14e/0x3e0
[ 64.470331][ C1] ? __lock_acquired+0x18a/0x6b0
[ 64.470591][ C1] ? __pfx_check_noncircular+0x10/0x10
[ 64.470897][ C1] ? hlock_class+0x4e/0x130
[ 64.471134][ C1] ? __lock_release+0x40f/0x880
[ 64.471406][ C1] ? hlock_class+0x4e/0x130
[ 64.471645][ C1] ? check_prev_add+0x773/0xce0
[ 64.471915][ C1] __tcf_classify+0x329/0x7d0
[ 64.472161][ C1] tcf_classify+0x283/0x930
[ 64.472421][ C1] ? __pfx_tcf_classify+0x10/0x10
[ 64.472685][ C1] ? __dev_queue_xmit+0x1da/0x17e0
[ 64.472954][ C1] ? __dev_queue_xmit+0x1da/0x17e0
[ 64.473238][ C1] tc_run+0x2e4/0x5d0
[ 64.473449][ C1] ? __pfx_tc_run+0x10/0x10
[ 64.473701][ C1] ? lock_acquire+0x1c1/0x220
[ 64.473952][ C1] ? __dev_queue_xmit+0x1da/0x17e0
[ 64.474234][ C1] __dev_queue_xmit+0x686/0x17e0
[ 64.474495][ C1] ? mark_held_locks+0xa5/0xf0
[ 64.474762][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370
[ 64.475106][ C1] ? __pfx___dev_queue_xmit+0x10/0x10
[ 64.475398][ C1] ? neigh_hh_output+0x348/0x590
[ 64.475662][ C1] ip_finish_output2+0x786/0x18e0
[ 64.475943][ C1] ? __pfx_ip_finish_output2+0x10/0x10
[ 64.476229][ C1] ? __ip_finish_output+0x3dd/0x770
[ 64.476516][ C1] ip_output+0x16b/0x4f0
[ 64.476742][ C1] ? mark_held_locks+0xa5/0xf0
[ 64.477009][ C1] ? __pfx_ip_output+0x10/0x10
[ 64.477260][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 64.477568][ C1] ? lockdep_hardirqs_on_prepare.part.0+0x151/0x370
[ 64.477929][ C1] ? ip_local_out+0x114/0x3b0
[ 64.478194][ C1] __ip_queue_xmit+0x672/0x1910
[ 64.478451][ C1] ? __skb_clone+0x57a/0x760
[ 64.478706][ C1] __tcp_transmit_skb+0x22b1/0x2d20
[ 64.478982][ C1] ? __pfx___tcp_transmit_skb+0x10/0x10
[ 64.479283][ C1] ? tcp_small_queue_check.isra.0+0xe9/0x380
[ 64.479597][ C1] tcp_write_xmit+0x94f/0x1cb0
[ 64.479864][ C1] ? ipv4_mtu+0x37/0x360
[ 64.480091][ C1] ? __pfx_tcp_write_xmit+0x10/0x10
[ 64.480375][ C1] ? __pfx_tcp_current_mss+0x10/0x10
[ 64.480654][ C1] __tcp_push_pending_frames+0x96/0x320
[ 64.480958][ C1] tcp_rcv_state_process+0x786/0x1fe0
[ 64.481241][ C1] ? tcp_v4_rcv+0x221e/0x2ac0
[ 64.481500][ C1] ? hlock_class+0x4e/0x130
[ 64.481740][ C1] ? __lock_acquired+0x18a/0x6b0
[ 64.482016][ C1] ? __pfx_tcp_rcv_state_process+0x10/0x10
[ 64.482320][ C1] ? __pfx___lock_acquired+0x10/0x10
[ 64.482614][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 64.482910][ C1] tcp_v4_do_rcv+0x154/0x860
[ 64.483169][ C1] tcp_v4_rcv+0x2449/0x2ac0
[ 64.483410][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10
[ 64.483682][ C1] ? __pfx_raw_v4_input+0x10/0x10
[ 64.483948][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10
[ 64.484260][ C1] ip_protocol_deliver_rcu+0x93/0x360
[ 64.484543][ C1] ip_local_deliver_finish+0x2ae/0x480
[ 64.484844][ C1] ip_local_deliver+0x19d/0x480
[ 64.485105][ C1] ? __pfx_ip_local_deliver+0x10/0x10
[ 64.485402][ C1] ? tcp_v4_early_demux+0x59a/0x9d0
[ 64.485678][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300
[ 64.486012][ C1] ip_rcv+0x564/0x740
[ 64.486237][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 64.486478][ C1] ? lock_acquire.part.0+0xe5/0x330
[ 64.486769][ C1] ? process_backlog+0x1ed/0x5e0
[ 64.487034][ C1] ? __pfx_ip_rcv+0x10/0x10
[ 64.487287][ C1] __netif_receive_skb_one_core+0x166/0x1b0
[ 64.487600][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10
[ 64.487960][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10
[ 64.488258][ C1] ? lock_acquire+0x1c1/0x220
[ 64.488522][ C1] ? process_backlog+0x1ed/0x5e0
[ 64.488790][ C1] process_backlog+0xd3/0x5e0
[ 64.489041][ C1] ? __pfx___lock_release+0x10/0x10
[ 64.489332][ C1] __napi_poll.constprop.0+0xa2/0x460
[ 64.489617][ C1] net_rx_action+0x440/0xb40
[ 64.489886][ C1] ? __pfx_net_rx_action+0x10/0x10
[ 64.490165][ C1] __do_softirq+0x1b9/0x7ff
[ 64.490420][ C1] irq_exit_rcu+0x98/0xc0
[ 64.490651][ C1] common_interrupt+0x83/0x90
[ 64.490904][ C1]
[ 64.491078][ C1]
[ 64.491237][ C1] asm_common_interrupt+0x26/0x40
[ 64.491525][ C1] RIP: 0010:default_idle+0xf/0x20
[ 64.491796][ 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 66 90 0f 00 2d a3 20 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
[ 64.492834][ C1] RSP: 0018:ffffc9000013fdf8 EFLAGS: 00000242
[ 64.493154][ C1] RAX: 00000000001ec4c1 RBX: 1ffff92000027fc1 RCX: ffffffff9144eb12
[ 64.493586][ C1] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8ee968b6
[ 64.494002][ C1] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006afeea4
[ 64.494419][ C1] R10: ffff8880357f7523 R11: ffff8880357fc348 R12: 0000000000000000
[ 64.494855][ C1] R13: ffff888001d18040 R14: dffffc0000000000 R15: 0000000000000000
[ 64.495286][ C1] ? ct_kernel_exit.constprop.0+0xc2/0xe0
[ 64.495605][ C1] ? cpuidle_idle_call+0x1f6/0x280
[ 64.495879][ C1] default_idle_call+0x69/0xa0
[ 64.496152][ C1] cpuidle_idle_call+0x1f6/0x280
[ 64.496416][ C1] ? __pfx_cpuidle_idle_call+0x10/0x10
[ 64.496720][ C1] ? tsc_verify_tsc_adjust+0x65/0x2b0
[ 64.497009][ C1] do_idle+0xfb/0x160
[ 64.497240][ C1] cpu_startup_entry+0x55/0x60
[ 64.497496][ C1] start_secondary+0x21c/0x2b0
[ 64.497775][ C1] ? __pfx_start_secondary+0x10/0x10
[ 64.498060][ C1] secondary_startup_64_no_verify+0x16d/0x17b
[ 64.498396][ C1]
[ 75.266293][ C1] irq 4: nobody cared (try booting with the "irqpoll" option)
[ 75.266693][ C1] CPU: 1 PID: 221 Comm: perl Not tainted 6.8.0-rc2-virtme #1
[ 75.267076][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[ 75.267713][ C1] Call Trace:
[ 75.267892][ C1]
[ 75.268045][ C1] dump_stack_lvl+0x64/0xb0
[ 75.268289][ C1] __report_bad_irq+0x5f/0x180
[ 75.268543][ C1] note_interrupt+0x6b3/0x860
[ 75.268790][ C1] handle_irq_event+0x16d/0x1c0
[ 75.269047][ C1] handle_edge_irq+0x1fa/0xb60
[ 75.269299][ C1] __common_interrupt+0x7c/0x180
[ 75.269563][ C1] common_interrupt+0x7e/0x90
[ 75.269813][ C1]
[ 75.269967][ C1]
[ 75.270120][ C1] asm_common_interrupt+0x26/0x40
[ 75.270387][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x43/0x70
[ 75.270725][ C1] Code: 10 e8 a1 28 a6 fd 48 89 ef e8 b9 b0 a6 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 35 a5 d7 6e <74> 0e 5b 5d c3 cc cc cc cc e8 3f 71 c8 fd eb dc 0f 1f 44 00 00 5b
[ 75.271728][ C1] RSP: 0018:ffffc90000b2fa88 EFLAGS: 00000286
[ 75.272044][ C1] RAX: 0000000000000046 RBX: 0000000000000200 RCX: 1ffffffff261c443
[ 75.272458][ C1] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff914811a1
[ 75.272868][ C1] RBP: ffffffff95227860 R08: 0000000000000000 R09: fffffbfff261c1fa
[ 75.273280][ C1] R10: ffffffff930e0fd7 R11: 0000000000000000 R12: 000000000000001f
[ 75.273690][ C1] R13: ffffffff95227970 R14: ffffffff95227860 R15: ffff888005aa0000
[ 75.274108][ C1] ? _raw_spin_unlock_irqrestore+0x51/0x70
[ 75.274412][ C1] uart_write+0x220/0x440
[ 75.274644][ C1] process_output_block+0x13e/0x790
[ 75.274917][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 75.275232][ C1] n_tty_write+0x414/0x7a0
[ 75.275467][ C1] ? __pfx_n_tty_write+0x10/0x10
[ 75.275727][ C1] ? __pfx_woken_wake_function+0x10/0x10
[ 75.276021][ C1] ? lock_acquire+0x1c1/0x220
[ 75.276266][ C1] ? iterate_tty_write+0x95/0x540
[ 75.276530][ C1] iterate_tty_write+0x229/0x540
[ 75.276792][ C1] file_tty_write.constprop.0+0x1db/0x370
[ 75.277091][ C1] vfs_write+0x9e9/0x10a0
[ 75.277320][ C1] ? lock_acquire+0x1c1/0x220
[ 75.277566][ C1] ? __might_fault+0xc6/0x180
[ 75.277823][ C1] ? __pfx_vfs_write+0x10/0x10
[ 75.278072][ C1] ? __might_fault+0xc6/0x180
[ 75.278319][ C1] ? lock_release+0x1d5/0x250
[ 75.278565][ C1] ? kvm_clock_get_cycles+0x18/0x30
[ 75.278839][ C1] ? __fget_light+0x54/0x1e0
[ 75.279085][ C1] ksys_write+0xf5/0x1e0
[ 75.279308][ C1] ? __pfx_ksys_write+0x10/0x10
[ 75.279565][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100
[ 75.279880][ C1] do_syscall_64+0xc9/0x1e0
[ 75.280119][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77
[ 75.280431][ C1] RIP: 0033:0x7f9fa0c97957
[ 75.280666][ 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
[ 75.281667][ C1] RSP: 002b:00007ffe801d82b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 75.282101][ C1] RAX: ffffffffffffffda RBX: 000055701736ae70 RCX: 00007f9fa0c97957
[ 75.282516][ C1] RDX: 0000000000000001 RSI: 000055701736ae70 RDI: 0000000000000001
[ 75.282929][ C1] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000
[ 75.283341][ C1] R10: 0000000000000001 R11: 0000000000000246 R12: 0000557017357530
[ 75.283752][ C1] R13: 00005570173382a0 R14: 0000000000000001 R15: 0000557017357530
[ 75.284169][ C1]
[ 75.284329][ C1] handlers:
[ 75.284497][ C1] [] serial8250_interrupt
[ 75.284805][ C1] Disabling IRQ #4
[ 82.143649][ T539] ncat (539) used greatest stack depth: 21312 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