Bug 53371

Summary:	via-rhine freaks out periodically and can't be reset
Product:	Drivers	Reporter:	Ryan Underwood (nemesis)
Component:	Network	Assignee:	drivers_network (drivers_network)
Status:	ASSIGNED ---
Severity:	normal	CC:	auxsvr, caralu1974, francesco.3ntini, romieu, szg00000, vetal4444
Priority:	P1
Hardware:	All
OS:	Linux
Kernel Version:	3.7.3	Subsystem:
Regression:	No	Bisected commit-id:

Description Ryan Underwood 2013-02-03 02:18:43 UTC

I get sporadic messages like this in my syslog:

kernel: [60072.004189] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...

Usually in groups of 5-6, spaced several hours apart.

However, occasionally the NIC jams up and requires reboot to get it back.

syslog.3.gz:Jan 30 02:28:05 iqrouter kernel: [220332.004196] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:09 iqrouter kernel: [220336.004198] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:13 iqrouter kernel: [220340.004198] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:17 iqrouter kernel: [220344.004198] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:21 iqrouter kernel: [220348.004196] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:25 iqrouter kernel: [220352.004193] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:29 iqrouter kernel: [220356.004216] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:33 iqrouter kernel: [220360.004189] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:37 iqrouter kernel: [220364.004199] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:41 iqrouter kernel: [220368.004193] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:45 iqrouter kernel: [220372.004193] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0001, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:49 iqrouter kernel: [220376.004200] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:53 iqrouter kernel: [220380.004195] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:28:57 iqrouter kernel: [220384.004290] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:01 iqrouter kernel: [220388.004222] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:05 iqrouter kernel: [220392.004194] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:09 iqrouter kernel: [220396.004204] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:13 iqrouter kernel: [220400.004195] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:17 iqrouter kernel: [220404.004199] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:21 iqrouter kernel: [220408.004196] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:25 iqrouter kernel: [220412.004198] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:29 iqrouter kernel: [220416.004194] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:33 iqrouter kernel: [220420.004192] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:37 iqrouter kernel: [220424.004225] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:41 iqrouter kernel: [220428.004199] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:45 iqrouter kernel: [220432.004198] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
syslog.3.gz:Jan 30 02:29:49 iqrouter kernel: [220436.004201] via-rhine 0000:00:12.0 eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...

Always the same PHY status.  This is an onboard VIA chip on an Epox KT600 motherboard.
00:12.0 Ethernet controller: VIA Technologies, Inc. VT6102 [Rhine-II] (rev 78)

 23:   55040717   IO-APIC-fasteoi   eth_ext1

Comment 1 Ryan Underwood 2013-02-03 02:19:41 UTC

BTW: Note the status 0001 in the middle of the pasted log, in contrast to the PHY status which does not change.

Comment 2 Francois Romieu 2013-02-04 23:54:05 UTC

You did not label it as a regression. Does it mean that the issue only
appeared in stable 3.7.x ?

-- 
Ueimor

Comment 3 Ryan Underwood 2013-02-05 01:32:06 UTC

I have no idea.  I only now was required to start using this hardware.  I can try some older version, but this seems to be a common problem from googling and I haven't yet found a resolution.

Comment 4 Ryan Underwood 2013-02-11 15:46:25 UTC

With kernel 3.2.0 I still get bursts of these messages from time to time, but so far there have been no instances when the driver jammed up and produced one 'resetting' message after another with no effect as with 3.7.0.

[159441.004171] via-rhine 0000:00:12.0: eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
[159441.017554] via-rhine 0000:00:12.0: eth_ext1: link up, 100Mbps, full-duplex, lpa 0x41E1
[159445.004165] via-rhine 0000:00:12.0: eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
[159445.017457] via-rhine 0000:00:12.0: eth_ext1: link up, 100Mbps, full-duplex, lpa 0x41E1
[159449.004189] via-rhine 0000:00:12.0: eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
[159449.017512] via-rhine 0000:00:12.0: eth_ext1: link up, 100Mbps, full-duplex, lpa 0x41E1
[159453.004168] via-rhine 0000:00:12.0: eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
[159453.017640] via-rhine 0000:00:12.0: eth_ext1: link up, 100Mbps, full-duplex, lpa 0x41E1
[161659.004171] via-rhine 0000:00:12.0: eth_ext1: Transmit timed out, status 0000, PHY status 786d, resetting...
[161659.020536] via-rhine 0000:00:12.0: eth_ext1: link up, 100Mbps, full-duplex, lpa 0x41E1

Comment 5 Francesco 2013-08-01 07:18:31 UTC

I've experience the same problem using Via-Rhine integrated chip. This happen from long time, about from the beginning of kernel 2.6. In my memory, it happen from something like kernel 2.6.32 up to recent kernel (I'm using 3.8.13).

This happen some minutes after the the NIC is exposed to a high traffic (at least 1-5 Mbps), whereas when the traffic is small (up to 500kbps) the NIC work correctly for months. Unloading and loading the module can restore the NIC in a normal behavior.

This is my syslog error:
Aug  1 06:39:33 ALIX kernel: [27776.004047] ------------[ cut here ]------------
Aug  1 06:39:33 ALIX kernel: [27776.019096] WARNING: at net/sched/sch_generic.c:254 dev_watchdog+0xfd/0x194()
Aug  1 06:39:33 ALIX kernel: [27776.034407] NETDEV WATCHDOG: eth0 (via-rhine): transmit queue 0 timed out
Aug  1 06:39:33 ALIX kernel: [27776.049910] Modules linked in: xt_nat nfsd exportfs 8021q ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_
nat nf_conntrack_ipv4 nf_defrag_ipv4 xt_state xt_limit xt_tcpudp nf_conntrack_ftp nf_conntrack iptable_filter ip_tables x_tables ipv
6 rtc ledtrig_netdev ledtrig_timer ledtrig_heartbeat geodewdt lm90 raid1 md_mod sg arc4 usbkbd usbhid ums_cypress pcspkr snd_cs5535a
udio snd_ac97_codec ac97_bus ath5k snd_pcm ath snd_page_alloc geode_aes snd_timer snd scx200_acb mac80211 soundcore evdev cs5535_mfg
pt geode_rng rng_core lxfb cfg80211 rfkill usb_storage dm_mod ata_generic pata_cs5536 pata_amd libata ide_pci_generic ehci_pci ohci_
hcd ehci_hcd usbcore usb_common amd74xx ssb pcmcia pcmcia_core via_rhine mii
Aug  1 06:39:33 ALIX kernel: [27776.138506] Pid: 0, comm: swapper/0 Not tainted 3.8.13-voyage #1
Aug  1 06:39:33 ALIX kernel: [27776.156449] Call Trace:
Aug  1 06:39:33 ALIX kernel: [27776.174089]  [<c1022910>] warn_slowpath_common+0x60/0x75
Aug  1 06:39:33 ALIX kernel: [27776.191985]  [<c1022989>] warn_slowpath_fmt+0x26/0x2a
Aug  1 06:39:33 ALIX kernel: [27776.209886]  [<c125d900>] dev_watchdog+0xfd/0x194
Aug  1 06:39:33 ALIX kernel: [27776.227784]  [<c125d803>] ? pfifo_fast_dequeue+0xaa/0xaa
Aug  1 06:39:33 ALIX kernel: [27776.245726]  [<c102bb24>] call_timer_fn.isra.32+0x16/0x5f
Aug  1 06:39:33 ALIX kernel: [27776.263676]  [<c102bc99>] run_timer_softirq+0x12c/0x168
Aug  1 06:39:33 ALIX kernel: [27776.281396]  [<c125d803>] ? pfifo_fast_dequeue+0xaa/0xaa
Aug  1 06:39:33 ALIX kernel: [27776.298918]  [<c1027df3>] __do_softirq+0x81/0x117
Aug  1 06:39:33 ALIX kernel: [27776.316523]  [<c1027d72>] ? remote_softirq_receive+0x2e/0x2e
Aug  1 06:39:33 ALIX kernel: [27776.334191]  <IRQ>  [<c1027f47>] ? irq_exit+0x35/0x86
Aug  1 06:39:33 ALIX kernel: [27776.352002]  [<c100403e>] ? do_IRQ+0x79/0x8f
Aug  1 06:39:33 ALIX kernel: [27776.369770]  [<c12d986c>] ? common_interrupt+0x2c/0x31
Aug  1 06:39:33 ALIX kernel: [27776.387577]  [<c101beb6>] ? native_safe_halt+0x5/0x7
Aug  1 06:39:33 ALIX kernel: [27776.405128]  [<c10084a3>] ? default_idle+0x1f/0x35
Aug  1 06:39:33 ALIX kernel: [27776.422469]  [<c1008ad3>] ? cpu_idle+0x54/0x73
Aug  1 06:39:33 ALIX kernel: [27776.439798]  [<c12c9a58>] ? rest_init+0x58/0x5a
Aug  1 06:39:33 ALIX kernel: [27776.457144]  [<c13fe8f5>] ? start_kernel+0x2ca/0x2d1
Aug  1 06:39:33 ALIX kernel: [27776.474544]  [<c13fe2ae>] ? i386_start_kernel+0x78/0x7d
Aug  1 06:39:33 ALIX kernel: [27776.491949] ---[ end trace ee8cf69b9f8b798a ]---
Aug  1 06:39:33 ALIX kernel: [27776.509529] via-rhine 0000:00:09.0 eth0: Transmit timed out, status 0000, PHY status 786d, resetting
...

If can help, I can do some debug test.

Thanks,
Francesco

Comment 6 Vitaliy 2014-03-06 00:56:13 UTC

I have this problem too. I am using 3.13.5 kernel. To reproduce this need suspend to RAM and after wake up network is not work. 

The network card is (lspci):
03:06.0 Ethernet controller: VIA Technologies, Inc. VT6105/VT6106S [Rhine-III] (rev 8b)

Only this network card stop working. 
02:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd. RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (rev 02)
and
03:07.0 Network controller: Ralink corp. RT2800 802.11n PCI
continue work properly.

In dmesg:
[59164.334113] ------------[ cut here ]------------
[59164.334137] WARNING: CPU: 1 PID: 0 at net/sched/sch_generic.c:264 dev_watchdog+0x279/0x290()
[59164.334143] NETDEV WATCHDOG: enp3s6 (via-rhine): transmit queue 0 timed out
[59164.334147] Modules linked in: ctr ccm xt_nat ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat xt_TCPMSS xt_tcpudp ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack iptable_filter ip_tables x_tables nfsd auth_rpcgss oid_registry nfs_acl joydev mousedev arc4 ppdev rt2800pci rt2800mmio rt2800lib evdev rt2x00pci rt2x00mmio rt2x00lib eeprom_93cx6 powernow_k8 mac80211 kvm_amd cfg80211 kvm crc_ccitt rfkill pcspkr edac_core k8temp edac_mce_amd nvidia(PO) snd_hda_codec_hdmi via_rhine snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm snd_page_alloc snd_timer snd soundcore sp5100_tco drm r8169 i2c_piix4 mii i2c_core button parport_pc shpchp parport wmi processor nfs lockd sunrpc fscache vboxdrv(O) fuse ext4 crc16 mbcache jbd2 hid_generic usbhid hid sr_mod cdrom sd_mod ata_generic
[59164.334255]  pata_acpi firewire_ohci ahci pata_atiixp ohci_pci ohci_hcd libahci firewire_core crc_itu_t libata ehci_pci ehci_hcd usbcore scsi_mod usb_common
[59164.334280] CPU: 1 PID: 0 Comm: swapper/1 Tainted: P        W  O 3.13.5-1-ARCH #1
[59164.334284] Hardware name: Gigabyte Technology Co., Ltd. GA-MA770-DS3/GA-MA770-DS3, BIOS FC 03/18/2009
[59164.334289]  0000000000000009 ffff880137c83da0 ffffffff81512ff4 ffff880137c83de8
[59164.334298]  ffff880137c83dd8 ffffffff81061a3d 0000000000000000 ffff8800c726a000
[59164.334305]  ffff8800c79aa280 0000000000000001 0000000000000001 ffff880137c83e38
[59164.334311] Call Trace:
[59164.334316]  <IRQ>  [<ffffffff81512ff4>] dump_stack+0x4d/0x6f
[59164.334337]  [<ffffffff81061a3d>] warn_slowpath_common+0x7d/0xa0
[59164.334345]  [<ffffffff81061aac>] warn_slowpath_fmt+0x4c/0x50
[59164.334356]  [<ffffffff81447469>] dev_watchdog+0x279/0x290
[59164.334364]  [<ffffffff814471f0>] ? dev_graft_qdisc+0x80/0x80
[59164.334371]  [<ffffffff8106e1a6>] call_timer_fn+0x36/0x140
[59164.334377]  [<ffffffff814471f0>] ? dev_graft_qdisc+0x80/0x80
[59164.334383]  [<ffffffff8106ea84>] run_timer_softirq+0x214/0x2c0
[59164.334391]  [<ffffffff810665f4>] __do_softirq+0xe4/0x2a0
[59164.334397]  [<ffffffff81066a86>] irq_exit+0x86/0xb0
[59164.334407]  [<ffffffff81523805>] smp_apic_timer_interrupt+0x45/0x60
[59164.334414]  [<ffffffff8152219d>] apic_timer_interrupt+0x6d/0x80
[59164.334417]  <EOI>  [<ffffffff8104e186>] ? native_safe_halt+0x6/0x10
[59164.334431]  [<ffffffff8101d61f>] default_idle+0x1f/0x110
[59164.334437]  [<ffffffff8101d74f>] amd_e400_idle+0x3f/0x110
[59164.334444]  [<ffffffff8101dfd6>] arch_cpu_idle+0x26/0x30
[59164.334453]  [<ffffffff810b77ea>] cpu_startup_entry+0x24a/0x2d0
[59164.334462]  [<ffffffff81041d0b>] start_secondary+0x21b/0x2d0
[59164.334467] ---[ end trace 58a9770fb0eba32f ]---
[59164.346557] via-rhine 0000:03:06.0 enp3s6: Transmit timed out, status 0000, PHY status 786d, resetting...
[59174.346166] via-rhine 0000:03:06.0 enp3s6: Transmit timed out, status 0000, PHY status 786d, resetting...
[59184.346022] via-rhine 0000:03:06.0 enp3s6: Transmit timed out, status 0000, PHY status 786d, resetting...
[59196.345960] via-rhine 0000:03:06.0 enp3s6: Transmit timed out, status 0000, PHY status 786d, resetting...

I hope for some help in my problem.

P.s. Sorry for my English.

Comment 7 Vitaliy 2014-03-06 01:01:55 UTC

One more thing.
After reboot card work properly. 
"rmmod via-rhine && modprobe via-rhine" has no affect.

Comment 8 Vitaliy 2014-03-06 01:08:30 UTC

And one more. Higher in dmesg I found this:
[59143.495349] ------------[ cut here ]------------
[59143.495355] WARNING: CPU: 0 PID: 25541 at fs/sysfs/dir.c:486 sysfs_warn_dup+0x86/0xa0()
[59143.495356] sysfs: cannot create duplicate filename '/devices/system/cpu/cpu1/cpufreq'
[59143.495398] Modules linked in: ctr ccm xt_nat ipt_MASQUERADE iptable_nat nf_nat_ipv4 nf_nat xt_TCPMSS xt_tcpudp ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack iptable_filter ip_tables x_tables nfsd auth_rpcgss oid_registry nfs_acl joydev mousedev arc4 ppdev rt2800pci rt2800mmio rt2800lib evdev rt2x00pci rt2x00mmio rt2x00lib eeprom_93cx6 powernow_k8 mac80211 kvm_amd cfg80211 kvm crc_ccitt rfkill pcspkr edac_core k8temp edac_mce_amd nvidia(PO) snd_hda_codec_hdmi via_rhine snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm snd_page_alloc snd_timer snd soundcore sp5100_tco drm r8169 i2c_piix4 mii i2c_core button parport_pc shpchp parport wmi processor nfs lockd sunrpc fscache vboxdrv(O) fuse ext4 crc16 mbcache jbd2 hid_generic usbhid hid sr_mod cdrom sd_mod ata_generic
[59143.495406]  pata_acpi firewire_ohci ahci pata_atiixp ohci_pci ohci_hcd libahci firewire_core crc_itu_t libata ehci_pci ehci_hcd usbcore scsi_mod usb_common
[59143.495409] CPU: 0 PID: 25541 Comm: systemd-sleep Tainted: P           O 3.13.5-1-ARCH #1
[59143.495410] Hardware name: Gigabyte Technology Co., Ltd. GA-MA770-DS3/GA-MA770-DS3, BIOS FC 03/18/2009
[59143.495413]  0000000000000009 ffff880046015ba8 ffffffff81512ff4 ffff880046015bf0
[59143.495415]  ffff880046015be0 ffffffff81061a3d ffff8800b1685000 ffff8800b1685000
[59143.495417]  ffff88013144a690 0000000000000001 0000000000000000 ffff880046015c40
[59143.495417] Call Trace:
[59143.495424]  [<ffffffff81512ff4>] dump_stack+0x4d/0x6f
[59143.495428]  [<ffffffff81061a3d>] warn_slowpath_common+0x7d/0xa0
[59143.495430]  [<ffffffff81061aac>] warn_slowpath_fmt+0x4c/0x50
[59143.495432]  [<ffffffff81218ec6>] sysfs_warn_dup+0x86/0xa0
[59143.495434]  [<ffffffff81218f20>] sysfs_add_one+0x40/0x50
[59143.495436]  [<ffffffff812198cf>] sysfs_do_create_link_sd.isra.2+0xbf/0x210
[59143.495438]  [<ffffffff81219a45>] sysfs_create_link+0x25/0x50
[59143.495442]  [<ffffffff813ea1e3>] __cpufreq_add_dev.isra.21+0x1b3/0x8c0
[59143.495444]  [<ffffffff813ea962>] cpufreq_cpu_callback+0x72/0xc0
[59143.495447]  [<ffffffff8151d78c>] notifier_call_chain+0x4c/0x70
[59143.495450]  [<ffffffff81087b5e>] __raw_notifier_call_chain+0xe/0x10
[59143.495452]  [<ffffffff81061c33>] cpu_notify+0x23/0x50
[59143.495455]  [<ffffffff81061e78>] _cpu_up+0x168/0x180
[59143.495457]  [<ffffffff81506680>] enable_nonboot_cpus+0x90/0xe0
[59143.495459]  [<ffffffff810ac4b5>] suspend_devices_and_enter+0x305/0x490
[59143.495461]  [<ffffffff810ac7b8>] pm_suspend+0x178/0x260
[59143.495463]  [<ffffffff810ab747>] state_store+0x97/0xa0
[59143.495466]  [<ffffffff812b661f>] kobj_attr_store+0xf/0x20
[59143.495468]  [<ffffffff81217368>] sysfs_write_file+0x128/0x1c0
[59143.495471]  [<ffffffff811a3be4>] vfs_write+0xb4/0x1e0
[59143.495473]  [<ffffffff811a4619>] SyS_write+0x49/0xa0
[59143.495475]  [<ffffffff8152142d>] system_call_fastpath+0x1a/0x1f
[59143.495477] ---[ end trace 58a9770fb0eba32e ]---

It seems known bug, but I have no idea does this have affect for my problem or not.

Comment 9 Carlos Luna 2014-05-20 22:53:36 UTC

I have the same trouble. Running Debian testing. linux-3.14.4

May 16 18:05:15 pcdebian kernel: [ 4000.808043] WARNING: CPU: 1 PID: 0 at /build/linux-Zc5oK7/linux-3.14.4/net/sched/sch_generic.c:264 dev_watchdog+0x226/0x230()
May 16 18:05:15 pcdebian kernel: [ 4000.808048] NETDEV WATCHDOG: eth0 (via-rhine): transmit queue 0 timed out
May 16 18:05:15 pcdebian kernel: [ 4000.808052] Modules linked in: nls_utf8 nls_cp437 vfat fat binfmt_misc nfsd auth_rpcgss oid_registry nfs_acl nfs lockd fscache sunrpc powernow_k8 kvm_amd kvm nouveau snd_hda_codec_realtek snd_hda_codec_hdmi snd_hda_codec_generic mxm_wmi edac_mce_amd edac_core snd_hda_intel pcspkr k8temp snd_hda_codec snd_hwdep wmi video ttm drm_kms_helper evdev snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_midi snd_seq_midi_event drm snd_rawmidi snd_seq snd_seq_device snd_timer i2c_viapro i2c_algo_bit snd i2c_core soundcore shpchp button processor thermal_sys fuse parport_pc ppdev lp parport loop dm_crypt dm_mod autofs4 ext4 crc16 mbcache jbd2 hid_generic usbhid hid sd_mod crc_t10dif sr_mod crct10dif_generic cdrom crct10dif_common ata_generic usb_storage ehci_pci via_rhine mii floppy uhci_hcd ehci_hcd pata_via usbcore usb_common sata_via libata scsi_mod
May 16 18:05:15 pcdebian kernel: [ 4000.808166] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 3.14-1-amd64 #1 Debian 3.14.4-1
May 16 18:05:15 pcdebian kernel: [ 4000.808171] Hardware name: MICRO-STAR INTERNATIONAL CO., LTD MS-7253/MS-7253, BIOS V1.2 01/25/2007
May 16 18:05:15 pcdebian kernel: [ 4000.808176]  0000000000000009 ffffffff814b9b42 ffff88007fd03e20 ffffffff8105f0a2
May 16 18:05:15 pcdebian kernel: [ 4000.808184]  0000000000000000 ffff88007fd03e70 0000000000000001 0000000000000001
May 16 18:05:15 pcdebian kernel: [ 4000.808190]  ffff880036c2c000 ffffffff8105f107 ffffffff8174fbc8 ffff880000000030
May 16 18:05:15 pcdebian kernel: [ 4000.808197] Call Trace:
May 16 18:05:15 pcdebian kernel: [ 4000.808202]  <IRQ>  [<ffffffff814b9b42>] ? dump_stack+0x41/0x51
May 16 18:05:15 pcdebian kernel: [ 4000.808219]  [<ffffffff8105f0a2>] ? warn_slowpath_common+0x72/0x90
May 16 18:05:15 pcdebian kernel: [ 4000.808225]  [<ffffffff8105f107>] ? warn_slowpath_fmt+0x47/0x50
May 16 18:05:15 pcdebian kernel: [ 4000.808235]  [<ffffffff81091265>] ? sched_clock_local+0x15/0x80
May 16 18:05:15 pcdebian kernel: [ 4000.808247]  [<ffffffff813f4736>] ? dev_watchdog+0x226/0x230
May 16 18:05:15 pcdebian kernel: [ 4000.808254]  [<ffffffff813f4510>] ? dev_graft_qdisc+0x70/0x70
May 16 18:05:15 pcdebian kernel: [ 4000.808261]  [<ffffffff81069cfc>] ? call_timer_fn+0x2c/0x100
May 16 18:05:15 pcdebian kernel: [ 4000.808267]  [<ffffffff813f4510>] ? dev_graft_qdisc+0x70/0x70
May 16 18:05:15 pcdebian kernel: [ 4000.808273]  [<ffffffff8106abc9>] ? run_timer_softirq+0x1f9/0x2b0
May 16 18:05:15 pcdebian kernel: [ 4000.808281]  [<ffffffff8106400a>] ? __do_softirq+0xfa/0x2a0
May 16 18:05:15 pcdebian kernel: [ 4000.808288]  [<ffffffff810643d5>] ? irq_exit+0x95/0xa0
May 16 18:05:15 pcdebian kernel: [ 4000.808295]  [<ffffffff8104272b>] ? smp_apic_timer_interrupt+0x3b/0x50
May 16 18:05:15 pcdebian kernel: [ 4000.808302]  [<ffffffff814c805d>] ? apic_timer_interrupt+0x6d/0x80
May 16 18:05:15 pcdebian kernel: [ 4000.808305]  <EOI>  [<ffffffff8106c6a6>] ? get_next_timer_interrupt+0x1d6/0x250
May 16 18:05:15 pcdebian kernel: [ 4000.808317]  [<ffffffff8104c122>] ? native_safe_halt+0x2/0x10
May 16 18:05:15 pcdebian kernel: [ 4000.808326]  [<ffffffff8101bec4>] ? default_idle+0x14/0xb0
May 16 18:05:15 pcdebian kernel: [ 4000.808332]  [<ffffffff8101bf97>] ? amd_e400_idle+0x37/0x100
May 16 18:05:15 pcdebian kernel: [ 4000.808339]  [<ffffffff810af415>] ? cpu_startup_entry+0x95/0x230
May 16 18:05:15 pcdebian kernel: [ 4000.808344] ---[ end trace da6f14c4c56a95ae ]---
May 16 18:05:15 pcdebian kernel: [ 4000.808514] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:05:19 pcdebian kernel: [ 4004.808182] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:11:47 pcdebian kernel: [ 4392.808196] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:11:54 pcdebian kernel: [ 4399.184274] traps: packagekitd[4997] trap int3 ip:7f9f89fcec13 sp:7fff6ab9b780 error:0
May 16 18:11:55 pcdebian kernel: [ 4400.808196] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:23:54 pcdebian kernel: [ 5119.174527] traps: packagekitd[6242] trap int3 ip:7f9b7063fc13 sp:7fffcb749650 error:0
May 16 18:24:03 pcdebian kernel: [ 5128.808197] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:24:13 pcdebian kernel: [ 5138.808194] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:31:15 pcdebian kernel: [ 5560.808202] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 16 18:31:44 pcdebian kernel: [ 5590.100328] EXT4-fs (sdc5): mounted filesystem with ordered data mode. Opts: (null)
May 16 18:35:40 pcdebian pulseaudio[7860]: Daemon already running.
May 16 18:35:41 pcdebian pulseaudio[7874]: Daemon already running.
May 16 18:35:41 pcdebian kernel: [ 5827.033258] traps: packagekitd[7187] trap int3 ip:7f674cff3c13 sp:7fff317ccbc0 error:0
May 16 18:35:43 pcdebian kernel: [ 5828.808197] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 5003, PHY status 786d, resetting...
May 16 18:39:05 pcdebian kernel: [ 6030.820189] via-rhine 0000:00:12.0 eth0: Transmit timed out, status 1003, PHY status 786d, resetting...
May 20 15:09:34 pcdebian kernel: [    0.000000] Initializing cgroup subsys cpuset
May 20 15:09:34 pcdebian kernel: [    0.000000] Initializing cgroup subsys cpu
May 20 15:09:34 pcdebian kernel: [    0.000000] Initializing cgroup subsys cpuacct
May 20 15:09:34 pcdebian kernel: [    0.000000] Linux version 3.14-1-amd64 (debian-kernel@lists.debian.org) (gcc version 4.8.2 (Debian 4.8.2-21) ) #1 SMP Debian 3.14.4-1 (2014-05-13)
May 20 15:09:34 pcdebian kernel: [    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.14-1-amd64 root=UUID=2788ada5-7f50-4191-b94e-03fd231908bb ro quiet
May 20 15:09:34 pcdebian kernel: [    0.000000] e820: BIOS-provided physical RAM map:

Comment 10 Carlos Luna 2014-06-20 16:46:07 UTC

I`ve been testing with another Kernels and the problem is the same, so I think now that this trouble could be about Systemd. 
Some one has test if this happen on another distro not using Systemd?

Comment 11 Carlos Luna 2015-02-03 17:46:24 UTC

After several weeks I have been testing with acpi=off noapic and the network card work well but after a 30 - 45 minutes the USB devices quit working, so I must reset the pc.
May some of you test with noapic noacpi kernel line, please?

Comment 12 Carlos Luna 2015-02-03 18:51:33 UTC

Till today with Linux ubuntupc 3.13.0-45-generic #74-Ubuntu SMP Tue Jan 13 19:36:28 UTC 2015 x86_64 x86_64 x86_64 GNU/Linux  the onboard Via-Rhine chip is not working.
Feb  3 13:21:16 ubuntupc kernel: [ 5776.824182] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...

Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Initializing cgroup subsys cpuset
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Initializing cgroup subsys cpu
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Initializing cgroup subsys cpuacct
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Linux version 3.13.0-45-generic (buildd@phianna) (gcc version 4.8.2 (Ubuntu 4.8.2-19ubuntu1) ) #74-Ubuntu SMP Tue Jan 13 19:36:28 UTC 2015 (Ubuntu 3.13.0-45.74-generic 3.13.11-ckt13)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.13.0-45-generic root=UUID=423d1eff-1f01-4303-a774-0c4cb9918d90 ro quiet splash
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] KERNEL supported cpus:
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   Intel GenuineIntel
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   AMD AuthenticAMD
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   Centaur CentaurHauls
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009efff] usable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007feeffff] usable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x000000007fef0000-0x000000007fef2fff] ACPI NVS
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x000000007fef3000-0x000000007fefffff] ACPI data
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000ffffffff] reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] NX (Execute Disable) protection: active
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] SMBIOS 2.4 present.
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] DMI: MICRO-STAR INTERNATIONAL CO., LTD MS-7253/MS-7253, BIOS V1.2 01/25/2007
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] AGP bridge at 00:00:00
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Aperture from AGP @ d0000000 old size 32 MB
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Aperture from AGP @ d0000000 size 128 MB (APSIZE f20)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] e820: last_pfn = 0x7fef0 max_arch_pfn = 0x400000000
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] MTRR default type: uncachable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] MTRR fixed ranges enabled:
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   00000-9FFFF write-back
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   A0000-BFFFF uncachable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   C0000-C7FFF write-protect
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   C8000-CFFFF uncachable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   D0000-D7FFF write-back
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   D8000-FFFFF uncachable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] MTRR variable ranges enabled:
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   0 base 0000000000 mask FF80000000 write-back
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   1 base 007FF00000 mask FFFFF00000 uncachable
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   2 base 00D0000000 mask FFF8000000 write-combining
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   3 disabled
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   4 disabled
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   5 disabled
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   6 disabled
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   7 disabled
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] found SMP MP-table at [mem 0x000f3e90-0x000f3e9f] mapped at [ffff8800000f3e90]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Scanning 1 areas for low memory corruption
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [mem 0x00000000-0x000fffff] page 4k
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] init_memory_mapping: [mem 0x7c000000-0x7fbfffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [mem 0x7c000000-0x7fbfffff] page 2M
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] init_memory_mapping: [mem 0x00100000-0x7bffffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [mem 0x00100000-0x001fffff] page 4k
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [mem 0x00200000-0x7bffffff] page 2M
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] init_memory_mapping: [mem 0x7fe00000-0x7feeffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [mem 0x7fe00000-0x7feeffff] page 4k
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] BRK [0x01fe5000, 0x01fe5fff] PGTABLE
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] RAMDISK: [mem 0x34aba000-0x36554fff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: RSDP 00000000000f7cb0 000014 (v00 K8M890)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: RSDT 000000007fef3040 000034 (v01 K8M890 AWRDACPI 42302E31 AWRD 00000000)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: FACP 000000007fef30c0 000074 (v01 K8M890 AWRDACPI 42302E31 AWRD 00000000)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: DSDT 000000007fef3180 006CD7 (v01 K8M890 AWRDACPI 00001000 MSFT 0100000E)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: FACS 000000007fef0000 000040
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: SSDT 000000007fef9f80 000206 (v01 PTLTD  POWERNOW 00000001  LTP 00000001)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: MCFG 000000007fefa200 00003C (v01 K8M890 AWRDACPI 42302E31 AWRD 00000000)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: APIC 000000007fef9ec0 000074 (v01 K8M890 AWRDACPI 42302E31 AWRD 00000000)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Scanning NUMA topology in Northbridge 24
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] No NUMA configuration found
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x000000007feeffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Initmem setup node 0 [mem 0x00000000-0x7feeffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   NODE_DATA [mem 0x7feeb000-0x7feeffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]  [ffffea0000000000-ffffea0001ffffff] PMD -> [ffff88007d600000-ffff88007f5fffff] on node 0
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Zone ranges:
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   Normal   empty
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Movable zone start for each node
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Early memory node ranges
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   node   0: [mem 0x00001000-0x0009efff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   node   0: [mem 0x00100000-0x7feeffff]
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] On node 0 totalpages: 523918
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA zone: 21 pages reserved
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA zone: 3998 pages, LIFO batch:0
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA32 zone: 8124 pages used for memmap
Feb  3 11:50:41 ubuntupc kernel: [    0.000000]   DMA32 zone: 519920 pages, LIFO batch:31
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Detected use of extended apic ids on hypertransport bus
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: PM-Timer IO Port: 0x408
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] IOAPIC[0]: apic_id 2, version 3, address 0xfec00000, GSI 0-23
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: IOAPIC (id[0x03] address[0xfecc0000] gsi_base[24])
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] IOAPIC[1]: apic_id 3, version 3, address 0xfecc0000, GSI 24-47
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 low level)
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: IRQ0 used by override.
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: IRQ2 used by override.
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] ACPI: IRQ9 used by override.
Feb  3 11:50:41 ubuntupc kernel: [    0.000000] Using ACPI (MADT) for SMP configuration information
Feb  3 11:49:51 ubuntupc kernel: [  291.702724] type=1400 audit(1422982191.521:76): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/bin/freshclam" pid=5403 comm="apparmor_parser"
Feb  3 12:23:28 ubuntupc kernel: [ 2309.164760] EXT4-fs (sdc1): mounted filesystem with ordered data mode. Opts: (null)
Feb  3 12:25:22 ubuntupc kernel: [ 2422.837985] multiqueue0:src[6780]: segfault at 0 ip 00007f3378a05f12 sp 00007f33794236e0 error 6 in libgstlibav.so[7f33789ec000+35000]
Feb  3 12:31:27 ubuntupc kernel: [ 2787.484069] usb 1-7: new high-speed USB device number 4 using ehci-pci
Feb  3 12:31:27 ubuntupc kernel: [ 2787.616925] usb 1-7: New USB device found, idVendor=0781, idProduct=5567
Feb  3 12:31:27 ubuntupc kernel: [ 2787.616938] usb 1-7: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Feb  3 12:31:27 ubuntupc kernel: [ 2787.616944] usb 1-7: Product: Cruzer Blade
Feb  3 12:31:27 ubuntupc kernel: [ 2787.616950] usb 1-7: Manufacturer: SanDisk
Feb  3 12:31:27 ubuntupc kernel: [ 2787.616955] usb 1-7: SerialNumber: 20053248210A7B20C87D
Feb  3 12:31:27 ubuntupc kernel: [ 2787.617518] usb-storage 1-7:1.0: USB Mass Storage device detected
Feb  3 12:31:27 ubuntupc kernel: [ 2787.617773] scsi5 : usb-storage 1-7:1.0
Feb  3 12:31:28 ubuntupc kernel: [ 2788.617013] scsi 5:0:0:0: Direct-Access     SanDisk  Cruzer Blade     1.00 PQ: 0 ANSI: 2
Feb  3 12:31:28 ubuntupc kernel: [ 2788.617749] sd 5:0:0:0: Attached scsi generic sg5 type 0
Feb  3 12:31:28 ubuntupc kernel: [ 2788.618581] sd 5:0:0:0: [sde] 15625216 512-byte logical blocks: (8.00 GB/7.45 GiB)
Feb  3 12:31:28 ubuntupc kernel: [ 2788.629713] sd 5:0:0:0: [sde] Write Protect is off
Feb  3 12:31:28 ubuntupc kernel: [ 2788.629732] sd 5:0:0:0: [sde] Mode Sense: 03 00 00 00
Feb  3 12:31:28 ubuntupc kernel: [ 2788.634086] sd 5:0:0:0: [sde] No Caching mode page found
Feb  3 12:31:28 ubuntupc kernel: [ 2788.634100] sd 5:0:0:0: [sde] Assuming drive cache: write through
Feb  3 12:31:28 ubuntupc kernel: [ 2788.643898] sd 5:0:0:0: [sde] No Caching mode page found
Feb  3 12:31:28 ubuntupc kernel: [ 2788.643917] sd 5:0:0:0: [sde] Assuming drive cache: write through
Feb  3 12:31:28 ubuntupc kernel: [ 2788.648317]  sde: sde1
Feb  3 12:31:28 ubuntupc kernel: [ 2788.651737] sd 5:0:0:0: [sde] No Caching mode page found
Feb  3 12:31:28 ubuntupc kernel: [ 2788.651754] sd 5:0:0:0: [sde] Assuming drive cache: write through
Feb  3 12:31:28 ubuntupc kernel: [ 2788.651764] sd 5:0:0:0: [sde] Attached SCSI removable disk
Feb  3 12:31:32 ubuntupc kernel: [ 2792.381949] FAT-fs (sde1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Feb  3 12:59:44 ubuntupc kernel: [ 4484.984194] usb 3-1: USB disconnect, device number 2
Feb  3 12:59:46 ubuntupc kernel: [ 4486.616047] usb 3-1: new low-speed USB device number 3 using uhci_hcd
Feb  3 12:59:46 ubuntupc kernel: [ 4486.792089] usb 3-1: New USB device found, idVendor=0458, idProduct=003a
Feb  3 12:59:46 ubuntupc kernel: [ 4486.792099] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb  3 12:59:46 ubuntupc kernel: [ 4486.792102] usb 3-1: Product: USB Optical Mouse
Feb  3 12:59:46 ubuntupc kernel: [ 4486.792105] usb 3-1: Manufacturer: Genius
Feb  3 12:59:46 ubuntupc kernel: [ 4486.807746] input: Genius USB Optical Mouse as /devices/pci0000:00/0000:00:10.1/usb3/3-1/3-1:1.0/input/input16
Feb  3 12:59:46 ubuntupc kernel: [ 4486.807930] hid-generic 0003:0458:003A.0002: input,hidraw0: USB HID v1.11 Mouse [Genius USB Optical Mouse] on usb-0000:00:10.1-1/input0
Feb  3 13:05:55 ubuntupc kernel: [ 4855.496193] usb 3-1: USB disconnect, device number 3
Feb  3 13:05:57 ubuntupc kernel: [ 4857.176075] usb 3-1: new low-speed USB device number 4 using uhci_hcd
Feb  3 13:05:57 ubuntupc kernel: [ 4857.351050] usb 3-1: New USB device found, idVendor=0458, idProduct=003a
Feb  3 13:05:57 ubuntupc kernel: [ 4857.351063] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Feb  3 13:05:57 ubuntupc kernel: [ 4857.351071] usb 3-1: Product: USB Optical Mouse
Feb  3 13:05:57 ubuntupc kernel: [ 4857.351076] usb 3-1: Manufacturer: Genius
Feb  3 13:05:57 ubuntupc kernel: [ 4857.367130] input: Genius USB Optical Mouse as /devices/pci0000:00/0000:00:10.1/usb3/3-1/3-1:1.0/input/input17
Feb  3 13:05:57 ubuntupc kernel: [ 4857.367677] hid-generic 0003:0458:003A.0003: input,hidraw0: USB HID v1.11 Mouse [Genius USB Optical Mouse] on usb-0000:00:10.1-1/input0
Feb  3 13:19:47 ubuntupc kernel: [ 5687.242546] EXT4-fs (sdb3): mounting ext3 file system using the ext4 subsystem
Feb  3 13:19:47 ubuntupc kernel: [ 5687.276028] EXT4-fs (sdb3): warning: maximal mount count reached, running e2fsck is recommended
Feb  3 13:19:47 ubuntupc kernel: [ 5687.276843] EXT4-fs (sdb3): mounted filesystem with ordered data mode. Opts: (null)
Feb  3 13:20:20 ubuntupc kernel: [ 5720.820199] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:24 ubuntupc kernel: [ 5724.820204] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:28 ubuntupc kernel: [ 5728.820185] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:32 ubuntupc kernel: [ 5732.820197] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:36 ubuntupc kernel: [ 5736.820193] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:40 ubuntupc kernel: [ 5740.820184] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:44 ubuntupc kernel: [ 5744.820187] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:48 ubuntupc kernel: [ 5748.820194] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:52 ubuntupc kernel: [ 5752.820231] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:20:56 ubuntupc kernel: [ 5756.820196] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:00 ubuntupc kernel: [ 5760.820209] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:04 ubuntupc kernel: [ 5764.820193] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:08 ubuntupc kernel: [ 5768.820208] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:12 ubuntupc kernel: [ 5772.820191] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:16 ubuntupc kernel: [ 5776.824182] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:20 ubuntupc kernel: [ 5780.820187] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:26 ubuntupc kernel: [ 5786.820183] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:42 ubuntupc kernel: [ 5802.820183] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:21:58 ubuntupc kernel: [ 5818.820182] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:08 ubuntupc kernel: [ 5828.820184] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:18 ubuntupc kernel: [ 5838.820182] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:28 ubuntupc kernel: [ 5848.820191] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:36 ubuntupc kernel: [ 5856.820385] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:42 ubuntupc kernel: [ 5862.820347] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:22:50 ubuntupc kernel: [ 5870.820191] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:00 ubuntupc kernel: [ 5880.820177] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:10 ubuntupc kernel: [ 5890.820183] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:20 ubuntupc kernel: [ 5900.820189] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:30 ubuntupc kernel: [ 5910.820197] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:40 ubuntupc kernel: [ 5920.820184] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:23:50 ubuntupc kernel: [ 5930.820187] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:11 ubuntupc kernel: [ 5951.489776] via_rhine: v1.10-LK1.5.1 2010-10-09 Written by Donald Becker
Feb  3 13:24:11 ubuntupc kernel: [ 5951.490953] via-rhine 0000:00:12.0 eth1: VIA Rhine II at 0xdfffe000, 00:19:db:a0:d6:13, IRQ 23
Feb  3 13:24:11 ubuntupc kernel: [ 5951.491720] via-rhine 0000:00:12.0 eth1: MII PHY found at address 1, status 0x786d advertising 01e1 Link 45e1
Feb  3 13:24:17 ubuntupc kernel: [ 5957.808213] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:21 ubuntupc kernel: [ 5961.808194] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:27 ubuntupc kernel: [ 5967.808187] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:31 ubuntupc kernel: [ 5971.808232] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:35 ubuntupc kernel: [ 5975.808189] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:39 ubuntupc kernel: [ 5979.808196] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:24:43 ubuntupc kernel: [ 5983.808224] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:25:09 ubuntupc kernel: [ 6009.808207] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:25:13 ubuntupc kernel: [ 6013.808212] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 1003, PHY status 786d, resetting...
Feb  3 13:26:13 ubuntupc kernel: [ 6073.808195] via-rhine 0000:00:12.0 eth1: Transmit timed out, status 4003, PHY status 7849, resetting...
Feb  3 13:26:33 ubuntupc kernel: [ 6094.132056] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=23209 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:26:34 ubuntupc kernel: [ 6095.132726] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=23286 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:26:35 ubuntupc kernel: [ 6096.132587] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=23481 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:26:49 ubuntupc kernel: [ 6109.897383] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=60.173.26.62 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=109 ID=256 PROTO=TCP SPT=77 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:27:39 ubuntupc kernel: [ 6159.988901] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=222.186.21.97 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=108 ID=256 PROTO=TCP SPT=77 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:28:33 ubuntupc kernel: [ 6214.135382] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=43608 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:28:34 ubuntupc kernel: [ 6215.135028] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=43748 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:28:35 ubuntupc kernel: [ 6216.136572] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=43978 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:30:33 ubuntupc kernel: [ 6334.137272] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=7570 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:30:34 ubuntupc kernel: [ 6335.137576] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=7819 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:30:35 ubuntupc kernel: [ 6336.138409] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=7880 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:30:50 ubuntupc kernel: [ 6350.539597] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=115.230.124.164 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=109 ID=256 PROTO=TCP SPT=64316 DPT=9064 WINDOW=15500 RES=0x00 SYN URGP=0 
Feb  3 13:32:23 ubuntupc kernel: [ 6443.939741] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=9064 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:32:23 ubuntupc kernel: [ 6443.940035] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=8118 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:32:23 ubuntupc kernel: [ 6443.948808] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=18186 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:32:23 ubuntupc kernel: [ 6443.969307] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=9797 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:32:33 ubuntupc kernel: [ 6454.139445] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=17870 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:32:34 ubuntupc kernel: [ 6455.141025] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=17987 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:32:35 ubuntupc kernel: [ 6456.141113] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=18204 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:33:09 ubuntupc kernel: [ 6489.187642] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=61.160.213.54 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=107 ID=256 PROTO=TCP SPT=696 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:34:13 ubuntupc kernel: [ 6553.244825] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=60.173.10.173 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=103 ID=256 PROTO=TCP SPT=6000 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:34:33 ubuntupc kernel: [ 6574.142297] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=22821 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:34:34 ubuntupc kernel: [ 6575.142134] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=23049 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:34:35 ubuntupc kernel: [ 6576.142038] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=23214 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:35:59 ubuntupc kernel: [ 6659.328491] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=9064 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:35:59 ubuntupc kernel: [ 6659.331446] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=219.148.111.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=111 ID=256 DF PROTO=TCP SPT=12200 DPT=8118 WINDOW=8192 RES=0x00 SYN URGP=0 
Feb  3 13:36:33 ubuntupc kernel: [ 6694.143838] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=45391 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:36:34 ubuntupc kernel: [ 6695.144355] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=45631 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:36:35 ubuntupc kernel: [ 6696.144668] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=45701 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:37:09 ubuntupc kernel: [ 6729.582572] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=222.186.134.33 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=107 ID=256 PROTO=TCP SPT=77 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:37:31 ubuntupc kernel: [ 6751.310456] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=60.173.26.62 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=109 ID=256 PROTO=TCP SPT=77 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:37:59 ubuntupc kernel: [ 6780.101281] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=117.21.176.124 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=108 ID=256 PROTO=TCP SPT=77 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:38:33 ubuntupc kernel: [ 6814.145850] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=54926 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:38:34 ubuntupc kernel: [ 6815.146008] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=55017 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:38:35 ubuntupc kernel: [ 6816.146201] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=55044 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:39:44 ubuntupc kernel: [ 6884.507212] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=115.230.124.164 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=109 ID=256 PROTO=TCP SPT=64316 DPT=9064 WINDOW=15500 RES=0x00 SYN URGP=0 
Feb  3 13:39:58 ubuntupc kernel: [ 6898.937611] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=60.173.9.45 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=101 ID=256 PROTO=TCP SPT=6000 DPT=9064 WINDOW=16384 RES=0x00 SYN URGP=0 
Feb  3 13:40:29 ubuntupc kernel: [ 6930.157927] Inbound IN=eth0 OUT= MAC=00:00:e8:55:c2:5d:00:01:5c:42:ce:cc:08:00 SRC=104.149.88.195 DST=186.147.71.205 LEN=40 TOS=0x00 PREC=0x00 TTL=241 ID=38950 PROTO=TCP SPT=48826 DPT=9064 WINDOW=1024 RES=0x00 SYN URGP=0 
Feb  3 13:40:33 ubuntupc kernel: [ 6934.147544] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=10336 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:40:34 ubuntupc kernel: [ 6935.147867] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=10445 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102 
Feb  3 13:40:35 ubuntupc kernel: [ 6936.147987] Inbound IN=eth0 OUT= MAC= SRC=186.147.71.205 DST=239.255.255.250 LEN=122 TOS=0x00 PREC=0x00 TTL=1 ID=10536 DF PROTO=UDP SPT=1900 DPT=1900 LEN=102

Comment 13 auxsvr 2015-07-18 20:02:23 UTC

This just occurred on 3.16.7-21 openSUSE 13.2. I had to reload via_rhine for the NIC to work afterwards.

-----------[ cut here ]------------
[54444.708039] WARNING: CPU: 0 PID: 4814 at ../net/sched/sch_generic.c:264 dev_watchdog+0x246/0x250()
[54444.708041] NETDEV WATCHDOG: eth_s4_0 (via-rhine): transmit queue 0 timed out
[54444.708043] Modules linked in: bnep bluetooth 6lowpan_iphc xt_LOG xt_DSCP iptable_nat nf_nat_ipv4 xt_recent xt_comment xt_dscp arptable_filter arp_
[54444.708132] CPU: 0 PID: 4814 Comm: MathKernel Tainted: P           O  3.16.7-21-desktop #1
[54444.708134] Hardware name: System manufacturer System Product Name/M3A, BIOS 0406    12/19/2007
[54444.708136]  0000000000000009 ffffffff8161c373 ffff88016fc03e18 ffffffff8105caf7
[54444.708139]  0000000000000000 ffff88016fc03e68 0000000000000001 ffff8800caf923a0
[54444.708142]  0000000000000000 ffffffff8105cb5c ffffffff81a9ebc0 ffffffff00000030
[54444.708145] Call Trace:
[54444.708159]  [<ffffffff810051ee>] dump_trace+0x8e/0x350
[54444.708164]  [<ffffffff81005556>] show_stack_log_lvl+0xa6/0x190
[54444.708169]  [<ffffffff81006c51>] show_stack+0x21/0x50
[54444.708174]  [<ffffffff8161c373>] dump_stack+0x49/0x6a
[54444.708179]  [<ffffffff8105caf7>] warn_slowpath_common+0x77/0x90
[54444.708184]  [<ffffffff8105cb5c>] warn_slowpath_fmt+0x4c/0x50
[54444.708187]  [<ffffffff81550656>] dev_watchdog+0x246/0x250
[54444.708193]  [<ffffffff810681f1>] call_timer_fn+0x31/0x140
[54444.708198]  [<ffffffff8106863b>] run_timer_softirq+0x25b/0x310
[54444.708205]  [<ffffffff81061bf1>] __do_softirq+0xf1/0x2d0
[54444.708210]  [<ffffffff81062015>] irq_exit+0x95/0xa0
[54444.708215]  [<ffffffff81625e15>] smp_apic_timer_interrupt+0x45/0x60
[54444.708219]  [<ffffffff816240ad>] apic_timer_interrupt+0x6d/0x80
[54444.708230]  [<00007f8c8624a3d1>] 0x7f8c8624a3d0
[54444.708232] ---[ end trace d3147db3a3d9d9de ]---
[54444.708397] via-rhine 0000:03:05.0 eth_s4_0: Transmit timed out, status 4003, PHY status 786d, resetting...
[54444.708476] via-rhine 0000:03:05.0 eth_s4_0: Reset not complete yet. Trying harder.

Comment 14 Francois Romieu 2015-07-19 16:57:49 UTC

Can you give 4.1 - or any stable derivative of it - a try ?

It contains a batch of receive ring rework starting at
3a5a883a8a663b930908cae4abe5ec913b9b2fd2 ("via-rhine: close SMP transmit
races") that could make some difference.

-- 
Ueimor

Comment 15 Vitaliy 2015-07-27 07:49:21 UTC

(In reply to Francois Romieu from comment #14)
> Can you give 4.1 - or any stable derivative of it - a try ?
> 
> It contains a batch of receive ring rework starting at
> 3a5a883a8a663b930908cae4abe5ec913b9b2fd2 ("via-rhine: close SMP transmit
> races") that could make some difference.
> 
> -- 
> Ueimor

$ uname -a
Linux ArchLinux 4.1.2-2-ARCH #1 SMP PREEMPT Wed Jul 15 08:30:32 UTC 2015 x86_64 GNU/Linux

[110997.999787] ------------[ cut here ]------------
[110997.999795] WARNING: CPU: 3 PID: 0 at net/sched/sch_generic.c:303 dev_watchdog+0x253/0x260()
[110997.999796] NETDEV WATCHDOG: enp4s1 (via-rhine): transmit queue 0 timed out
[110997.999797] Modules linked in: ctr ccm xt_nat ipt_MASQUERADE nf_nat_masquerade_ipv4 iptable_nat nf_nat_ipv4 nf_nat xt_TCPMSS xt_tcpudp ipt_REJECT nf_reject_ipv4 nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack iptable_filter uas usb_storage snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic iTCO_wdt iTCO_vendor_support mxm_wmi intel_rapl iosf_mbi x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel nls_iso8859_1 kvm nls_cp437 joydev crct10dif_pclmul crc32_pclmul vfat crc32c_intel fat ghash_clmulni_intel evdev mousedev mac_hid aesni_intel aes_x86_64 nvidia(PO) lrw gf128mul glue_helper ablk_helper cryptd arc4 rt2800pci rt2800mmio rt2800lib rt2x00pci rt2x00mmio rt2x00lib mac80211 psmouse serio_raw pcspkr cfg80211 snd_hda_intel snd_hda_controller eeprom_93cx6 snd_soc_rt5640
[110997.999820]  via_rhine e1000e crc_ccitt drm rfkill mii snd_hda_codec snd_soc_rl6231 mei_me ptp snd_hda_core mei snd_hwdep lpc_ich pps_core shpchp i2c_i801 snd_soc_core tpm_tis snd_compress tpm battery snd_pcm_dmaengine snd_pcm snd_timer snd soundcore regmap_i2c i2c_hid nuvoton_cir video rc_core dw_dmac wmi i2c_designware_platform dw_dmac_core snd_soc_sst_acpi i2c_designware_core button i2c_core gpio_lynxpoint spi_pxa2xx_platform 8250_dw acpi_pad processor sch_fq_codel nfs lockd grace sunrpc fscache vboxdrv(O) fuse ip_tables x_tables ext4 crc16 mbcache jbd2 hid_generic usbhid hid sd_mod atkbd libps2 ahci libahci libata scsi_mod xhci_pci ehci_pci xhci_hcd ehci_hcd usbcore usb_common i8042 serio sdhci_acpi sdhci led_class mmc_core
[110997.999848] CPU: 3 PID: 0 Comm: swapper/3 Tainted: P           O    4.1.2-2-ARCH #1
[110997.999850] Hardware name: To Be Filled By O.E.M. To Be Filled By O.E.M./Z97 Pro4, BIOS P1.30 05/23/2014
[110997.999851]  0000000000000000 740828856830cbb6 ffff88041ed83d38 ffffffff81585c8e
[110997.999853]  0000000000000000 ffff88041ed83d90 ffff88041ed83d78 ffffffff81078c9a
[110997.999854]  ffff88041ed83d68 0000000000000000 ffff88040a9b3680 0000000000000003
[110997.999856] Call Trace:
[110997.999858]  <IRQ>  [<ffffffff81585c8e>] dump_stack+0x4c/0x6e
[110997.999862]  [<ffffffff81078c9a>] warn_slowpath_common+0x8a/0xc0
[110997.999864]  [<ffffffff81078d25>] warn_slowpath_fmt+0x55/0x70
[110997.999867]  [<ffffffff8143e82d>] ? intel_pstate_timer_func+0x31d/0x410
[110997.999869]  [<ffffffff814aa683>] dev_watchdog+0x253/0x260
[110997.999871]  [<ffffffff814aa430>] ? qdisc_rcu_free+0x40/0x40
[110997.999873]  [<ffffffff810e4f29>] call_timer_fn+0x39/0x160
[110997.999875]  [<ffffffff814aa430>] ? qdisc_rcu_free+0x40/0x40
[110997.999877]  [<ffffffff810e55c4>] run_timer_softirq+0x274/0x320
[110997.999879]  [<ffffffff8107ccb1>] __do_softirq+0xe1/0x2d0
[110997.999881]  [<ffffffff8107d01d>] irq_exit+0xad/0xb0
[110997.999883]  [<ffffffff8158e176>] smp_apic_timer_interrupt+0x46/0x60
[110997.999885]  [<ffffffff8158c3de>] apic_timer_interrupt+0x6e/0x80
[110997.999886]  <EOI>  [<ffffffff8143f412>] ? cpuidle_enter_state+0x92/0x240
[110997.999889]  [<ffffffff8143f3e4>] ? cpuidle_enter_state+0x64/0x240
[110997.999891]  [<ffffffff8143f5f7>] cpuidle_enter+0x17/0x20
[110997.999893]  [<ffffffff810bccac>] cpu_startup_entry+0x31c/0x450
[110997.999895]  [<ffffffff81050066>] start_secondary+0x196/0x1e0
[110997.999896] ---[ end trace 1d060e5d1ad9d529 ]---