====================================== | [ 9.969438][ T187] netconsole: network logging started | [ 9.969510][ T242] ------------[ cut here ]------------ | [ 9.969857][ T242] WARNING: kernel/softirq.c:430 at __local_bh_enable_ip+0xc0/0x140, CPU#3: pr/netcon_ext0/242 | [ 9.970143][ T242] Modules linked in: netconsole netdevsim [ 9.970634][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.970846][ T242] RIP: 0010:__local_bh_enable_ip (kernel/softirq.c:430 (discriminator 34)) [ 9.971034][ T242] Code: 00 00 00 e8 12 15 0a 00 e8 3d 7c 3c 00 fb 65 8b 05 05 72 40 04 85 c0 74 64 48 83 c4 10 c3 65 8b 05 11 b6 40 04 85 c0 75 a2 90 <0f> 0b 90 eb 9c 89 74 24 0c 4c 89 04 24 e8 ce 7f 3c 00 8b 74 24 0c All code ======== 0: 00 00 add %al,(%rax) 2: 00 e8 add %ch,%al 4: 12 15 0a 00 e8 3d adc 0x3de8000a(%rip),%dl # 0x3de80014 a: 7c 3c jl 0x48 c: 00 fb add %bh,%bl e: 65 8b 05 05 72 40 04 mov %gs:0x4407205(%rip),%eax # 0x440721a 15: 85 c0 test %eax,%eax 17: 74 64 je 0x7d 19: 48 83 c4 10 add $0x10,%rsp 1d: c3 ret 1e: 65 8b 05 11 b6 40 04 mov %gs:0x440b611(%rip),%eax # 0x440b636 25: 85 c0 test %eax,%eax 27: 75 a2 jne 0xffffffffffffffcb 29: 90 nop 2a:* 0f 0b ud2 <-- trapping instruction 2c: 90 nop 2d: eb 9c jmp 0xffffffffffffffcb 2f: 89 74 24 0c mov %esi,0xc(%rsp) 33: 4c 89 04 24 mov %r8,(%rsp) 37: e8 ce 7f 3c 00 call 0x3c800a 3c: 8b 74 24 0c mov 0xc(%rsp),%esi Code starting with the faulting instruction =========================================== 0: 0f 0b ud2 2: 90 nop 3: eb 9c jmp 0xffffffffffffffa1 5: 89 74 24 0c mov %esi,0xc(%rsp) 9: 4c 89 04 24 mov %r8,(%rsp) d: e8 ce 7f 3c 00 call 0x3c7fe0 12: 8b 74 24 0c mov 0xc(%rsp),%esi [ 9.971549][ T242] RSP: 0018:ffa00000008a78b8 EFLAGS: 00010046 [ 9.971731][ T242] RAX: 0000000000000000 RBX: 00000000234b61cb RCX: 1ffffffff190ca80 [ 9.971944][ T242] RDX: 0000000000000001 RSI: 0000000000000201 RDI: ffffffff8a6657ff [ 9.972161][ T242] RBP: ffa00000008a78e8 R08: ffffffff8a6657ff R09: ffe21c00003e8963 [ 9.972374][ T242] R10: ffe21c00003e8964 R11: ff11000001f44b14 R12: ffa00000008a7990 [ 9.972587][ T242] R13: ff1100000c7d1000 R14: ff1100000c7b2000 R15: ff1100000fa52d00 [ 9.972801][ T242] FS: 0000000000000000(0000) GS:ff110000a260b000(0000) knlGS:0000000000000000 [ 9.973056][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 9.973261][ T242] CR2: 00007ffe4d467058 CR3: 000000000b48a002 CR4: 0000000000771ef0 [ 9.973474][ T242] PKRU: 55555554 [ 9.973582][ T242] Call Trace: [ 9.973691][ T242] [ 9.973763][ T242] ? _raw_spin_unlock_bh (./include/linux/spinlock_api_smp.h:196 (discriminator 1) kernel/locking/spinlock.c:210 (discriminator 1)) [ 9.973909][ T242] mock_phc_gettime64 (drivers/ptp/ptp_mock.c:98) [ 9.974053][ T242] nsim_start_xmit (./include/linux/skbuff.h:1724 ./include/linux/skbuff.h:1787 drivers/net/netdevsim/netdev.c:189) netdevsim [ 9.974238][ T242] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 9.974379][ T242] ? nsim_poll (drivers/net/netdevsim/netdev.c:123) netdevsim [ 9.974522][ T242] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.974663][ T242] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.974803][ T242] ? netif_skb_features (net/core/dev.c:3747 net/core/dev.c:3856) [ 9.974944][ T242] netpoll_start_xmit (./include/linux/netdevice.h:5285 net/core/netpoll.c:82) [ 9.975086][ T242] __netpoll_send_skb (net/core/netpoll.c:341) [ 9.975235][ T242] netpoll_send_skb (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 net/core/netpoll.c:408) [ 9.975375][ T242] send_ext_msg_udp (drivers/net/netconsole.c:1653 drivers/net/netconsole.c:1699 drivers/net/netconsole.c:1863) netconsole [ 9.975553][ T242] netconsole_write (drivers/net/netconsole.c:1915) netconsole [ 9.975733][ T242] nbcon_emit_next_record (kernel/printk/nbcon.c:1070) [ 9.975880][ T242] ? nbcon_can_proceed (kernel/printk/nbcon.c:981) [ 9.976024][ T242] ? nbcon_context_try_acquire (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/printk/nbcon.c:170 kernel/printk/nbcon.c:630) [ 9.976217][ T242] nbcon_emit_one (kernel/printk/nbcon.c:1157 (discriminator 1)) [ 9.976357][ T242] ? nbcon_emit_next_record (kernel/printk/nbcon.c:1130) [ 9.976506][ T242] nbcon_kthread_func (kernel/printk/nbcon.c:1273) [ 9.976649][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.976828][ T242] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 9.976978][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.977160][ T242] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 9.977304][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.977481][ T242] kthread (kernel/kthread.c:467) [ 9.977587][ T242] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 33)) [ 9.977772][ T242] ? kthread_affine_node (kernel/kthread.c:412) [ 9.977912][ T242] ret_from_fork (arch/x86/kernel/process.c:164) [ 9.978055][ T242] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 9.978234][ T242] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 9.978374][ T242] ? kthread_affine_node (kernel/kthread.c:412) [ 9.978516][ T242] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 9.988929][ C3] #13: ff1100000bc35228 (dev->qdisc_tx_busylock ?: &qdisc_tx_busylock){+...}-{3:3}, at: __dev_xmit_skb (./include/net/sch_generic.h:202 (discriminator 1) net/core/dev.c:4173 (discriminator 1)) | [ 9.989199][ C3] | [ 9.989199][ C3] stack backtrace: | [ 9.989353][ C3] Tainted: [W]=WARN [ 9.989354][ C3] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 9.989354][ C3] Call Trace: [ 9.989355][ C3] [ 9.989357][ C3] dump_stack_lvl (lib/dump_stack.c:122) [ 9.989359][ C3] print_usage_bug.part.0 (kernel/locking/lockdep.c:4045) [ 9.989361][ C3] ? filter_irq_stacks (kernel/stacktrace.c:114) [ 9.989364][ C3] mark_lock_irq (kernel/locking/lockdep.c:4268) [ 9.989366][ C3] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 9.989369][ C3] ? save_trace (kernel/locking/lockdep.c:592) [ 9.989371][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 9.989373][ C3] mark_lock (kernel/locking/lockdep.c:4753) [ 9.989374][ C3] mark_usage (kernel/locking/lockdep.c:4642 (discriminator 1)) [ 9.989375][ C3] __lock_acquire (kernel/locking/lockdep.c:5191) [ 9.989377][ C3] ? rcu_lockdep_current_cpu_online (kernel/rcu/tree.c:4040 (discriminator 2) kernel/rcu/tree.c:4032 (discriminator 2)) [ 9.989379][ C3] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 9.989383][ C3] lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989384][ C3] ? sch_direct_xmit (./include/linux/netdevice.h:4715 (discriminator 2) net/sched/sch_generic.c:345 (discriminator 2)) [ 9.989387][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.989389][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 9.989390][ C3] _raw_spin_lock (./include/linux/spinlock_api_smp.h:159 kernel/locking/spinlock.c:154) [ 9.989392][ C3] ? sch_direct_xmit (./include/linux/netdevice.h:4715 (discriminator 2) net/sched/sch_generic.c:345 (discriminator 2)) [ 9.989394][ C3] sch_direct_xmit (./include/linux/netdevice.h:4715 (discriminator 2) net/sched/sch_generic.c:345 (discriminator 2)) [ 9.989396][ C3] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989397][ C3] ? dequeue_skb (net/sched/sch_generic.c:322) [ 9.989400][ C3] ? __rcu_read_lock (kernel/rcu/tree_plugin.h:391 (discriminator 7) kernel/rcu/tree_plugin.h:414 (discriminator 7)) [ 9.989401][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 9.989403][ C3] __dev_xmit_skb (net/core/dev.c:4186 (discriminator 1)) [ 9.989405][ C3] ? alloc_netdev_dummy (net/core/dev.c:4160) [ 9.989407][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.989409][ C3] ? _raw_spin_unlock_irqrestore (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 ./include/linux/spinlock_api_smp.h:178 kernel/locking/spinlock.c:194) [ 9.989410][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 9.989412][ C3] __dev_queue_xmit (net/core/dev.c:4802 (discriminator 1)) [ 9.989415][ C3] ? __asan_memset (mm/kasan/shadow.c:84 (discriminator 2)) [ 9.989419][ C3] ? netdev_core_pick_tx (net/core/dev.c:4744) [ 9.989421][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 9.989423][ C3] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989424][ C3] ? arp_xmit (./include/linux/rcupdate.h:312 (discriminator 1) ./include/linux/rcupdate.h:850 (discriminator 1) net/ipv4/arp.c:664 (discriminator 1)) [ 9.989426][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.989428][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 9.989429][ C3] arp_xmit (./include/linux/rcupdate.h:879 net/ipv4/arp.c:669) [ 9.989432][ C3] arp_solicit (net/ipv4/arp.c:393) [ 9.989434][ C3] ? lockdep_hardirqs_on_prepare.part.0 (kernel/locking/lockdep.c:470 (discriminator 6) kernel/locking/lockdep.c:4411 (discriminator 6)) [ 9.989435][ C3] ? lockdep_hardirqs_on (kernel/locking/lockdep.c:4473) [ 9.989438][ C3] ? _raw_spin_unlock_irqrestore (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 ./include/linux/spinlock_api_smp.h:178 kernel/locking/spinlock.c:194) [ 9.989439][ C3] ? _raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:179 (discriminator 3) kernel/locking/spinlock.c:194 (discriminator 3)) [ 9.989441][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.989442][ C3] ? arp_rcv (net/ipv4/arp.c:335) [ 9.989445][ C3] ? neigh_probe (net/core/neighbour.c:1095) [ 9.989447][ C3] neigh_probe (net/core/neighbour.c:1097) [ 9.989449][ C3] __neigh_event_send (net/core/neighbour.c:1276) [ 9.989451][ C3] ? __rwlock_init (kernel/locking/spinlock_debug.c:114) [ 9.989453][ C3] ? mark_held_locks (kernel/locking/lockdep.c:4325 (discriminator 1)) [ 9.989455][ C3] neigh_resolve_output (net/core/neighbour.c:1603 (discriminator 1)) [ 9.989456][ C3] ? ___neigh_create (net/core/neighbour.c:726) [ 9.989459][ C3] ? ___neigh_create (net/core/neighbour.c:726) [ 9.989461][ C3] ip_finish_output2 (./include/net/neighbour.h:556 (discriminator 2) net/ipv4/ip_output.c:237 (discriminator 2)) [ 9.989463][ C3] ? ip_dst_mtu_maybe_forward (./include/net/ip.h:469) [ 9.989465][ C3] ? inet_sk_init_flowi4 (./include/net/ip.h:469) [ 9.989467][ C3] ? ip_fragment.constprop.0 (net/ipv4/ip_output.c:201) [ 9.989469][ C3] ? __ip_finish_output (./include/net/ip.h:518 net/ipv4/ip_output.c:308) [ 9.989471][ C3] ip_output (./include/linux/netfilter.h:414 net/ipv4/ip_output.c:438) [ 9.989472][ C3] ? __ip_local_out (net/ipv4/ip_output.c:98 (discriminator 1) net/ipv4/ip_output.c:109 (discriminator 1)) [ 9.989475][ C3] ip_push_pending_frames (net/ipv4/ip_output.c:1509 net/ipv4/ip_output.c:1528) [ 9.989477][ C3] __icmp_send (net/ipv4/icmp.c:1002) [ 9.989481][ C3] ? icmp_echo (net/ipv4/icmp.c:804) [ 9.989483][ C3] ? dst_init (./arch/x86/include/asm/atomic.h:28 ./include/linux/atomic/atomic-arch-fallback.h:503 ./include/linux/atomic/atomic-instrumented.h:68 ./include/linux/rcuref.h:26 net/core/dst.c:69) [ 9.989485][ C3] ? dst_alloc (net/core/dst.c:94) [ 9.989487][ C3] ? fib_validate_source (net/ipv4/fib_frontend.c:450 (discriminator 1)) [ 9.989492][ C3] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 9.989495][ C3] __udp4_lib_rcv (net/ipv4/udp.c:2767) [ 9.989498][ C3] ? udp_sk_rx_dst_set (net/ipv4/udp.c:2689) [ 9.989500][ C3] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989501][ C3] ? ip_local_deliver_finish.constprop.0 (./include/linux/rcupdate.h:312 (discriminator 1) ./include/linux/rcupdate.h:850 (discriminator 1) net/ipv4/ip_input.c:240 (discriminator 1)) [ 9.989504][ C3] ip_protocol_deliver_rcu (net/ipv4/ip_input.c:209) [ 9.989506][ C3] ip_local_deliver_finish.constprop.0 (./include/linux/rcupdate.h:879 net/ipv4/ip_input.c:242) [ 9.989508][ C3] ? ip_rcv_finish_core (net/ipv4/ip_input.c:370 (discriminator 1)) [ 9.989510][ C3] ? ip_local_deliver (./include/net/net_namespace.h:419 (discriminator 10) ./include/linux/netdevice.h:2741 (discriminator 10) net/ipv4/ip_input.c:255 (discriminator 10)) [ 9.989512][ C3] ip_sublist_rcv_finish (net/ipv4/ip_input.c:582 (discriminator 4)) [ 9.989514][ C3] ip_list_rcv_finish (net/ipv4/ip_input.c:603) [ 9.989517][ C3] ? ip_rcv_finish_core (net/ipv4/ip_input.c:603) [ 9.989519][ C3] ? ip_rcv_core (net/ipv4/ip_input.c:540) [ 9.989521][ C3] ip_list_rcv (net/ipv4/ip_input.c:650) [ 9.989523][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 9.989524][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 9.989526][ C3] ? ip_rcv (net/ipv4/ip_input.c:650) [ 9.989528][ C3] __netif_receive_skb_list_core (net/core/dev.c:6215) [ 9.989531][ C3] ? __netif_receive_skb_core.constprop.0 (net/core/dev.c:6215) [ 9.989533][ C3] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989535][ C3] ? lock_acquire (./include/trace/events/lock.h:24 (discriminator 33) kernel/locking/lockdep.c:5831 (discriminator 33)) [ 9.989537][ C3] netif_receive_skb_list_internal (net/core/dev.c:6306 net/core/dev.c:6395) [ 9.989539][ C3] ? process_backlog (net/core/dev.c:6367) [ 9.989542][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 9.989543][ C3] ? reacquire_held_locks (kernel/locking/lockdep.c:238 (discriminator 3) kernel/locking/lockdep.c:227 (discriminator 3) kernel/locking/lockdep.c:5386 (discriminator 3)) [ 9.989545][ C3] napi_complete_done (./include/linux/list.h:45 (discriminator 2) ./include/net/gro.h:524 (discriminator 2) ./include/net/gro.h:519 (discriminator 2) ./include/net/gro.h:531 (discriminator 2) net/core/dev.c:6764 (discriminator 2)) [ 9.989547][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 9.989549][ C3] ? netif_receive_skb_list (net/core/dev.c:6733) [ 9.989551][ C3] ? nsim_start_peer_tx_queue.isra.0 (./include/linux/rcupdate.h:322 (discriminator 1) ./include/linux/rcupdate.h:881 (discriminator 1) drivers/net/netdevsim/netdev.c:67 (discriminator 1)) netdevsim [ 9.989555][ C3] nsim_poll (drivers/net/netdevsim/netdev.c:510 drivers/net/netdevsim/netdev.c:543) netdevsim [ 9.989558][ C3] ? nsim_start_peer_tx_queue.isra.0 (drivers/net/netdevsim/netdev.c:539) netdevsim [ 9.989561][ C3] ? rcu_read_lock_any_held (kernel/rcu/update.c:386 (discriminator 1) kernel/rcu/update.c:380 (discriminator 1)) [ 9.989563][ C3] ? validate_chain (kernel/locking/lockdep.c:3801 (discriminator 4) kernel/locking/lockdep.c:3821 (discriminator 4) kernel/locking/lockdep.c:3876 (discriminator 4)) [ 9.989565][ C3] __napi_poll.constprop.0 (net/core/dev.c:7692) [ 9.989568][ C3] net_rx_action (net/core/dev.c:7754 net/core/dev.c:7906) [ 9.989571][ C3] ? run_backlog_napi (net/core/dev.c:7868) [ 9.989573][ C3] ? find_held_lock (kernel/locking/lockdep.c:5350 (discriminator 1)) [ 9.989576][ C3] ? kvm_clock_get_cycles (./arch/x86/include/asm/preempt.h:95 (discriminator 1) arch/x86/kernel/kvmclock.c:81 (discriminator 1) arch/x86/kernel/kvmclock.c:87 (discriminator 1)) [ 9.989580][ C3] ? ktime_get (kernel/time/timekeeping.c:381 kernel/time/timekeeping.c:404 kernel/time/timekeeping.c:826) [ 9.989582][ C3] ? mark_held_locks (kernel/locking/lockdep.c:4325 (discriminator 1)) [ 9.989584][ C3] handle_softirqs (./arch/x86/include/asm/jump_label.h:37 ./include/trace/events/irq.h:142 kernel/softirq.c:623) [ 9.989586][ C3] ? _local_bh_enable (kernel/softirq.c:580) [ 9.989588][ C3] irq_exit_rcu (kernel/softirq.c:657 kernel/softirq.c:496 kernel/softirq.c:723 kernel/softirq.c:739) [ 9.989589][ C3] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1056 (discriminator 47) arch/x86/kernel/apic/apic.c:1056 (discriminator 47)) [ 9.989591][ C3] [ 9.989592][ C3] [ 9.989593][ C3] asm_sysvec_apic_timer_interrupt (./arch/x86/include/asm/idtentry.h:697) [ 9.989595][ C3] RIP: 0010:_raw_spin_unlock_irqrestore (./include/linux/spinlock_api_smp.h:179 kernel/locking/spinlock.c:194) [ 9.989597][ C3] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 31 22 db fd 48 89 df e8 f9 75 db fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 40 9e ce fd 65 8b 05 39 fb 04 02 85 c0 74 12 5b All code ======== 0: f5 cmc 1: 53 push %rbx 2: 48 8b 74 24 10 mov 0x10(%rsp),%rsi 7: 48 89 fb mov %rdi,%rbx a: 48 83 c7 18 add $0x18,%rdi e: e8 31 22 db fd call 0xfffffffffddb2244 13: 48 89 df mov %rbx,%rdi 16: e8 f9 75 db fd call 0xfffffffffddb7614 1b: f7 c5 00 02 00 00 test $0x200,%ebp 21: 75 1f jne 0x42 23: 9c pushf 24: 58 pop %rax 25: f6 c4 02 test $0x2,%ah 28: 75 2f jne 0x59 2a:* bf 01 00 00 00 mov $0x1,%edi <-- trapping instruction 2f: e8 40 9e ce fd call 0xfffffffffdce9e74 34: 65 8b 05 39 fb 04 02 mov %gs:0x204fb39(%rip),%eax # 0x204fb74 3b: 85 c0 test %eax,%eax 3d: 74 12 je 0x51 3f: 5b pop %rbx Code starting with the faulting instruction =========================================== 0: bf 01 00 00 00 mov $0x1,%edi 5: e8 40 9e ce fd call 0xfffffffffdce9e4a a: 65 8b 05 39 fb 04 02 mov %gs:0x204fb39(%rip),%eax # 0x204fb4a 11: 85 c0 test %eax,%eax 13: 74 12 je 0x27 15: 5b pop %rbx [ 9.989599][ C3] RSP: 0018:ffa00000008a78e0 EFLAGS: 00000246 [ 9.989600][ C3] RAX: 0000000000000086 RBX: ff1100002f7a65c0 RCX: ffffffff8b145503 [ 9.989602][ C3] RDX: ff1100000bfc8040 RSI: ffffffff8b9d3441 RDI: ffffffff8b46c680 [ 9.989602][ C3] RBP: 0000000000000246 R08: 0000000000000000 R09: 0000000000000001 [ 9.989603][ C3] R10: 0000000000000003 R11: 0000000000000001 R12: ff11000009a42040 [ 9.989604][ C3] R13: ff1100000c7d1000 R14: ff1100000c7b2000 R15: ff1100000c7d1228 [ 9.989606][ C3] ? _raw_spin_unlock_irqrestore (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 ./include/linux/spinlock_api_smp.h:178 kernel/locking/spinlock.c:194) [ 9.989608][ C3] nsim_start_xmit (./include/linux/hrtimer.h:245 drivers/net/netdevsim/netdev.c:197) netdevsim [ 9.989611][ C3] ? __lock_acquire (kernel/locking/lockdep.c:5237 (discriminator 1)) [ 9.989613][ C3] ? nsim_poll (drivers/net/netdevsim/netdev.c:123) netdevsim [ 9.989616][ C3] ? lock_acquire.part.0 (kernel/locking/lockdep.c:470 kernel/locking/lockdep.c:5870) [ 9.989617][ C3] ? rcu_is_watching (./include/linux/context_tracking.h:128 (discriminator 1) kernel/rcu/tree.c:752 (discriminator 1)) [ 9.989619][ C3] ? netif_skb_features (net/core/dev.c:3747 net/core/dev.c:3856) [ 9.989621][ C3] netpoll_start_xmit (./include/linux/netdevice.h:5285 net/core/netpoll.c:82) [ 9.989623][ C3] __netpoll_send_skb (net/core/netpoll.c:341) [ 9.989625][ C3] netpoll_send_skb (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 net/core/netpoll.c:408) [ 9.989627][ C3] send_ext_msg_udp (drivers/net/netconsole.c:1653 drivers/net/netconsole.c:1699 drivers/net/netconsole.c:1863) netconsole [ 9.989630][ C3] netconsole_write (drivers/net/netconsole.c:1915) netconsole [ 9.989632][ C3] nbcon_emit_next_record (kernel/printk/nbcon.c:1070) [ 9.989634][ C3] ? nbcon_can_proceed (kernel/printk/nbcon.c:981) [ 9.989637][ C3] ? nbcon_context_try_acquire (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/printk/nbcon.c:170 kernel/printk/nbcon.c:630) [ 9.989640][ C3] nbcon_emit_one (kernel/printk/nbcon.c:1157 (discriminator 1)) [ 9.989642][ C3] ? nbcon_emit_next_record (kernel/printk/nbcon.c:1130) [ 9.989644][ C3] nbcon_kthread_func (kernel/printk/nbcon.c:1273) [ 9.989647][ C3] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.989648][ C3] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 9.989650][ C3] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.989652][ C3] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 9.989654][ C3] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 9.989656][ C3] kthread (kernel/kthread.c:467) [ 9.989657][ C3] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 33)) [ 9.989660][ C3] ? kthread_affine_node (kernel/kthread.c:412) [ 9.989661][ C3] ret_from_fork (arch/x86/kernel/process.c:164) [ 9.989663][ C3] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 9.989665][ C3] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 9.989667][ C3] ? kthread_affine_node (kernel/kthread.c:412) [ 9.989669][ C3] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 10.008885][ T242] netpoll_send_skb_on_dev(): eni372np1 enabled interrupts in poll nsim_start_xmit (drivers/net/netdevsim/netdev.c:123) netdevsim | [ 10.009078][ T242] WARNING: net/core/netpoll.c:356 at __netpoll_send_skb+0x710/0x800, CPU#3: pr/netcon_ext0/242 | [ 10.009268][ T242] Modules linked in: netconsole netdevsim | [ 10.009804][ T242] Tainted: [W]=WARN [ 10.009876][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.009987][ T242] RIP: 0010:__netpoll_send_skb (net/core/netpoll.c:356 (discriminator 11)) [ 10.010102][ T242] Code: 08 49 8d 7c 24 20 48 89 fa 48 c1 ea 03 80 3c 02 00 0f 85 d9 00 00 00 48 8d 3d a0 72 ea 01 49 8b 54 24 20 48 8d b3 18 01 00 00 <67> 48 0f b9 3a e9 cc fd ff ff e8 65 3f ca fe e9 56 fb ff ff e8 7b All code ======== 0: 08 49 8d or %cl,-0x73(%rcx) 3: 7c 24 jl 0x29 5: 20 48 89 and %cl,-0x77(%rax) 8: fa cli 9: 48 c1 ea 03 shr $0x3,%rdx d: 80 3c 02 00 cmpb $0x0,(%rdx,%rax,1) 11: 0f 85 d9 00 00 00 jne 0xf0 17: 48 8d 3d a0 72 ea 01 lea 0x1ea72a0(%rip),%rdi # 0x1ea72be 1e: 49 8b 54 24 20 mov 0x20(%r12),%rdx 23: 48 8d b3 18 01 00 00 lea 0x118(%rbx),%rsi 2a:* 67 48 0f b9 3a ud1 (%edx),%rdi <-- trapping instruction 2f: e9 cc fd ff ff jmp 0xfffffffffffffe00 34: e8 65 3f ca fe call 0xfffffffffeca3f9e 39: e9 56 fb ff ff jmp 0xfffffffffffffb94 3e: e8 .byte 0xe8 3f: 7b .byte 0x7b Code starting with the faulting instruction =========================================== 0: 67 48 0f b9 3a ud1 (%edx),%rdi 5: e9 cc fd ff ff jmp 0xfffffffffffffdd6 a: e8 65 3f ca fe call 0xfffffffffeca3f74 f: e9 56 fb ff ff jmp 0xfffffffffffffb6a 14: e8 .byte 0xe8 15: 7b .byte 0x7b [ 10.010412][ T242] RSP: 0018:ffa00000008a7a40 EFLAGS: 00010246 [ 10.010534][ T242] RAX: dffffc0000000000 RBX: ff1100000fa52000 RCX: 0000000000000002 [ 10.010669][ T242] RDX: ffffffffc0605f00 RSI: ff1100000fa52118 RDI: ffffffff8c8b1be0 [ 10.010804][ T242] RBP: ff110000095d7400 R08: ffffffff88efcb29 R09: ffe21c00014185a0 [ 10.010937][ T242] R10: ffe21c00014185a1 R11: 0000000000000001 R12: ffffffffc05a2c60 [ 10.011072][ T242] R13: 0000000000000003 R14: ff1100000fa52004 R15: ff1100000a0c2c00 [ 10.011221][ T242] FS: 0000000000000000(0000) GS:ff110000a260b000(0000) knlGS:0000000000000000 [ 10.011378][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 10.011495][ T242] CR2: 00007ffe4d467058 CR3: 000000003773b006 CR4: 0000000000771ef0 [ 10.011629][ T242] PKRU: 55555554 [ 10.011698][ T242] Call Trace: [ 10.011766][ T242] [ 10.011815][ T242] netpoll_send_skb (./arch/x86/include/asm/irqflags.h:26 ./arch/x86/include/asm/irqflags.h:109 ./arch/x86/include/asm/irqflags.h:151 net/core/netpoll.c:408) [ 10.011904][ T242] send_ext_msg_udp (drivers/net/netconsole.c:1653 drivers/net/netconsole.c:1699 drivers/net/netconsole.c:1863) netconsole [ 10.012014][ T242] netconsole_write (drivers/net/netconsole.c:1915) netconsole [ 10.012125][ T242] nbcon_emit_next_record (kernel/printk/nbcon.c:1070) [ 10.012221][ T242] ? nbcon_can_proceed (kernel/printk/nbcon.c:981) [ 10.012312][ T242] ? nbcon_context_try_acquire (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/printk/nbcon.c:170 kernel/printk/nbcon.c:630) [ 10.012430][ T242] nbcon_emit_one (kernel/printk/nbcon.c:1157 (discriminator 1)) [ 10.012519][ T242] ? nbcon_emit_next_record (kernel/printk/nbcon.c:1130) [ 10.012608][ T242] nbcon_kthread_func (kernel/printk/nbcon.c:1273) [ 10.012697][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.012807][ T242] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 10.012895][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.013005][ T242] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 10.013101][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.013217][ T242] kthread (kernel/kthread.c:467) [ 10.013283][ T242] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 33)) [ 10.013393][ T242] ? kthread_affine_node (kernel/kthread.c:412) [ 10.013488][ T242] ret_from_fork (arch/x86/kernel/process.c:164) [ 10.013578][ T242] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 10.013689][ T242] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 10.013777][ T242] ? kthread_affine_node (kernel/kthread.c:412) [ 10.013867][ T242] ret_from_fork_asm (arch/x86/entry/entry_64.S:255) | [ 10.014916][ T242] raw_local_irq_restore() called with IRQs enabled | [ 10.015021][ T242] WARNING: kernel/locking/irqflag-debug.c:10 at warn_bogus_irq_restore+0xc/0x20, CPU#3: pr/netcon_ext0/242 | [ 10.015221][ T242] Modules linked in: netconsole netdevsim | [ 10.015522][ T242] Tainted: [W]=WARN [ 10.015588][ T242] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 [ 10.015698][ T242] RIP: 0010:warn_bogus_irq_restore (kernel/locking/irqflag-debug.c:10 (discriminator 4)) [ 10.015811][ T242] Code: e5 8b 48 89 54 24 08 48 89 0c 24 e8 7e 0d d1 fe 48 8b 54 24 08 48 8b 0c 24 e9 25 ff ff ff f3 0f 1e fa 90 48 8d 3d 54 d2 75 01 <67> 48 0f b9 3a 90 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 f3 0f All code ======== 0: e5 8b in $0x8b,%eax 2: 48 89 54 24 08 mov %rdx,0x8(%rsp) 7: 48 89 0c 24 mov %rcx,(%rsp) b: e8 7e 0d d1 fe call 0xfffffffffed10d8e 10: 48 8b 54 24 08 mov 0x8(%rsp),%rdx 15: 48 8b 0c 24 mov (%rsp),%rcx 19: e9 25 ff ff ff jmp 0xffffffffffffff43 1e: f3 0f 1e fa endbr64 22: 90 nop 23: 48 8d 3d 54 d2 75 01 lea 0x175d254(%rip),%rdi # 0x175d27e 2a:* 67 48 0f b9 3a ud1 (%edx),%rdi <-- trapping instruction 2f: 90 nop 30: c3 ret 31: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) 38: 00 00 00 3b: 0f 1f 00 nopl (%rax) 3e: f3 repz 3f: 0f .byte 0xf Code starting with the faulting instruction =========================================== 0: 67 48 0f b9 3a ud1 (%edx),%rdi 5: 90 nop 6: c3 ret 7: 66 2e 0f 1f 84 00 00 cs nopw 0x0(%rax,%rax,1) e: 00 00 00 11: 0f 1f 00 nopl (%rax) 14: f3 repz 15: 0f .byte 0xf [ 10.016123][ T242] RSP: 0018:ffa00000008a7a98 EFLAGS: 00010202 [ 10.016238][ T242] RAX: 0000000000000000 RBX: ff11000008e4c130 RCX: 0000000000000000 [ 10.016369][ T242] RDX: 0000000000000282 RSI: ffffffff8b46c600 RDI: ffffffff8c87ae60 [ 10.016505][ T242] RBP: 0000000000000040 R08: ffffffff88efcb29 R09: ffe21c00014185a0 [ 10.016638][ T242] R10: 0000000000000003 R11: 0000000000000001 R12: 00000000000003a8 [ 10.016772][ T242] R13: ffa00000008a7da0 R14: ff11000008e4c000 R15: ff11000008e4c650 [ 10.016905][ T242] FS: 0000000000000000(0000) GS:ff110000a260b000(0000) knlGS:0000000000000000 [ 10.017059][ T242] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 10.017174][ T242] CR2: 00007ffe4d467058 CR3: 000000003773b006 CR4: 0000000000771ef0 [ 10.017308][ T242] PKRU: 55555554 [ 10.017375][ T242] Call Trace: [ 10.017445][ T242] [ 10.017490][ T242] netpoll_send_skb (net/core/netpoll.c:408 (discriminator 12)) [ 10.017579][ T242] send_ext_msg_udp (drivers/net/netconsole.c:1653 drivers/net/netconsole.c:1699 drivers/net/netconsole.c:1863) netconsole [ 10.017689][ T242] netconsole_write (drivers/net/netconsole.c:1915) netconsole [ 10.017799][ T242] nbcon_emit_next_record (kernel/printk/nbcon.c:1070) [ 10.017887][ T242] ? nbcon_can_proceed (kernel/printk/nbcon.c:981) [ 10.017976][ T242] ? nbcon_context_try_acquire (./arch/x86/include/asm/atomic64_64.h:15 ./include/linux/atomic/atomic-arch-fallback.h:2583 ./include/linux/atomic/atomic-long.h:38 ./include/linux/atomic/atomic-instrumented.h:3189 kernel/printk/nbcon.c:170 kernel/printk/nbcon.c:630) [ 10.018086][ T242] nbcon_emit_one (kernel/printk/nbcon.c:1157 (discriminator 1)) [ 10.018179][ T242] ? nbcon_emit_next_record (kernel/printk/nbcon.c:1130) [ 10.018269][ T242] nbcon_kthread_func (kernel/printk/nbcon.c:1273) [ 10.018357][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.018474][ T242] ? __lock_release.isra.0 (kernel/locking/lockdep.c:5536) [ 10.018564][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.018675][ T242] ? __kthread_parkme (./arch/x86/include/asm/bitops.h:202 (discriminator 1) ./arch/x86/include/asm/bitops.h:232 (discriminator 1) ./include/asm-generic/bitops/instrumented-non-atomic.h:142 (discriminator 1) kernel/kthread.c:290 (discriminator 1)) [ 10.018767][ T242] ? __nbcon_atomic_flush_pending (kernel/printk/nbcon.c:1221) [ 10.018876][ T242] kthread (kernel/kthread.c:467) [ 10.018943][ T242] ? trace_irq_enable.constprop.0 (./include/trace/events/preemptirq.h:40 (discriminator 33)) [ 10.019053][ T242] ? kthread_affine_node (kernel/kthread.c:412) [ 10.019146][ T242] ret_from_fork (arch/x86/kernel/process.c:164) [ 10.019239][ T242] ? arch_exit_to_user_mode_prepare.isra.0 (arch/x86/entry/syscall_64.c:37) [ 10.019351][ T242] ? __switch_to (./arch/x86/include/asm/cpufeature.h:101 arch/x86/kernel/process_64.c:377 arch/x86/kernel/process_64.c:665) [ 10.019444][ T242] ? kthread_affine_node (kernel/kthread.c:412) Finger prints: __netpoll_send_skb:netpoll_send_skb:send_ext_msg_udp:netconsole_write:nbcon_emit_next_record warn_bogus_irq_restore:netpoll_send_skb:send_ext_msg_udp:netconsole_write:nbcon_emit_next_record mark_lock_irq:mark_lock:mark_usage:__lock_acquire:_raw_spin_lock __local_bh_enable_ip:mock_phc_gettime64:nsim_start_xmit:netpoll_start_xmit:__netpoll_send_skb