SlackwareThis Forum is for the discussion of Slackware Linux.
Notices
Welcome to LinuxQuestions.org, a friendly and active Linux Community.
You are currently viewing LQ as a guest. By joining our community you will have the ability to post topics, receive our newsletter, use the advanced search, subscribe to threads and access many other special features. Registration is quick, simple and absolutely free. Join our community today!
Note that registered members see fewer ads, and ContentLink is completely disabled once you log in.
If you have any problems with the registration process or your account login, please contact us. If you need to reset your password, click here.
Having a problem logging in? Please visit this page to clear all LQ-related cookies.
Get a virtual cloud desktop with the Linux distro that you want in less than five minutes with Shells! With over 10 pre-installed distros to choose from, the worry-free installation life is here! Whether you are a digital nomad or just looking for flexibility, Shells can put your Linux machine on the device that you want to use.
Exclusive for LQ members, get up to 45% off per month. Click here for more info.
I've had an issue for some time now where the entire system will freeze when doing heavy downloading. The problem is most apparent when downloading torrents (currently using Deluge), as it will freeze within minutes of starting. However I've also had it happen while Steam is running updates, and even when I load up a heavy page in Firefox. What would be the best way to go about diagnosing this problem?
I'm currently running Slackware-current, although I've had the same problem in Slackware-14.1
Have you verified that your RAM is in good shape?
Many liveCDs let you run memtest86+ at bootup.
Yep, and it all checks out.
I'm able to reproduce the problem fairly reliably by running Deluge. It freezes a couple of seconds after running. I'm trying to see if it's hitting any particular bandwidth or number of connections when the system does freeze.
Hmmm...
I can't speak to Steam, but regarding Deluge...it's fairly far outside Slackware's native realm dependencies-wise. I'm curious if you have ever tried Transmission.
In a full Slackware installation, all dependencies are already met.
If you're able to download "heavily" using transmission without the lock-up, it might be a software issue with Deluge.
Hmmm...
I can't speak to Steam, but regarding Deluge...it's fairly far outside Slackware's native realm dependencies-wise. I'm curious if you have ever tried Transmission.
In a full Slackware installation, all dependencies are already met.
If you're able to download "heavily" using transmission without the lock-up, it might be a software issue with Deluge.
Well, I haven't experienced the issue with Steam/browser recently, so perhaps it was a different issue addressed in a patch. I'll focus on the torrents for now, since it seems reliably reproducible.
I guess I could give Transmission a try. I wasn't a fan of it back in the day, but it seems to have moved along. (KTorrent is included with Slackware too.)
I'll also try pointing it to some other hard drives and get back to you with the results.
Sorry for the late update, but it's been a busy week, so I didn't get a chance to test this out until now.
Transmission exhibits the same issue as Deluge did. Interestingly enough, it took a little more time for the freeze to occur running Transmission alone than when running Transmission alongside Steam.
I also got a freeze when running Steam alone. (Firefox was also running at the time, but was on a static, text-only page.) It seemed like Steam had some downloads queued, although I don't know if they were actually trying to download when the freeze occurred.
The freeze occurs both for the current hard drive, as well as any others I've tried.
I've checked availability, and my main hard drive has plenty of room both on my home partition and my root partition. The /tmp directory is crowded, but there's plenty of hard drive space.
Something to consider is that whenever this freeze occurs, if I try to shut down by just hitting the power button (not holding), it unfreezes and does a regular shutdown. (Sending sigterms to the running programs normally.) This also works when I use the "magic" sys-req keys to send "reisub" to shut down. (Sending only alt-sysreq-r doesn't seem to unfreeze the keyboard, however, as I can't use this to simply change to TTY2 or something, to work with the console.)
Have you tried logging in remotely and running top to see if something has the CPU peaked? With my system, if I find general slowdowns, I can usually find a trace of it in the top output (unless it's just related to harddisk thrashing -- I'd expect there's a program to monitor hard drive usage by app, but I've never looked into it).
Here are the outputs to messages and syslog. Note that the issue occurs between 7:31 and 7:43. (Closer to 7:43, as I shut down at 7:43.)
/var/log/messages:
Code:
Nov 17 07:31:25 inkwell kernel: [ 260.315076] ata1: hard resetting link
Nov 17 07:31:25 inkwell kernel: [ 260.775119] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Nov 17 07:31:25 inkwell kernel: [ 260.776905] ata1.00: configured for UDMA/100
Nov 17 07:31:25 inkwell kernel: [ 260.776927] ata1: EH complete
Nov 17 07:31:25 inkwell kernel: [ 260.788169] ata1: hard resetting link
Nov 17 07:31:26 inkwell kernel: [ 261.248254] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Nov 17 07:31:26 inkwell kernel: [ 261.250034] ata1.00: configured for UDMA/100
Nov 17 07:31:26 inkwell kernel: [ 261.250054] ata1: EH complete
Nov 17 07:31:26 inkwell kernel: [ 261.261260] ata1: hard resetting link
Nov 17 07:31:26 inkwell kernel: [ 261.721334] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Nov 17 07:31:26 inkwell kernel: [ 261.723134] ata1.00: configured for UDMA/100
Nov 17 07:31:26 inkwell kernel: [ 261.723153] ata1: EH complete
Nov 17 07:31:26 inkwell kernel: [ 261.735357] ata1: hard resetting link
Nov 17 07:31:27 inkwell kernel: [ 262.195447] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 320)
Nov 17 07:31:27 inkwell kernel: [ 262.197206] ata1.00: configured for UDMA/100
Nov 17 07:31:27 inkwell kernel: [ 262.197221] ata1: EH complete
Nov 17 07:43:12 inkwell kernel: [ 967.715750] Task dump for CPU 0:
Nov 17 07:43:12 inkwell kernel: [ 967.715752] swapper/0 R running task 0 0 0 0x00000008
Nov 17 07:43:12 inkwell kernel: [ 967.715826] Task dump for CPU 1:
Nov 17 07:43:12 inkwell kernel: [ 967.715827] swapper/1 R running task 0 0 1 0x00000008
Nov 17 07:43:12 inkwell kernel: [ 967.715846] Task dump for CPU 3:
Nov 17 07:43:12 inkwell kernel: [ 967.715846] swapper/3 R running task 0 0 1 0x00000008
Nov 17 07:43:12 inkwell init: Switching to runlevel: 0
Nov 17 07:43:12 inkwell kernel: [ 967.760983] plugin-containe[1070]: segfault at 218acecfa4a1 ip 00007f2f6718d9aa sp 00007f2f627feae0 error 4 in libflashplayer.so[7f2f66f97000+118e000]
Nov 17 07:43:12 inkwell root: ACPI group jack / action lineout is not defined
Nov 17 07:43:12 inkwell root: ACPI group jack / action videoout is not defined
Nov 17 07:43:14 inkwell sshd[705]: Received signal 15; terminating.
Nov 17 07:43:14 inkwell root: /etc/rc.d/rc.inet1: /sbin/route del default
Nov 17 07:43:14 inkwell root: /etc/rc.d/rc.inet1: /sbin/ifconfig eth0 down
Nov 17 07:43:14 inkwell root: /etc/rc.d/rc.inet1: /sbin/ifconfig lo down
Nov 17 07:43:14 inkwell /usr/sbin/gpm[841]: *** info [mice.c(1990)]:
Nov 17 07:43:14 inkwell /usr/sbin/gpm[841]: imps2: Auto-detected intellimouse PS/2
Nov 17 07:43:14 inkwell exiting on signal 15
/var/log/syslog:
Code:
Nov 17 07:31:26 inkwell kernel: [ 261.261251] res 40/00:b0:18:36:15/00:00:39:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 07:31:26 inkwell kernel: [ 261.261252] ata1.00: status: { DRDY }
Nov 17 07:31:26 inkwell kernel: [ 261.261253] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 07:31:26 inkwell kernel: [ 261.261256] ata1.00: cmd 61/00:b0:18:36:15/04:00:39:00:00/40 tag 22 ncq 524288 out
Nov 17 07:31:26 inkwell kernel: [ 261.261256] res 40/00:b0:18:36:15/00:00:39:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 07:31:26 inkwell kernel: [ 261.261257] ata1.00: status: { DRDY }
Nov 17 07:31:26 inkwell kernel: [ 261.735339] ata1: limiting SATA link speed to 3.0 Gbps
Nov 17 07:31:26 inkwell kernel: [ 261.735344] ata1.00: exception Emask 0x10 SAct 0x40000000 SErr 0x400000 action 0x6 frozen
Nov 17 07:31:26 inkwell kernel: [ 261.735345] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 07:31:26 inkwell kernel: [ 261.735347] ata1: SError: { Handshk }
Nov 17 07:31:26 inkwell kernel: [ 261.735349] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 07:31:26 inkwell kernel: [ 261.735352] ata1.00: cmd 61/00:f0:08:5d:15/04:00:39:00:00/40 tag 30 ncq 524288 out
Nov 17 07:31:26 inkwell kernel: [ 261.735352] res 40/00:f0:08:5d:15/00:00:39:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 07:31:26 inkwell kernel: [ 261.735354] ata1.00: status: { DRDY }
Nov 17 07:43:12 inkwell kernel: [ 967.715743] INFO: rcu_sched self-detected stall on CPU { 0} (t=127540 jiffies g=37861 c=37860 q=4)
Nov 17 07:43:12 inkwell kernel: [ 967.715755] ffffffff82069100 ffff8801bfc03c38 ffffffff810aabe8 0000000000000000
Nov 17 07:43:12 inkwell kernel: [ 967.715757] ffffffff82069100 ffff8801bfc03c58 ffffffff810adbed ffff8801bfc03c98
Nov 17 07:43:12 inkwell kernel: [ 967.715758] 0000000000000001 ffff8801bfc03c88 ffffffff810d51f1 ffff8801bfc0c2c0
Nov 17 07:43:12 inkwell kernel: [ 967.715760] Call Trace:
Nov 17 07:43:12 inkwell kernel: [ 967.715762] <IRQ> [<ffffffff810aabe8>] sched_show_task+0xa8/0x110
Nov 17 07:43:12 inkwell kernel: [ 967.715769] [<ffffffff810adbed>] dump_cpu_task+0x3d/0x50
Nov 17 07:43:12 inkwell kernel: [ 967.715772] [<ffffffff810d51f1>] rcu_dump_cpu_stacks+0x91/0xd0
Nov 17 07:43:12 inkwell kernel: [ 967.715775] [<ffffffff810d81a1>] rcu_check_callbacks+0x431/0x6a0
Nov 17 07:43:12 inkwell kernel: [ 967.715777] [<ffffffff810dc96b>] update_process_times+0x4b/0x80
Nov 17 07:43:12 inkwell kernel: [ 967.715779] [<ffffffff810eb7d6>] tick_sched_handle.isra.16+0x36/0x50
Nov 17 07:43:12 inkwell kernel: [ 967.715781] [<ffffffff810eb832>] tick_sched_timer+0x42/0x80
Nov 17 07:43:12 inkwell kernel: [ 967.715783] [<ffffffff810dd562>] __run_hrtimer+0x72/0x1b0
Nov 17 07:43:12 inkwell kernel: [ 967.715785] [<ffffffff810eb7f0>] ? tick_sched_handle.isra.16+0x50/0x50
Nov 17 07:43:12 inkwell kernel: [ 967.715787] [<ffffffff810dd94f>] hrtimer_interrupt+0xff/0x240
Nov 17 07:43:12 inkwell kernel: [ 967.715789] [<ffffffff810ea23b>] tick_do_broadcast.constprop.7+0x9b/0xa0
Nov 17 07:43:12 inkwell kernel: [ 967.715791] [<ffffffff810ea415>] tick_handle_oneshot_broadcast+0x145/0x1d0
Nov 17 07:43:12 inkwell kernel: [ 967.715793] [<ffffffff81005b25>] timer_interrupt+0x15/0x20
Nov 17 07:43:12 inkwell kernel: [ 967.715795] [<ffffffff810cdab9>] handle_irq_event_percpu+0x39/0x1b0
Nov 17 07:43:12 inkwell kernel: [ 967.715797] [<ffffffff810cdc6a>] handle_irq_event+0x3a/0x60
Nov 17 07:43:12 inkwell kernel: [ 967.715799] [<ffffffff810d0a8e>] handle_edge_irq+0x6e/0x120
Nov 17 07:43:12 inkwell kernel: [ 967.715800] [<ffffffff81005412>] handle_irq+0x22/0x40
Nov 17 07:43:12 inkwell kernel: [ 967.715803] [<ffffffff81c8b961>] do_IRQ+0x51/0xf0
Nov 17 07:43:12 inkwell kernel: [ 967.715805] [<ffffffff81c89d6a>] common_interrupt+0x6a/0x6a
Nov 17 07:43:12 inkwell kernel: [ 967.715806] <EOI> [<ffffffff81033954>] ? lapic_timer_setup+0x14/0x20
Nov 17 07:43:12 inkwell kernel: [ 967.715810] [<ffffffff8100cd71>] ? default_idle+0x21/0xc0
Nov 17 07:43:12 inkwell kernel: [ 967.715813] [<ffffffff8100ce5c>] amd_e400_idle+0x4c/0x100
Nov 17 07:43:12 inkwell kernel: [ 967.715814] [<ffffffff8100d6bf>] arch_cpu_idle+0xf/0x20
Nov 17 07:43:12 inkwell kernel: [ 967.715816] [<ffffffff810bd30c>] cpu_startup_entry+0x3bc/0x400
Nov 17 07:43:12 inkwell kernel: [ 967.715819] [<ffffffff81c754b2>] rest_init+0x72/0x80
Nov 17 07:43:12 inkwell kernel: [ 967.715821] [<ffffffff8217fee8>] start_kernel+0x456/0x463
Nov 17 07:43:12 inkwell kernel: [ 967.715823] [<ffffffff8217f495>] x86_64_start_reservations+0x2a/0x2c
Nov 17 07:43:12 inkwell kernel: [ 967.715825] [<ffffffff8217f589>] x86_64_start_kernel+0xf2/0xf6
Nov 17 07:43:12 inkwell kernel: [ 967.715829] ffffffff82346cd0 ffffffffffffff02 ffffffff8100cd71 0000000000000046
Nov 17 07:43:12 inkwell kernel: [ 967.715830] ffff8801b6dafe68 ffffffff810e92c2 ffff8801b6dafe84 0000000000000000
Nov 17 07:43:12 inkwell kernel: [ 967.715832] ffff8801b6dac000 0000000000000000 ffff8801b6dafe98 ffffffff8100ce6a
Nov 17 07:43:12 inkwell kernel: [ 967.715834] Call Trace:
Nov 17 07:43:12 inkwell kernel: [ 967.715836] [<ffffffff8100cd71>] ? default_idle+0x21/0xc0
Nov 17 07:43:12 inkwell kernel: [ 967.715837] [<ffffffff810e92c2>] ? clockevents_notify+0x22/0x220
Nov 17 07:43:12 inkwell kernel: [ 967.715839] [<ffffffff8100ce6a>] ? amd_e400_idle+0x5a/0x100
Nov 17 07:43:12 inkwell kernel: [ 967.715841] [<ffffffff8100d6bf>] ? arch_cpu_idle+0xf/0x20
Nov 17 07:43:12 inkwell kernel: [ 967.715842] [<ffffffff810bd30c>] ? cpu_startup_entry+0x3bc/0x400
Nov 17 07:43:12 inkwell kernel: [ 967.715844] [<ffffffff81032215>] ? start_secondary+0x185/0x190
Nov 17 07:43:12 inkwell kernel: [ 967.715848] ffffffff82346cd0 ffffffffffffff2e ffffffff8100cd71 0000000000000010
Nov 17 07:43:12 inkwell kernel: [ 967.715849] 0000000000000246 ffff8801b6db7e58 0000000000000000 0000000000000000
Nov 17 07:43:12 inkwell kernel: [ 967.715851] ffff8801b6db7e84 0000000000000000 ffff8801b6db7e98 ffffffff8100ce5c
Nov 17 07:43:12 inkwell kernel: [ 967.715852] Call Trace:
Nov 17 07:43:12 inkwell kernel: [ 967.715854] [<ffffffff8100cd71>] ? default_idle+0x21/0xc0
Nov 17 07:43:12 inkwell kernel: [ 967.715856] [<ffffffff8100ce5c>] ? amd_e400_idle+0x4c/0x100
Nov 17 07:43:12 inkwell kernel: [ 967.715858] [<ffffffff8100d6bf>] ? arch_cpu_idle+0xf/0x20
Nov 17 07:43:12 inkwell kernel: [ 967.715859] [<ffffffff810bd30c>] ? cpu_startup_entry+0x3bc/0x400
Nov 17 07:43:12 inkwell kernel: [ 967.715861] [<ffffffff81032215>] ? start_secondary+0x185/0x190
Note that the failed ata write commands at 7:31 are likely unrelated, as I have a batch of them for every boot up.
The output of lspci shows this for my ethernet driver:
I just tried connecting via SSH during a freeze. SSH was unable to find the host, but when I hit the power button to initiate shutdown, my other computer was able to briefly connect long enough to ask for the password. Then the connection was broken as the computer continued the shutdown process.
Here is a second collection of logs to view (for correlation):
messages:
Code:
Nov 17 08:33:48 inkwell -- MARK --
Nov 17 08:53:48 inkwell -- MARK --
Nov 17 09:02:21 inkwell init: Switching to runlevel: 0
Nov 17 09:02:21 inkwell root: ACPI group jack / action lineout is not defined
Nov 17 09:02:21 inkwell root: ACPI group jack / action videoout is not defined
Nov 17 09:02:23 inkwell sshd[704]: Received signal 15; terminating.
Nov 17 09:02:23 inkwell root: /etc/rc.d/rc.inet1: /sbin/route del default
Nov 17 09:02:23 inkwell root: /etc/rc.d/rc.inet1: /sbin/ifconfig eth0 down
Nov 17 09:02:23 inkwell /usr/sbin/gpm[839]: *** info [mice.c(1990)]:
Nov 17 09:02:23 inkwell /usr/sbin/gpm[839]: imps2: Auto-detected intellimouse PS/2
Nov 17 09:02:23 inkwell root: /etc/rc.d/rc.inet1: /sbin/ifconfig lo down
Nov 17 09:02:23 inkwell exiting on signal 15
Nov 17 09:03:22 inkwell syslogd 1.5.0: restart.
Nov 17 09:03:22 inkwell kernel: klogd 1.5.0, log source = /proc/kmsg started.
syslog:
Code:
Nov 17 08:16:12 inkwell kernel: [ 158.263718] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 08:16:12 inkwell kernel: [ 158.263720] ata1: SError: { Handshk }
Nov 17 08:16:12 inkwell kernel: [ 158.263722] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 08:16:12 inkwell kernel: [ 158.263726] ata1.00: cmd 61/00:a8:68:e8:d0/04:00:3a:00:00/40 tag 21 ncq 524288 out
Nov 17 08:16:12 inkwell kernel: [ 158.263726] res 40/00:b0:68:ec:d0/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 08:16:12 inkwell kernel: [ 158.263727] ata1.00: status: { DRDY }
Nov 17 08:16:12 inkwell kernel: [ 158.263729] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 08:16:12 inkwell kernel: [ 158.263732] ata1.00: cmd 61/60:b0:68:ec:d0/00:00:3a:00:00/40 tag 22 ncq 49152 out
Nov 17 08:16:12 inkwell kernel: [ 158.263732] res 40/00:b0:68:ec:d0/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 08:16:12 inkwell kernel: [ 158.263733] ata1.00: status: { DRDY }
[REBOOT OCCURRED HERE]
Nov 17 09:03:22 inkwell kernel: [ 0.000000] ACPI: RSDP 0x00000000000F0490 000024 (v02 ALASKA)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: XSDT 0x00000000BAA11070 000054 (v01 ALASKA A M I 01072009 AMI 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: FACP 0x00000000BAA18100 00010C (v05 ALASKA A M I 01072009 AMI 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI BIOS Warning (bug): Optional FADT field Pm2ControlBlock has zero address or length: 0x0000000000000000/0x1 (20140926/tbfadt-649)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: DSDT 0x00000000BAA11158 006FA8 (v02 ALASKA A M I 00000000 INTL 20051117)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: FACS 0x00000000BB815F80 000040
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: APIC 0x00000000BAA18210 00007E (v03 ALASKA A M I 01072009 AMI 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: FPDT 0x00000000BAA18290 000044 (v01 ALASKA A M I 01072009 AMI 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: MCFG 0x00000000BAA182D8 00003C (v01 ALASKA A M I 01072009 MSFT 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: HPET 0x00000000BAA18318 000038 (v01 ALASKA A M I 01072009 AMI 00000005)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] ACPI: BGRT 0x00000000BAA183A8 000038 (v00 ALASKA A M I 01072009 AMI 00010013)
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Zone ranges:
Nov 17 09:03:23 inkwell kernel: [ 0.000000] DMA [mem 0x00001000-0x00ffffff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] DMA32 [mem 0x01000000-0xffffffff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Normal [mem 0x100000000-0x1bfffffff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Movable zone start for each node
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Early memory node ranges
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0x00001000-0x0009dfff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0x00100000-0xba5d4fff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0xbca38000-0xbca38fff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0xbcc3f000-0xbd082fff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0xbd7f4000-0xbd7fffff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] node 0: [mem 0x100001000-0x1bfffffff]
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 1526532
Nov 17 09:03:23 inkwell kernel: [ 0.000000] Memory: 5939940K/6203144K available (12855K kernel code, 1246K rwdata, 3720K rodata, 1360K init, 948K bss, 263204K reserved)
Nov 17 09:03:23 inkwell kernel: [ 0.002444] ACPI: All ACPI Tables successfully acquired
Nov 17 09:03:23 inkwell kernel: [ 0.412618] #2
Nov 17 09:03:23 inkwell kernel: [ 0.425817] #3
Nov 17 09:03:23 inkwell kernel: [ 0.539830] ACPI: Executed 2 blocks of module-level executable AML code
Nov 17 09:03:23 inkwell kernel: [ 0.546069] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20140926/hwxface-580)
Nov 17 09:03:23 inkwell kernel: [ 0.546074] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20140926/hwxface-580)
Nov 17 09:03:23 inkwell kernel: [ 0.625478] ACPI: Enabled 1 GPEs in block 00 to 1F
Nov 17 09:03:23 inkwell kernel: [ 0.907435] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Nov 17 09:03:23 inkwell kernel: [ 0.910192] OCFS2 User DLM kernel interface loaded
Nov 17 09:03:23 inkwell kernel: [ 0.946206] scsi: <fdomain> Detection failed (no card)
Nov 17 09:03:23 inkwell kernel: [ 0.946267] qla2xxx [0000:00:00.0]-0005: : QLogic Fibre Channel HBA Driver: 8.07.00.16-k.
Nov 17 09:03:23 inkwell kernel: [ 0.946344] Emulex LightPulse Fibre Channel SCSI driver 10.4.8000.0.
Nov 17 09:03:23 inkwell kernel: [ 0.946394] Copyright(c) 2004-2014 Emulex. All rights reserved.
Nov 17 09:03:23 inkwell kernel: [ 0.954674] GDT-HA: Storage RAID Controller Driver. Version: 3.05
Nov 17 09:03:23 inkwell kernel: [ 0.956252] 3ware Storage Controller device driver for Linux v1.26.02.003.
Nov 17 09:03:23 inkwell kernel: [ 0.957866] 3ware 9000 Storage Controller device driver for Linux v2.26.02.014.
Nov 17 09:03:23 inkwell kernel: [ 4.904902] EXT3-fs (sda3): error: couldn't mount because of unsupported optional features (240)
Nov 17 09:03:23 inkwell kernel: [ 4.906441] EXT2-fs (sda3): error: couldn't mount because of unsupported optional features (240)
Nov 17 09:03:23 inkwell kernel: [ 7.022253] fglrx: module license 'Proprietary. (C) 2002 - ATI Technologies, Starnberg, GERMANY' taints kernel.
Nov 17 09:03:23 inkwell kernel: [ 7.023762] Disabling lock debugging due to kernel taint
Nov 17 09:03:23 inkwell kernel: [ 7.046416] <6>[fglrx] Maximum main memory to use for locked dma buffers: 5670 MBytes.
Nov 17 09:03:23 inkwell kernel: [ 7.048184] <6>[fglrx] vendor: 1002 device: 7300 revision: cb count: 1
Nov 17 09:03:23 inkwell kernel: [ 7.050182] <6>[fglrx] ioport: bar 4, base 0xe000, size: 0x100
Nov 17 09:03:23 inkwell kernel: [ 7.052001] <6>[fglrx] Kernel PAT support is enabled
Nov 17 09:03:23 inkwell kernel: [ 7.053551] <6>[fglrx] module loaded - fglrx 15.20.3 [Sep 8 2015] with 1 minors
Nov 17 09:03:23 inkwell kernel: [ 12.468921] FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Nov 17 09:03:25 inkwell ntpd[698]: restrict: 'monitor' cannot be disabled while 'limited' is enabled
Nov 17 09:03:25 inkwell ntpd[698]: bind(21) AF_INET6 fe80::21b:21ff:fe69:ca78%2#123 flags 0x11 failed: Cannot assign requested address
Nov 17 09:03:25 inkwell ntpd[698]: unable to create socket on eth0 (5) for fe80::21b:21ff:fe69:ca78%2#123
Nov 17 09:03:26 inkwell ntpd[698]: bind(24) AF_INET6 fe80::21b:21ff:fe69:ca78%2#123 flags 0x11 failed: Cannot assign requested address
Nov 17 09:03:26 inkwell ntpd[698]: unable to create socket on eth0 (6) for fe80::21b:21ff:fe69:ca78%2#123
Nov 17 09:03:36 inkwell kernel: [ 27.140209] <6>[fglrx] Firegl kernel thread PID: 847
Nov 17 09:03:36 inkwell kernel: [ 27.140286] <6>[fglrx] Firegl kernel thread PID: 848
Nov 17 09:03:36 inkwell kernel: [ 27.140341] <6>[fglrx] Firegl kernel thread PID: 849
Nov 17 09:03:36 inkwell kernel: [ 27.140501] <6>[fglrx] IRQ 51 Enabled
Nov 17 09:03:36 inkwell kernel: [ 27.204078] <6>[fglrx] Reserved FB block: Shared offset:0, size:1000000
Nov 17 09:03:36 inkwell kernel: [ 27.204080] <6>[fglrx] Reserved FB block: Unshared offset:f67a000, size:1000
Nov 17 09:03:36 inkwell kernel: [ 27.204081] <6>[fglrx] Reserved FB block: Unshared offset:f67b000, size:4000
Nov 17 09:03:36 inkwell kernel: [ 27.204082] <6>[fglrx] Reserved FB block: Unshared offset:f67f000, size:581000
Nov 17 09:03:36 inkwell kernel: [ 27.204083] <6>[fglrx] Reserved FB block: Unshared offset:fc00000, size:100000
Nov 17 09:03:36 inkwell kernel: [ 27.204084] <6>[fglrx] Reserved FB block: Unshared offset:fff56000, size:aa000
Nov 17 09:03:41 inkwell kdm_greet[860]: Cannot load /usr/share/apps/kdm/faces/.default.face: No such file or directory
Nov 17 09:04:05 inkwell kernel: [ 55.852783] ata1.00: exception Emask 0x10 SAct 0xc SErr 0x400000 action 0x6 frozen
Nov 17 09:04:05 inkwell kernel: [ 55.852787] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 09:04:05 inkwell kernel: [ 55.852790] ata1: SError: { Handshk }
Nov 17 09:04:05 inkwell kernel: [ 55.852792] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:05 inkwell kernel: [ 55.852796] ata1.00: cmd 61/00:10:00:9c:51/04:00:26:00:00/40 tag 2 ncq 524288 out
Nov 17 09:04:05 inkwell kernel: [ 55.852796] res 40/00:18:00:a0:51/00:00:26:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:05 inkwell kernel: [ 55.852797] ata1.00: status: { DRDY }
Nov 17 09:04:05 inkwell kernel: [ 55.852799] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:05 inkwell kernel: [ 55.852802] ata1.00: cmd 61/18:18:00:a0:51/02:00:26:00:00/40 tag 3 ncq 274432 out
Nov 17 09:04:05 inkwell kernel: [ 55.852802] res 40/00:18:00:a0:51/00:00:26:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:05 inkwell kernel: [ 55.852803] ata1.00: status: { DRDY }
Nov 17 09:04:05 inkwell kernel: [ 56.324863] ata1.00: exception Emask 0x10 SAct 0x70 SErr 0x400000 action 0x6 frozen
Nov 17 09:04:05 inkwell kernel: [ 56.324865] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 09:04:05 inkwell kernel: [ 56.324867] ata1: SError: { Handshk }
Nov 17 09:04:05 inkwell kernel: [ 56.324869] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:05 inkwell kernel: [ 56.324872] ata1.00: cmd 61/18:20:00:a0:51/02:00:26:00:00/40 tag 4 ncq 274432 out
Nov 17 09:04:05 inkwell kernel: [ 56.324872] res 40/00:30:98:3b:87/00:00:13:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:05 inkwell kernel: [ 56.324874] ata1.00: status: { DRDY }
Nov 17 09:04:05 inkwell kernel: [ 56.324876] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:05 inkwell kernel: [ 56.324879] ata1.00: cmd 61/00:28:00:9c:51/04:00:26:00:00/40 tag 5 ncq 524288 out
Nov 17 09:04:05 inkwell kernel: [ 56.324879] res 40/00:30:98:3b:87/00:00:13:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:05 inkwell kernel: [ 56.324880] ata1.00: status: { DRDY }
Nov 17 09:04:05 inkwell kernel: [ 56.324881] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:05 inkwell kernel: [ 56.324884] ata1.00: cmd 61/38:30:98:3b:87/01:00:13:00:00/40 tag 6 ncq 159744 out
Nov 17 09:04:05 inkwell kernel: [ 56.324884] res 40/00:30:98:3b:87/00:00:13:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:05 inkwell kernel: [ 56.324886] ata1.00: status: { DRDY }
Nov 17 09:04:06 inkwell kernel: [ 56.796941] ata1.00: exception Emask 0x10 SAct 0x300 SErr 0x400000 action 0x6 frozen
Nov 17 09:04:06 inkwell kernel: [ 56.796944] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 09:04:06 inkwell kernel: [ 56.796946] ata1: SError: { Handshk }
Nov 17 09:04:06 inkwell kernel: [ 56.796948] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:06 inkwell kernel: [ 56.796952] ata1.00: cmd 61/00:40:00:9c:51/04:00:26:00:00/40 tag 8 ncq 524288 out
Nov 17 09:04:06 inkwell kernel: [ 56.796952] res 40/00:48:00:a0:51/00:00:26:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:06 inkwell kernel: [ 56.796954] ata1.00: status: { DRDY }
Nov 17 09:04:06 inkwell kernel: [ 56.796955] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:06 inkwell kernel: [ 56.796958] ata1.00: cmd 61/18:48:00:a0:51/02:00:26:00:00/40 tag 9 ncq 274432 out
Nov 17 09:04:06 inkwell kernel: [ 56.796958] res 40/00:48:00:a0:51/00:00:26:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:06 inkwell kernel: [ 56.796960] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977103] ata1: limiting SATA link speed to 3.0 Gbps
Nov 17 09:04:43 inkwell kernel: [ 93.977108] ata1.00: exception Emask 0x10 SAct 0x700001ff SErr 0x400000 action 0x6 frozen
Nov 17 09:04:43 inkwell kernel: [ 93.977110] ata1.00: irq_stat 0x08000000, interface fatal error
Nov 17 09:04:43 inkwell kernel: [ 93.977112] ata1: SError: { Handshk }
Nov 17 09:04:43 inkwell kernel: [ 93.977114] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977117] ata1.00: cmd 61/20:00:00:91:8c/00:00:3a:00:00/40 tag 0 ncq 16384 out
Nov 17 09:04:43 inkwell kernel: [ 93.977117] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977119] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977121] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977124] ata1.00: cmd 61/08:08:08:94:8c/00:00:3a:00:00/40 tag 1 ncq 4096 out
Nov 17 09:04:43 inkwell kernel: [ 93.977124] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977125] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977126] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977129] ata1.00: cmd 61/18:10:60:ba:8c/00:00:3a:00:00/40 tag 2 ncq 12288 out
Nov 17 09:04:43 inkwell kernel: [ 93.977129] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977131] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977132] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977134] ata1.00: cmd 61/18:18:e0:e4:8c/00:00:3a:00:00/40 tag 3 ncq 12288 out
Nov 17 09:04:43 inkwell kernel: [ 93.977134] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977136] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977137] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977140] ata1.00: cmd 61/10:20:00:25:8d/00:00:3a:00:00/40 tag 4 ncq 8192 out
Nov 17 09:04:43 inkwell kernel: [ 93.977140] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977141] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977142] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977145] ata1.00: cmd 61/10:28:30:26:8d/00:00:3a:00:00/40 tag 5 ncq 8192 out
Nov 17 09:04:43 inkwell kernel: [ 93.977145] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977147] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977148] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977151] ata1.00: cmd 61/88:30:20:27:8d/00:00:3a:00:00/40 tag 6 ncq 69632 out
Nov 17 09:04:43 inkwell kernel: [ 93.977151] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977152] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977153] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977156] ata1.00: cmd 61/10:38:b0:27:8d/00:00:3a:00:00/40 tag 7 ncq 8192 out
Nov 17 09:04:43 inkwell kernel: [ 93.977156] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977157] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977158] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977161] ata1.00: cmd 61/10:40:80:2f:8d/00:00:3a:00:00/40 tag 8 ncq 8192 out
Nov 17 09:04:43 inkwell kernel: [ 93.977161] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977163] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977164] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977167] ata1.00: cmd 61/00:e0:68:44:4d/04:00:39:00:00/40 tag 28 ncq 524288 out
Nov 17 09:04:43 inkwell kernel: [ 93.977167] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977168] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977169] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977172] ata1.00: cmd 61/00:e8:68:48:4d/04:00:39:00:00/40 tag 29 ncq 524288 out
Nov 17 09:04:43 inkwell kernel: [ 93.977172] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977174] ata1.00: status: { DRDY }
Nov 17 09:04:43 inkwell kernel: [ 93.977175] ata1.00: failed command: WRITE FPDMA QUEUED
Nov 17 09:04:43 inkwell kernel: [ 93.977178] ata1.00: cmd 61/18:f0:68:4c:4d/02:00:39:00:00/40 tag 30 ncq 274432 out
Nov 17 09:04:43 inkwell kernel: [ 93.977178] res 40/00:40:80:2f:8d/00:00:3a:00:00/40 Emask 0x10 (ATA bus error)
Nov 17 09:04:43 inkwell kernel: [ 93.977179] ata1.00: status: { DRDY }
Note that there doesn't seem to be any error in syslog that matches the timeframe (as the reboot happened at 9:02, as you can see in messages). The ata errors are from the previous boot, and the stuff from 9:03 on is the reboot after the freeze. I included the full boot cycle all the way up to the point I posted this message for syslog, so you can see that the errors line up with the prevous boot. (I tagged it with [REBOOT OCCURRED HERE] )
I recognize this frustrating problem having experienced it in the past (2007-2008 or so) and was never able to find what caused it. The reason for this is that it is very hard to pinpoint what triggers these error-messages as a quick google-search on "failed command: WRITE FPDMA QUEUED" will show. Most of these surface under I/O pressure as happens in your case as well.
My feeling is that you probably need to look whether this is a hardware problem
1) does your hard-drive pass a full smartctl test?
2) does the problem remain if you swap out the SATA cable?
btw) On my system both these tests didn't give an answer. In the end it seemed to be a firmware problem of the SATA-controller not liking a specific series of hard-disks. After throwing those hard-disks out of my computer the problem disappeared. When I tried these same disks recently on a new motherboard it still had issues, so probably a firmware problem of the hard-disks itself in my case.
I recognize this frustrating problem having experienced it in the past (2007-2008 or so) and was never able to find what caused it. The reason for this is that it is very hard to pinpoint what triggers these error-messages as a quick google-search on "failed command: WRITE FPDMA QUEUED" will show. Most of these surface under I/O pressure as happens in your case as well.
My feeling is that you probably need to look whether this is a hardware problem
1) does your hard-drive pass a full smartctl test?
2) does the problem remain if you swap out the SATA cable?
btw) On my system both these tests didn't give an answer. In the end it seemed to be a firmware problem of the SATA-controller not liking a specific series of hard-disks. After throwing those hard-disks out of my computer the problem disappeared. When I tried these same disks recently on a new motherboard it still had issues, so probably a firmware problem of the hard-disks itself in my case.
I'm fairly sure those errors are unrelated to the problem, as they occur at every boot up, whether the freeze occurred previously or not. At the moment they don't seem to be an issue.
I'll run the smartctl test just to be sure, but this seems to be more of a network related issue.
LinuxQuestions.org is looking for people interested in writing
Editorials, Articles, Reviews, and more. If you'd like to contribute
content, let us know.