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 0 # 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 ] [ 1881.328473][T12993] ping (12993) used greatest stack depth: 23352 bytes left # TEST: mirred_egress_to_ingress (skip_hw) [ OK ] # [ 1884.673796][ C1] [ 1884.673955][ C1] ============================================ [ 1884.674281][ C1] WARNING: possible recursive locking detected [ 1884.674604][ C1] 6.8.0-rc1-virtme #1 Not tainted [ 1884.674887][ C1] -------------------------------------------- [ 1884.675205][ C1] swapper/1/0 is trying to acquire lock: [ 1884.675522][ C1] ffff88800a2e9b70 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2159/0x29b0 [ 1884.676016][ C1] [ 1884.676016][ C1] but task is already holding lock: [ 1884.676405][ C1] ffff88800a2e8e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2159/0x29b0 [ 1884.676896][ C1] [ 1884.676896][ C1] other info that might help us debug this: [ 1884.677321][ C1] Possible unsafe locking scenario: [ 1884.677321][ C1] [ 1884.677705][ C1] CPU0 [ 1884.677900][ C1] ---- [ 1884.678078][ C1] lock(slock-AF_INET/1); [ 1884.678333][ C1] lock(slock-AF_INET/1); [ 1884.678579][ C1] [ 1884.678579][ C1] *** DEADLOCK *** [ 1884.678579][ C1] [ 1884.679026][ C1] May be due to missing lock nesting notation [ 1884.679026][ C1] [ 1884.679473][ C1] 8 locks held by swapper/1/0: [ 1884.679726][ C1] #0: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: process_backlog+0x1ed/0x5e0 [ 1884.680237][ C1] #1: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450 [ 1884.680780][ C1] #2: ffff88800a2e8e30 (slock-AF_INET/1){+.-.}-{2:2}, at: tcp_v4_rcv+0x2159/0x29b0 [ 1884.681285][ C1] #3: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: __ip_queue_xmit+0x65/0x1910 [ 1884.681785][ C1] #4: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: ip_finish_output2+0x262/0x18e0 [ 1884.682319][ C1] #5: ffffffff90744780 (rcu_read_lock_bh){....}-{1:2}, at: __dev_queue_xmit+0x1c1/0x1ca0 [ 1884.682846][ C1] #6: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: netif_receive_skb_internal+0x84/0x300 [ 1884.683408][ C1] #7: ffffffff907447e0 (rcu_read_lock){....}-{1:2}, at: ip_local_deliver_finish+0x1f5/0x450 [ 1884.683942][ C1] [ 1884.683942][ C1] stack backtrace: [ 1884.684284][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 6.8.0-rc1-virtme #1 [ 1884.684684][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 1884.685340][ C1] Call Trace: [ 1884.685524][ C1] [ 1884.685701][ C1] dump_stack_lvl+0x64/0xb0 [ 1884.685946][ C1] validate_chain+0x525/0xa00 [ 1884.686213][ C1] ? __pfx_validate_chain+0x10/0x10 [ 1884.686486][ C1] ? hlock_class+0x4e/0x130 [ 1884.686750][ C1] ? mark_lock+0x38/0x3e0 [ 1884.686981][ C1] __lock_acquire+0xb67/0x1610 [ 1884.687255][ C1] ? lock_downgrade+0x90/0x110 [ 1884.687514][ C1] ? mark_lock+0x38/0x3e0 [ 1884.687762][ C1] lock_acquire.part.0+0xe5/0x330 [ 1884.688031][ C1] ? tcp_v4_rcv+0x2159/0x29b0 [ 1884.688297][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1884.688604][ C1] ? __pfx_sk_filter_trim_cap+0x10/0x10 [ 1884.688915][ C1] ? lock_acquire+0x1c1/0x220 [ 1884.689164][ C1] ? tcp_v4_rcv+0x2159/0x29b0 [ 1884.689432][ C1] _raw_spin_lock_nested+0x33/0x80 [ 1884.689703][ C1] ? tcp_v4_rcv+0x2159/0x29b0 [ 1884.689974][ C1] tcp_v4_rcv+0x2159/0x29b0 [ 1884.690222][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 1884.690495][ C1] ? __pfx_raw_v4_input+0x10/0x10 [ 1884.690767][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1884.691090][ C1] ip_protocol_deliver_rcu+0x93/0x360 [ 1884.691376][ C1] ip_local_deliver_finish+0x2ae/0x450 [ 1884.691681][ C1] ip_local_deliver+0x19d/0x480 [ 1884.691942][ C1] ? __pfx_ip_local_deliver+0x10/0x10 [ 1884.692247][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300 [ 1884.692585][ C1] ip_rcv+0x564/0x740 [ 1884.692817][ C1] ? __pfx_ip_rcv+0x10/0x10 [ 1884.693060][ C1] ? lock_acquire.part.0+0xe5/0x330 [ 1884.693355][ C1] ? netif_receive_skb_internal+0x84/0x300 [ 1884.693663][ C1] ? __pfx_ip_rcv+0x10/0x10 [ 1884.693930][ C1] __netif_receive_skb_one_core+0x166/0x1b0 [ 1884.694245][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10 [ 1884.694608][ C1] ? lock_acquire+0x1c1/0x220 [ 1884.694858][ C1] ? netif_receive_skb_internal+0x84/0x300 [ 1884.695187][ C1] netif_receive_skb_internal+0xb0/0x300 [ 1884.695483][ C1] ? __pfx_netif_receive_skb_internal+0x10/0x10 [ 1884.695841][ C1] ? __copy_skb_header+0xaf/0x490 [ 1884.696109][ C1] ? __skb_clone+0x57a/0x760 [ 1884.696374][ C1] netif_receive_skb+0x55/0x280 [ 1884.696631][ C1] tcf_mirred_to_dev+0x444/0xd70 [act_mirred] [ 1884.696974][ C1] ? __pfx_tcf_skbedit_act+0x10/0x10 [act_skbedit] [ 1884.697344][ C1] ? hlock_class+0x4e/0x130 [ 1884.697584][ C1] tcf_mirred_act+0x338/0x780 [act_mirred] [ 1884.697909][ C1] tcf_action_exec.part.0+0x115/0x3d0 [ 1884.698200][ C1] fl_classify+0x4dc/0x650 [cls_flower] [ 1884.698523][ C1] ? __pfx_fl_classify+0x10/0x10 [cls_flower] [ 1884.698846][ C1] ? validate_chain+0x130/0xa00 [ 1884.699122][ C1] ? __pfx_validate_chain+0x10/0x10 [ 1884.699399][ C1] ? hlock_class+0x4e/0x130 [ 1884.699637][ C1] ? mark_lock+0x38/0x3e0 [ 1884.699889][ C1] ? __lock_acquire+0xb67/0x1610 [ 1884.700154][ C1] ? hlock_class+0x4e/0x130 [ 1884.700414][ C1] ? __lock_release+0x40f/0x880 [ 1884.700674][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1884.700994][ C1] ? kvm_sched_clock_read+0x11/0x20 [ 1884.701269][ C1] ? sched_clock+0x10/0x30 [ 1884.701530][ C1] ? sched_clock_cpu+0x6d/0x500 [ 1884.701792][ C1] ? tick_nohz_start_idle+0xa5/0x1a0 [ 1884.702092][ C1] __tcf_classify+0x32c/0x7d0 [ 1884.702342][ C1] tcf_classify+0x283/0x930 [ 1884.702607][ C1] ? __pfx_tcf_classify+0x10/0x10 [ 1884.702873][ C1] ? lock_acquire.part.0+0x113/0x330 [ 1884.703169][ C1] tc_run+0x2e4/0x5d0 [ 1884.703388][ C1] ? __pfx_tc_run+0x10/0x10 [ 1884.703631][ C1] ? lock_acquire+0x1c1/0x220 [ 1884.703900][ C1] ? __dev_queue_xmit+0x1c1/0x1ca0 [ 1884.704175][ C1] ? __dev_queue_xmit+0x1c1/0x1ca0 [ 1884.704466][ C1] __dev_queue_xmit+0x8eb/0x1ca0 [ 1884.704736][ C1] ? mark_lock+0x38/0x3e0 [ 1884.704983][ C1] ? mark_held_locks+0xa5/0xf0 [ 1884.705241][ C1] ? __pfx___dev_queue_xmit+0x10/0x10 [ 1884.705557][ C1] ? neigh_hh_output+0x348/0x590 [ 1884.705822][ C1] ? vrf_ip_local_out+0x781/0x860 [vrf] [ 1884.706137][ C1] ip_finish_output2+0x786/0x18e0 [ 1884.706403][ C1] ? __pfx_ip_finish_output2+0x10/0x10 [ 1884.706718][ C1] ? __ip_finish_output+0x3dd/0x770 [ 1884.706997][ C1] ip_output+0x16b/0x4f0 [ 1884.707246][ C1] ? __pfx_ip_output+0x10/0x10 [ 1884.707498][ C1] ? __pfx_lock_acquire.part.0+0x10/0x10 [ 1884.707815][ C1] ? __lock_release+0x40f/0x880 [ 1884.708074][ C1] ? ip_local_out+0x114/0x3b0 [ 1884.708341][ C1] __ip_queue_xmit+0x672/0x1910 [ 1884.708610][ C1] ? __skb_clone+0x57a/0x760 [ 1884.708876][ C1] __tcp_transmit_skb+0x22b1/0x2d20 [ 1884.709156][ C1] ? __pfx___tcp_transmit_skb+0x10/0x10 [ 1884.709472][ C1] ? tcp_small_queue_check.isra.0+0xe9/0x380 [ 1884.709788][ C1] tcp_write_xmit+0xe42/0x24c0 [ 1884.710067][ C1] ? ipv4_mtu+0x37/0x360 [ 1884.710294][ C1] ? __pfx_tcp_write_xmit+0x10/0x10 [ 1884.710571][ C1] ? __pfx_tcp_current_mss+0x10/0x10 [ 1884.710875][ C1] __tcp_push_pending_frames+0x96/0x320 [ 1884.711168][ C1] tcp_rcv_state_process+0x81e/0x1fd0 [ 1884.711469][ C1] ? tcp_v4_rcv+0x2159/0x29b0 [ 1884.711716][ C1] ? hlock_class+0x4e/0x130 [ 1884.711974][ C1] ? __lock_acquired+0x18a/0x6b0 [ 1884.712234][ C1] ? __pfx_tcp_rcv_state_process+0x10/0x10 [ 1884.712545][ C1] ? __pfx___lock_acquired+0x10/0x10 [ 1884.712842][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10 [ 1884.713145][ C1] tcp_v4_do_rcv+0x154/0x850 [ 1884.713412][ C1] tcp_v4_rcv+0x235a/0x29b0 [ 1884.713662][ C1] ? __pfx_tcp_v4_rcv+0x10/0x10 [ 1884.713942][ C1] ip_protocol_deliver_rcu+0x93/0x360 [ 1884.714232][ C1] ip_local_deliver_finish+0x2ae/0x450 [ 1884.714548][ C1] ip_local_deliver+0x19d/0x480 [ 1884.714810][ C1] ? __pfx_ip_local_deliver+0x10/0x10 [ 1884.715111][ C1] ? ip_rcv_finish_core.constprop.0+0x522/0x1300 [ 1884.715445][ C1] ip_rcv+0x564/0x740 [ 1884.715684][ C1] ? __pfx_ip_rcv+0x10/0x10 [ 1884.715929][ C1] ? lock_acquire.part.0+0xe5/0x330 [ 1884.716223][ C1] ? process_backlog+0x1ed/0x5e0 [ 1884.716486][ C1] ? __pfx_ip_rcv+0x10/0x10 [ 1884.716744][ C1] __netif_receive_skb_one_core+0x166/0x1b0 [ 1884.717056][ C1] ? __pfx___netif_receive_skb_one_core+0x10/0x10 [ 1884.717411][ C1] ? __pfx_do_raw_spin_trylock+0x10/0x10 [ 1884.717710][ C1] ? lock_acquire+0x1c1/0x220 [ 1884.717982][ C1] ? process_backlog+0x1ed/0x5e0 [ 1884.718247][ C1] process_backlog+0xd3/0x5e0 [ 1884.718501][ C1] __napi_poll.constprop.0+0xa5/0x450 [ 1884.718808][ C1] net_rx_action+0x440/0xb40 [ 1884.719058][ C1] ? __pfx_net_rx_action+0x10/0x10 [ 1884.719344][ C1] ? __pfx_rebalance_domains+0x10/0x10 [ 1884.719637][ C1] __do_softirq+0x1bc/0x7ff [ 1884.719895][ C1] irq_exit_rcu+0x98/0xc0 [ 1884.720124][ C1] sysvec_apic_timer_interrupt+0x75/0x80 [ 1884.720440][ C1] [ 1884.720600][ C1] [ 1884.720779][ C1] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 1884.721128][ C1] RIP: 0010:default_idle+0xf/0x20 [ 1884.721397][ 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 c3 a2 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 [ 1884.722427][ C1] RSP: 0018:ffffc9000013fdf8 EFLAGS: 00000202 [ 1884.722747][ C1] RAX: 000000000162e5c1 RBX: 1ffff92000027fc1 RCX: ffffffff8f446832 [ 1884.723180][ C1] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8ce969c6 [ 1884.723593][ C1] RBP: 0000000000000000 R08: 0000000000000001 R09: ffffed1006afeea4 [ 1884.724005][ C1] R10: ffff8880357f7523 R11: ffff8880357fc348 R12: 0000000000000000 [ 1884.724437][ C1] R13: ffff888001d0bec0 R14: dffffc0000000000 R15: 0000000000000000 [ 1884.724852][ C1] ? ct_kernel_exit.constprop.0+0xc2/0xe0 [ 1884.725171][ C1] ? cpuidle_idle_call+0x1f6/0x280 [ 1884.725442][ C1] default_idle_call+0x69/0xa0 [ 1884.725716][ C1] cpuidle_idle_call+0x1f6/0x280 [ 1884.725981][ C1] ? __pfx_cpuidle_idle_call+0x10/0x10 [ 1884.726291][ C1] do_idle+0xfb/0x160 [ 1884.726502][ C1] cpu_startup_entry+0x55/0x60 [ 1884.726774][ C1] start_secondary+0x21c/0x2b0 [ 1884.727030][ C1] ? __pfx_start_secondary+0x10/0x10 [ 1884.727326][ C1] secondary_startup_64_no_verify+0x16d/0x17b [ 1884.727656][ C1] [ 1892.214442][ C1] irq 4: nobody cared (try booting with the "irqpoll" option) [ 1892.214853][ C1] CPU: 1 PID: 12711 Comm: perl Not tainted 6.8.0-rc1-virtme #1 [ 1892.215249][ C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014 [ 1892.215889][ C1] Call Trace: [ 1892.216067][ C1] [ 1892.216225][ C1] dump_stack_lvl+0x64/0xb0 [ 1892.216470][ C1] __report_bad_irq+0x5f/0x180 [ 1892.216728][ C1] note_interrupt+0x6b3/0x860 [ 1892.216980][ C1] handle_irq_event+0x16d/0x1c0 [ 1892.217241][ C1] handle_edge_irq+0x1fa/0xb60 [ 1892.217496][ C1] __common_interrupt+0x7f/0x180 [ 1892.217762][ C1] common_interrupt+0x7e/0x90 [ 1892.218017][ C1] [ 1892.218174][ C1] [ 1892.218331][ C1] asm_common_interrupt+0x26/0x40 [ 1892.218608][ C1] RIP: 0010:_raw_spin_unlock_irqrestore+0x43/0x70 [ 1892.218948][ C1] Code: 10 e8 91 ac a6 fd 48 89 ef e8 a9 34 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 15 28 d8 70 <74> 0e 5b 5d c3 cc cc cc cc e8 af 3b c9 fd eb dc 0f 1f 44 00 00 5b [ 1892.219951][ C1] RSP: 0018:ffffc90002b1fa88 EFLAGS: 00000286 [ 1892.220267][ C1] RAX: 0000000000000046 RBX: 0000000000000200 RCX: 1ffffffff221bf63 [ 1892.220678][ C1] RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffffffff8f478ec1 [ 1892.221090][ C1] RBP: ffffffff93223940 R08: 0000000000000000 R09: fffffbfff221bd1a [ 1892.221502][ C1] R10: ffffffff910de8d7 R11: 0000000000000000 R12: 0000000000000e28 [ 1892.221913][ C1] R13: ffffffff93223a50 R14: ffffffff93223940 R15: ffff888005540000 [ 1892.222326][ C1] ? _raw_spin_unlock_irqrestore+0x51/0x70 [ 1892.222631][ C1] uart_write+0x220/0x440 [ 1892.222866][ C1] process_output_block+0x141/0x790 [ 1892.223156][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100 [ 1892.223480][ C1] n_tty_write+0x414/0x7a0 [ 1892.223717][ C1] ? __pfx_n_tty_write+0x10/0x10 [ 1892.223982][ C1] ? __pfx_woken_wake_function+0x10/0x10 [ 1892.224282][ C1] ? lock_acquire+0x1c1/0x220 [ 1892.224532][ C1] ? iterate_tty_write+0x95/0x540 [ 1892.224802][ C1] iterate_tty_write+0x22c/0x540 [ 1892.225067][ C1] file_tty_write.constprop.0+0x1db/0x370 [ 1892.225365][ C1] vfs_write+0x9ec/0x10a0 [ 1892.225598][ C1] ? __run_hrtimer+0x5df/0x710 [ 1892.225850][ C1] ? __pfx_vfs_write+0x10/0x10 [ 1892.226105][ C1] ? lock_acquire+0x1c1/0x220 [ 1892.226352][ C1] ? clockevents_program_event+0xf6/0x300 [ 1892.226661][ C1] ? kvm_clock_get_cycles+0x18/0x30 [ 1892.226935][ C1] ? __fget_light+0x54/0x1e0 [ 1892.227181][ C1] ? __pfx_lapic_next_deadline+0x10/0x10 [ 1892.227481][ C1] ksys_write+0xf5/0x1e0 [ 1892.227705][ C1] ? __pfx_ksys_write+0x10/0x10 [ 1892.227963][ C1] ? trace_irq_enable.constprop.0+0xd4/0x100 [ 1892.228284][ C1] do_syscall_64+0xcc/0x1e0 [ 1892.228532][ C1] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 1892.228850][ C1] RIP: 0033:0x7fd373fa1957 [ 1892.229086][ 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 [ 1892.230086][ C1] RSP: 002b:00007ffd1afc4ee8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 [ 1892.230520][ C1] RAX: ffffffffffffffda RBX: 000055b2a1aeaef0 RCX: 00007fd373fa1957 [ 1892.230937][ C1] RDX: 0000000000000001 RSI: 000055b2a1aeaef0 RDI: 0000000000000001 [ 1892.231355][ C1] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000002000 [ 1892.231769][ C1] R10: 0000000000000001 R11: 0000000000000246 R12: 000055b2a1ad74e0 [ 1892.232183][ C1] R13: 000055b2a1ab82a0 R14: 0000000000000001 R15: 000055b2a1ad74e0 [ 1892.232603][ C1] [ 1892.232768][ C1] handlers: [ 1892.232936][ C1] [] serial8250_interrupt [ 1892.233266][ C1] Disabling IRQ #4 [ 1907.476284][T13042] ncat (13042) used greatest stack depth: 21168 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