Created attachment 178941 [details] kernel log Network is blocking for some seconds. The network is a bonded ethernet with 2 slaves interfaces. Both are on the mainboard. The network is using jumbo frames (mtu=9000)
See bug #9882 -comment 16/17 - reported for 3.19.2
See bug #14962 - comment 42 - reported for 3.19.0-150212 #1
Still happens with 4.0.5. Single onboard NIC in my case, also with MTU 9000. I have not seen this problem with MTU 1500.
Created attachment 182401 [details] Stack trace using the r8168 driver
Created attachment 182411 [details] Stack trace using the r8169 driver
I'm having the same (?) problem on 4.0.7-2 x86_64 (Arch Linux), with 10ec:8168 (Realtek RTL8111EVL PCI-E Gigabit Ethernet according to the product specs). In my case, it happens with both the r8169 driver, as well as the r8168 (r8168-8.040.00-2 from Arch's repo); attached both stack traces. What's different in my case is that I didn't use jumbo frames (mtu 1500); however, I was on a gigabit link and the interface was member of a bridge.
I have this NIC on Hetzner Server EX60, with motherboard MSI X58 Pro-E (MS-7522), my MTU is 1500 and i have bridge on this interface. Often i have call trace about NIC and IO error on all disc with raid1. This is my call trace: Aug 28 09:14:28 tytonida kernel: [184218.359946] ------------[ cut here ]------------ Aug 28 09:14:28 tytonida kernel: [184218.360038] WARNING: CPU: 7 PID: 0 at /home/kernel/COD/linux/net/sched/sch_generic.c:303 dev_watchdog+0x247/0x250() Aug 28 09:14:28 tytonida kernel: [184218.360130] NETDEV WATCHDOG: eth0 (r8168): transmit queue 0 timed out Aug 28 09:14:28 tytonida kernel: [184218.360194] Modules linked in: dm_snapshot dm_bufio xen_netback xen_blkback xen_gntdev xen_evtchn xenfs xen_privcmd xt_CHECKSUM iptable_mangle ipt_MASQUERADE nf_nat_masquerade_ipv4 xt_nat xt_conntrack iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack ipt_REJECT nf_reject_ipv4 xt_physdev br_netfilter bridge stp llc xt_tcpudp xt_multiport iptable_filter ip_tables x_tables joydev hid_generic usbhid hid gpio_ich nouveau mxm_wmi video ttm drm_kms_helper drm i2c_algo_bit serio_raw i7core_edac coretemp edac_core lpc_ich i5500_temp shpchp wmi mac_hid tpm_infineon 8250_fintek configfs lp parport btrfs pata_acpi raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx xor raid6_pq raid1 raid0 multipath linear ahci libahci pata_jmicron mpt2sas r8168(OE) raid_class scsi_transport_sas Aug 28 09:14:28 tytonida kernel: [184218.363538] CPU: 7 PID: 0 Comm: swapper/7 Tainted: G OE 4.0.0-040000-generic #201504121935 Aug 28 09:14:28 tytonida kernel: [184218.363626] Hardware name: MSI MS-7522/MSI X58 Pro-E (MS-7522), BIOS V8.15 03/19/2011 Aug 28 09:14:28 tytonida kernel: [184218.363712] 000000000000012f ffff880c168e3d38 ffffffff817e34b1 000000000000e2fc Aug 28 09:14:28 tytonida kernel: [184218.363935] ffff880c168e3d88 ffff880c168e3d78 ffffffff810791b7 0000000100000000 Aug 28 09:14:28 tytonida kernel: [184218.364157] ffff880c066f0000 ffff880c066f03a0 ffff880c07137400 0000000000000001 Aug 28 09:14:28 tytonida kernel: [184218.364380] Call Trace: Aug 28 09:14:28 tytonida kernel: [184218.364438] <IRQ> [<ffffffff817e34b1>] dump_stack+0x45/0x57 Aug 28 09:14:28 tytonida kernel: [184218.364581] [<ffffffff810791b7>] warn_slowpath_common+0x97/0xe0 Aug 28 09:14:28 tytonida kernel: [184218.364648] [<ffffffff810792b6>] warn_slowpath_fmt+0x46/0x50 Aug 28 09:14:28 tytonida kernel: [184218.364717] [<ffffffff816f4877>] dev_watchdog+0x247/0x250 Aug 28 09:14:28 tytonida kernel: [184218.364783] [<ffffffff816f4630>] ? dequeue_skb+0x110/0x110 Aug 28 09:14:28 tytonida kernel: [184218.364850] [<ffffffff810e3334>] call_timer_fn+0x44/0x160 Aug 28 09:14:28 tytonida kernel: [184218.364915] [<ffffffff810d528e>] ? irq_get_irq_data+0xe/0x10 Aug 28 09:14:28 tytonida kernel: [184218.364982] [<ffffffff810e5178>] run_timer_softirq+0x2d8/0x370 Aug 28 09:14:28 tytonida kernel: [184218.365048] [<ffffffff816f4630>] ? dequeue_skb+0x110/0x110 Aug 28 09:14:28 tytonida kernel: [184218.365115] [<ffffffff814948bc>] ? consume_one_event+0xfc/0x100 Aug 28 09:14:28 tytonida kernel: [184218.365182] [<ffffffff8107d16e>] __do_softirq+0xde/0x2d0 Aug 28 09:14:28 tytonida kernel: [184218.365246] [<ffffffff8107d58e>] irq_exit+0x7e/0xa0 Aug 28 09:14:28 tytonida kernel: [184218.365312] [<ffffffff814938e9>] xen_evtchn_do_upcall+0x39/0x50 Aug 28 09:14:28 tytonida kernel: [184218.365379] [<ffffffff817f1a8e>] xen_do_hypervisor_callback+0x1e/0x40 Aug 28 09:14:28 tytonida kernel: [184218.365444] <EOI> [<ffffffff810013aa>] ? xen_hypercall_sched_op+0xa/0x20 Aug 28 09:14:28 tytonida kernel: [184218.365585] [<ffffffff810013aa>] ? xen_hypercall_sched_op+0xa/0x20 Aug 28 09:14:28 tytonida kernel: [184218.365652] [<ffffffff8100b3a0>] ? xen_safe_halt+0x10/0x20 Aug 28 09:14:28 tytonida kernel: [184218.365719] [<ffffffff81020f02>] ? default_idle+0x22/0xe0 Aug 28 09:14:28 tytonida kernel: [184218.365785] [<ffffffff8102183f>] ? arch_cpu_idle+0xf/0x20 Aug 28 09:14:28 tytonida kernel: [184218.365851] [<ffffffff810bb5a5>] ? cpuidle_idle_call+0x85/0x240 Aug 28 09:14:28 tytonida kernel: [184218.365917] [<ffffffff810bb955>] ? cpu_idle_loop+0x1f5/0x210 Aug 28 09:14:28 tytonida kernel: [184218.365983] [<ffffffff810bb9ca>] ? cpu_startup_entry+0x5a/0x60 Aug 28 09:14:28 tytonida kernel: [184218.366051] [<ffffffff81012e1a>] ? cpu_bringup_and_idle+0x2a/0x40 Aug 28 09:14:28 tytonida kernel: [184218.366116] ---[ end trace eca39110c59114de ]--- Aug 28 09:14:28 tytonida kernel: [184218.366551] xenbr0: port 1(eth0) entered disabled state Aug 28 09:14:28 tytonida kernel: [184218.381129] ------------[ cut here ]------------ Aug 28 09:14:28 tytonida kernel: [184218.381214] WARNING: CPU: 7 PID: 3269 at /home/kernel/COD/linux/kernel/softirq.c:150 __local_bh_enable_ip+0x6f/0x90() Aug 28 09:14:28 tytonida kernel: [184218.381317] Modules linked in: dm_snapshot dm_bufio xen_netback xen_blkback xen_gntdev xen_evtchn xenfs xen_privcmd xt_CHECKSUM iptable_mangle ipt_MASQUERADE nf_nat_masquerade_ipv4 xt_nat xt_conntrack iptable_nat nf_conntrack_ipv4 nf_defrag_ipv4 nf_nat_ipv4 nf_nat nf_conntrack ipt_REJECT nf_reject_ipv4 xt_physdev br_netfilter bridge stp llc xt_tcpudp xt_multiport iptable_filter ip_tables x_tables joydev hid_generic usbhid hid gpio_ich nouveau mxm_wmi video ttm drm_kms_helper drm i2c_algo_bit serio_raw i7core_edac coretemp edac_core lpc_ich i5500_temp shpchp wmi mac_hid tpm_infineon 8250_fintek configfs lp parport btrfs pata_acpi raid10 raid456 async_raid6_recov async_memcpy async_pq async_xor async_tx xor raid6_pq raid1 raid0 multipath linear ahci libahci pata_jmicron mpt2sas r8168(OE) raid_class scsi_transport_sas Aug 28 09:14:28 tytonida kernel: [184218.384540] CPU: 7 PID: 3269 Comm: kworker/7:2 Tainted: G W OE 4.0.0-040000-generic #201504121935 Aug 28 09:14:28 tytonida kernel: [184218.384631] Hardware name: MSI MS-7522/MSI X58 Pro-E (MS-7522), BIOS V8.15 03/19/2011 Aug 28 09:14:28 tytonida kernel: [184218.384724] Workqueue: events rtl8168_reset_task [r8168] Aug 28 09:14:28 tytonida kernel: [184218.384826] 0000000000000096 ffff8800564e7c48 ffffffff817e34b1 0000000000000007 Aug 28 09:14:28 tytonida kernel: [184218.385058] 0000000000000000 ffff8800564e7c88 ffffffff810791b7 ffff880612ec04e8 Aug 28 09:14:28 tytonida kernel: [184218.385290] 0000000000000200 ffffffff81cd09c0 ffff880c066f08c0 ffff880c066f0000 Aug 28 09:14:28 tytonida kernel: [184218.385522] Call Trace: Aug 28 09:14:28 tytonida kernel: [184218.385585] [<ffffffff817e34b1>] dump_stack+0x45/0x57 Aug 28 09:14:28 tytonida kernel: [184218.385652] [<ffffffff810791b7>] warn_slowpath_common+0x97/0xe0 Aug 28 09:14:28 tytonida kernel: [184218.385721] [<ffffffff8107921a>] warn_slowpath_null+0x1a/0x20 Aug 28 09:14:28 tytonida kernel: [184218.385789] [<ffffffff8107d48f>] __local_bh_enable_ip+0x6f/0x90 Aug 28 09:14:28 tytonida kernel: [184218.385861] [<ffffffffc07674db>] destroy_conntrack+0x7b/0xf0 [nf_conntrack] Aug 28 09:14:28 tytonida kernel: [184218.385932] [<ffffffff81704b87>] nf_conntrack_destroy+0x17/0x20 Aug 28 09:14:28 tytonida kernel: [184218.386002] [<ffffffff816bba35>] skb_release_head_state+0x95/0xe0 Aug 28 09:14:28 tytonida kernel: [184218.386070] [<ffffffff816be556>] __kfree_skb+0x16/0xa0 Aug 28 09:14:28 tytonida kernel: [184218.386136] [<ffffffff816bedbd>] consume_skb+0x3d/0xb0 Aug 28 09:14:28 tytonida kernel: [184218.386207] [<ffffffffc020b417>] rtl8168_tx_clear+0xf7/0x160 [r8168] Aug 28 09:14:28 tytonida kernel: [184218.386279] [<ffffffffc020c036>] rtl8168_reset_task+0xb6/0x160 [r8168] Aug 28 09:14:28 tytonida kernel: [184218.386349] [<ffffffff810920d4>] process_one_work+0x144/0x490 Aug 28 09:14:28 tytonida kernel: [184218.386417] [<ffffffff8100bca2>] ? check_events+0x12/0x20 Aug 28 09:14:28 tytonida kernel: [184218.386484] [<ffffffff81092b3e>] worker_thread+0x11e/0x450 Aug 28 09:14:28 tytonida kernel: [184218.386551] [<ffffffff81092a20>] ? create_worker+0x1f0/0x1f0 Aug 28 09:14:28 tytonida kernel: [184218.386619] [<ffffffff81098869>] kthread+0xc9/0xe0 Aug 28 09:14:28 tytonida kernel: [184218.386685] [<ffffffff810987a0>] ? flush_kthread_worker+0x90/0x90 Aug 28 09:14:28 tytonida kernel: [184218.386754] [<ffffffff817efc18>] ret_from_fork+0x58/0x90 Aug 28 09:14:28 tytonida kernel: [184218.386822] [<ffffffff810987a0>] ? flush_kthread_worker+0x90/0x90 Aug 28 09:14:28 tytonida kernel: [184218.386889] ---[ end trace eca39110c59114df ]---
I'm having the same problem. I have to unplug and replug the ethernet cable to get it to work. If you need more info, please ask. Kernel 4.2.2, OS: Gentoo Here's an lspci -v of the device. 3c:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (rev 10) Subsystem: ASUSTeK Computer Inc. RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller Flags: bus master, fast devsel, latency 0, IRQ 29 I/O ports at d000 [size=256] Memory at ed104000 (64-bit, non-prefetchable) [size=4K] Memory at ed100000 (64-bit, non-prefetchable) [size=16K] Capabilities: [40] Power Management version 3 Capabilities: [50] MSI: Enable+ Count=1/1 Maskable- 64bit+ Capabilities: [70] Express Endpoint, MSI 01 Capabilities: [b0] MSI-X: Enable- Count=4 Masked- Capabilities: [d0] Vital Product Data Capabilities: [100] Advanced Error Reporting Capabilities: [140] Virtual Channel Capabilities: [160] Device Serial Number 10-95-44-07-68-4c-e0-00 Capabilities: [170] Latency Tolerance Reporting Capabilities: [178] L1 PM Substates Kernel driver in use: r8169 Kernel modules: r8169 Here's the relevant output of dmesg: [ 27.424296] r8169 0000:3c:00.0 enp60s0: link up [ 39.261298] capability: warning: `VirtualBox' uses 32-bit capabilities (legacy support in use) [ 52.087441] ------------[ cut here ]------------ [ 52.087468] WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:303 dev_watchdog+0x181/0x1e7() [ 52.087473] NETDEV WATCHDOG: enp60s0 (r8169): transmit queue 0 timed out [ 52.087476] Modules linked in: binfmt_misc vboxnetadp(O) vboxnetflt(O) vboxdrv(O) joydev hid_logitech_hidpp uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_core v4l2_common videodev btusb btrtl btbcm btintel hid_logitech_dj bluetooth snd_hda_codec_hdmi arc4 nvidia(PO) asus_nb_wmi asus_wmi iwlmvm sparse_keymap snd_hda_codec_realtek snd_hda_codec_generic mac80211 coretemp hwmon x86_pkg_temp_thermal microcode iwlwifi efivars i2c_i801 drm snd_hda_intel r8169 cfg80211 snd_hda_codec mii lpc_ich wmi snd_hda_core snd_pcm snd_timer snd soundcore xhci_pci xhci_hcd efivarfs [ 52.087542] CPU: 0 PID: 0 Comm: swapper/0 Tainted: P O 4.2.2-gentoo #7 [ 52.087546] Hardware name: ASUSTeK COMPUTER INC. G751JL/G751JL, BIOS G751JL.204 08/01/2015 [ 52.087550] 0000000000000000 0000000000000009 ffffffff814f9c32 ffff88047f003e28 [ 52.087557] ffffffff8103914d ffff88046de5731c ffffffff8144722e 0000000000000000 [ 52.087564] ffff88046b408000 ffff88046d597800 ffff88046b4083a0 0000000000000001 [ 52.087570] Call Trace: [ 52.087574] <IRQ> [<ffffffff814f9c32>] ? dump_stack+0x4a/0x74 [ 52.087593] [<ffffffff8103914d>] ? warn_slowpath_common+0x93/0xab [ 52.087598] [<ffffffff8144722e>] ? dev_watchdog+0x181/0x1e7 [ 52.087605] [<ffffffff810391aa>] ? warn_slowpath_fmt+0x45/0x4a [ 52.087612] [<ffffffff8144722e>] ? dev_watchdog+0x181/0x1e7 [ 52.087617] [<ffffffff814470ad>] ? dev_graft_qdisc+0x62/0x62 [ 52.087623] [<ffffffff814470ad>] ? dev_graft_qdisc+0x62/0x62 [ 52.087633] [<ffffffff8107790e>] ? call_timer_fn.isra.26+0x12/0x67 [ 52.087638] [<ffffffff81077af1>] ? run_timer_softirq+0x18e/0x1b6 [ 52.087646] [<ffffffff8103bbd4>] ? __do_softirq+0xc2/0x1af [ 52.087653] [<ffffffff8103be00>] ? irq_exit+0x33/0x77 [ 52.087661] [<ffffffff810290cd>] ? smp_apic_timer_interrupt+0x39/0x43 [ 52.087667] [<ffffffff814ff948>] ? apic_timer_interrupt+0x68/0x70 [ 52.087670] <EOI> [<ffffffff813fc911>] ? cpuidle_enter_state+0xd9/0x128 [ 52.087681] [<ffffffff813fc8d8>] ? cpuidle_enter_state+0xa0/0x128 [ 52.087689] [<ffffffff810603ca>] ? cpu_startup_entry+0x179/0x1e5 [ 52.087696] [<ffffffff8188ce3d>] ? start_kernel+0x451/0x45c [ 52.087702] [<ffffffff8188c7eb>] ? set_init_arg+0x50/0x50 [ 52.087707] ---[ end trace 36dcda20d455cc1c ]--- [ 52.129707] r8169 0000:3c:00.0 enp60s0: link up
I have the same problem on a Gigabyte GA-J1900-D3V, running 3.18.12-gentoo, on the onboard ethernets, with 9000 MTU: It happens once per boot, usually after a few minutes. It happens once, and never again until the next reboot. [ 1260.843131] ------------[ cut here ]------------ [ 1260.843144] WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:303 dev_watchdog+0x251/0x260() [ 1260.843148] NETDEV WATCHDOG: eth0 (r8169): transmit queue 0 timed out [ 1260.843150] Modules linked in: tun nfsd auth_rpcgss oid_registry nfs_acl hwmon_vid sch_codel act_police act_mirred cls_u32 sch_ingress sch_htb ifb sch _fq_codel bluetooth dahdi_echocan_mg2(O) wctdm(O) dahdi(O) pppoe pppox ppp_generic ip6table_mangle nf_conntrack_ipv6 nf_defrag_ipv6 xt_CT iptable_raw ipt _MASQUERADE nf_nat_masquerade_ipv4 xt_REDIRECT xt_nat xt_owner iptable_nat nf_nat_ipv4 xt_TCPMSS xt_connmark iptable_mangle xt_helper ipt_REJECT nf_rejec t_ipv4 xt_NFLOG xt_limit ipt_SYNPROXY nf_synproxy_core nf_conntrack_ipv4 nf_defrag_ipv4 xt_tcpudp xt_iprange xt_mark xt_multiport xt_set xt_conntrack nf_ nat_sip nf_conntrack_sip nf_nat_ftp nf_nat_irc nf_conntrack_ftp nf_conntrack_irc nf_nat_pptp nf_nat_proto_gre nf_nat nf_conntrack_pptp nf_conntrack_proto _gre nf_conntrack ip_set_hash_ipportip ip_set_hash_net [ 1260.843212] ip_set_hash_ip ip_set ip6table_filter ip6_tables iptable_filter ip_tables x_tables nfnetlink_log nfnetlink zram lz4_compress vboxnetflt(O ) vboxnetadp(O) vboxdrv(O) mousedev uas iTCO_wdt iTCO_vendor_support psmouse serio_raw atkbd libps2 snd_hda_codec_hdmi coretemp intel_rapl intel_powercla mp evdev kvm_intel hisax snd_hda_codec_realtek mac_hid kvm snd_hda_codec_generic crct10dif_pclmul crc32_pclmul isdn crc_ccitt r8169 slhc mii ghash_clmuln i_intel pcspkr i2c_i801 lpc_ich snd_hda_intel thermal fan i915 snd_hda_controller i8042 snd_hda_codec battery serio drm_kms_helper video dw_dmac snd_hwde p dw_dmac_core snd_pcm sdhci_acpi i2c_hid rfkill_gpio drm i2c_designware_platform i2c_algo_bit snd_timer i2c_designware_core intel_gtt mei_txe sdhci shpc hp snd i2c_core mei rfkill mmc_core soundcore [ 1260.843282] 8250_dw iosf_mbi spi_pxa2xx_platform xhci_pci button processor ppdev xts lrw gf128mul glue_helper ablk_helper cryptd aes_x86_64 cbc sha25 6_generic iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi tg3 ptp pps_core libphy hwmon e1000 fuse xfs libcrc32c nfs lockd grace sunrpc fscache jfs reiserfs crc32c_intel crc32c_generic btrfs ext4 crc16 mbcache jbd2 multipath linear raid0 dm_raid raid456 raid1 raid10 md_mod async_raid6_recov async_mem cpy async_pq async_xor xor async_tx raid6_pq dm_snapshot dm_bufio dm_crypt dm_mirror dm_region_hash dm_log dm_mod firewire_sbp2 firewire_ohci firewire_co re crc_itu_t hid_sunplus hid_sony led_class hid_samsung hid_pl hid_petalynx hid_monterey hid_microsoft hid_logitech ff_memless hid_gyration hid_ezkey hid _cypress hid_chicony hid_cherry hid_belkin hid_apple [ 1260.843359] hid_a4tech sl811_hcd hid_generic usbhid xhci_hcd ohci_hcd uhci_hcd usb_storage hid ehci_pci ehci_hcd usbcore usb_common mpt2sas raid_clas s aic94xx libsas lpfc qla2xxx megaraid_sas megaraid_mbox megaraid_mm megaraid aacraid sx8 DAC960 hpsa cciss 3w_9xxx 3w_xxxx mptsas scsi_transport_sas mpt fc scsi_transport_fc mptspi mptscsih mptbase atp870u dc395x qla1280 parport_pc imm parport dmx3191d sym53c8xx gdth advansys initio BusLogic arcmsr aic7xx x aic79xx scsi_transport_spi sr_mod cdrom sg sd_mod pdc_adma sata_inic162x sata_mv ata_piix ahci libahci sata_qstor sata_vsc sata_uli sata_sis sata_sx4 s ata_nv sata_via sata_svw sata_sil24 sata_sil sata_promise pata_sl82c105 pata_via pata_jmicron pata_marvell pata_sis pata_netcell pata_pdc202xx_old pata_t riflex pata_atiixp pata_opti pata_amd pata_ali [ 1260.843437] pata_it8213 pata_pcmcia pcmcia pcmcia_core pata_ns87415 pata_ns87410 pata_serverworks pata_cypress pata_oldpiix pata_artop pata_it821x pa ta_optidma pata_hpt3x2n pata_hpt3x3 pata_hpt37x pata_hpt366 pata_cmd64x pata_efar pata_rz1000 pata_sil680 pata_radisys pata_pdc2027x pata_mpiix libata sc si_mod [ 1260.843462] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G O 3.18.12-gentoo #1 [ 1260.843465] Hardware name: Gigabyte Technology Co., Ltd. To be filled by O.E.M./J1900N-D3V, BIOS F3 04/29/2014 [ 1260.843467] 0000000000000009 ffff88023fc03d58 ffffffff81532d55 0000000000000000 [ 1260.843472] ffff88023fc03da8 ffff88023fc03d98 ffffffff8106df61 0000000000000096 [ 1260.843477] 0000000000000000 ffff8802260a0000 0000000000000001 ffff88022bfe4080 [ 1260.843481] Call Trace: [ 1260.843484] <IRQ> [<ffffffff81532d55>] dump_stack+0x4e/0x71 [ 1260.843497] [<ffffffff8106df61>] warn_slowpath_common+0x81/0xa0 [ 1260.843502] [<ffffffff8106dfc6>] warn_slowpath_fmt+0x46/0x50 [ 1260.843515] [<ffffffff8145f5f1>] dev_watchdog+0x251/0x260 [ 1260.843520] [<ffffffff8145f3a0>] ? dev_graft_qdisc+0x80/0x80 [ 1260.843526] [<ffffffff810d114a>] call_timer_fn+0x3a/0x150 [ 1260.843530] [<ffffffff8145f3a0>] ? dev_graft_qdisc+0x80/0x80 [ 1260.843535] [<ffffffff810d1b14>] run_timer_softirq+0x264/0x310 [ 1260.843540] [<ffffffff810499b4>] ? lapic_next_deadline+0x34/0x40 [ 1260.843545] [<ffffffff810719b5>] __do_softirq+0xe5/0x2b0 [ 1260.843549] [<ffffffff81071dc6>] irq_exit+0x86/0xb0 [ 1260.843554] [<ffffffff8153b61a>] smp_apic_timer_interrupt+0x4a/0x60 [ 1260.843560] [<ffffffff815396ed>] apic_timer_interrupt+0x6d/0x80 [ 1260.843562] <EOI> [<ffffffff813ec090>] ? poll_idle+0x10/0x80 [ 1260.843571] [<ffffffff813ebb35>] cpuidle_enter_state+0x55/0x1b0 [ 1260.843576] [<ffffffff813ebd47>] cpuidle_enter+0x17/0x20 [ 1260.843581] [<ffffffff810abb79>] cpu_startup_entry+0x389/0x400 [ 1260.843586] [<ffffffff81526b25>] rest_init+0x85/0x90 [ 1260.843591] [<ffffffff818ef0f7>] start_kernel+0x48f/0x49c [ 1260.843595] [<ffffffff818eea58>] ? set_init_arg+0x55/0x55 [ 1260.843600] [<ffffffff818ee120>] ? early_idt_handlers+0x120/0x120 [ 1260.843604] [<ffffffff818ee5ee>] x86_64_start_reservations+0x2a/0x2c [ 1260.843609] [<ffffffff818ee733>] x86_64_start_kernel+0x143/0x152 [ 1260.843612] ---[ end trace 6228b4e7d2dcbd13 ]--- [ 1260.859504] r8169 0000:01:00.0 eth0: link up
Still seeing this on 4.5.1
In the file, from the root of the kernel directory kernel/time/timer.c. for the function call_timer_fn change this line: fn(data); to: printk_ratelimited("the function called is %pB", fn);. I just need to see what timer function is being called here.
Not having seen the source code for the driver but having seen somewhere else on the net that the issue might be locking up a ring buffer, if that is true (driver uses a ring buffer) could it be that age old bug where 'empty' and 'full' are equivalent conditions requiring an extra bit of information to disambiguate?