FAQ Search Today's Posts Mark Forums Read
» Video Reviews

» Linux Archive

Linux-archive is a website aiming to archive linux email lists and to make them easily accessible for linux users/developers.


» Sponsor

» Partners

» Sponsor

Go Back   Linux Archive > Debian > Debian Kernel

 
 
LinkBack Thread Tools
 
Old 10-14-2011, 10:52 PM
"brian m. carlson"
 
Default Bug#645366: linux-image-3.1.0-rc7-amd64: suspend fails with process waiting for IO on unmounted drive

Package: linux-2.6
Version: 3.1.0~rc7-1~experimental.1
Severity: normal

This morning I was backing up my laptop to another computer via sshfs
(and fuse). The afio archiver was writing to this sshfs-mounted
location. I decided to abort the operation with Ctrl-C, which caused
the sshfs mount to become unmounted; however, afio was apparently not
affected by the SIGINT (probably because processes in disk IO are
unkillable).

Several hours later, I attempted to suspend my computer and it failed to
do so. The kernel log (attached) indicated that the afio process from
hours before was preventing the suspend. Since processes waiting on
disk IO are unkillable (IMO a bug) and the underlying device to which
afio was writing was long gone, I was forced to reboot the machine in
order to get it to suspend. If I had not noticed that the machine had
failed to suspend, it could have stayed running in my bag and seriously
overheated.

This could be fixed by:

* making processes in the D state killable;
* aborting disk IO requests when the underlying device disappears;
* aborting disk IO requests when not doing so would prevent suspend from
occurring; or
* something else more clever that I haven't thought of.

-- Package-specific info:
** Version:
Linux version 3.1.0-rc7-amd64 (Debian 3.1.0~rc7-1~experimental.1) (ben@decadent.org.uk) (gcc version 4.5.3 (Debian 4.5.3-9) ) #1 SMP Mon Sep 26 13:09:27 UTC 2011

** Command line:
BOOT_IMAGE=/vmlinuz-3.1.0-rc7-amd64 root=/dev/mapper/lakeview-root ro usbcore.autosuspend=1

** Not tainted

** Kernel log:
[ 2163.093043] firewire_ohci 0000:15:00.1: restoring config space at offset 0x5 (was 0x0, writing 0xe4304000)
[ 2163.093050] firewire_ohci 0000:15:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xe4301000)
[ 2163.093057] firewire_ohci 0000:15:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x804000)
[ 2163.093066] firewire_ohci 0000:15:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006)
[ 2163.093391] PM: early resume of devices complete after 21.354 msecs
[ 2163.093483] i915 0000:00:02.0: power state changed by ACPI to D0
[ 2163.093487] i915 0000:00:02.0: power state changed by ACPI to D0
[ 2163.093495] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 2163.093499] i915 0000:00:02.0: setting latency timer to 64
[ 2163.095441] snd_hda_intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 2163.095877] snd_hda_intel 0000:00:1b.0: setting latency timer to 64
[ 2163.095929] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X
[ 2163.096102] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0
[ 2163.096105] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0
[ 2163.096112] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 2163.096119] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[ 2163.096147] usb usb2: root hub lost power or was reset
[ 2163.096162] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 2163.096169] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[ 2163.096195] usb usb3: root hub lost power or was reset
[ 2163.096207] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0
[ 2163.096210] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0
[ 2163.096215] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 2163.096222] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[ 2163.096248] usb usb4: root hub lost power or was reset
[ 2163.096262] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19
[ 2163.096268] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[ 2163.096295] usb usb5: root hub lost power or was reset
[ 2163.096307] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0
[ 2163.096312] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0
[ 2163.096319] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19
[ 2163.096326] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[ 2163.096381] pci 0000:00:1e.0: setting latency timer to 64
[ 2163.096395] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16
[ 2163.096400] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 2163.096424] ahci 0000:00:1f.2: setting latency timer to 64
[ 2163.096467] pcieport 0000:00:1c.0: wake-up capability disabled by ACPI
[ 2163.096474] tg3 0000:02:00.0: PME# disabled
[ 2163.097590] ata2: port disabled--ignoring
[ 2163.097775] sd 2:0:0:0: [sda] Starting disk
[ 2163.151016] Extended CMOS year: 2000
[ 2163.152112] firewire_core: skipped bus generations, destroying all nodes
[ 2163.260455] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
[ 2163.260459] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[ 2163.261906] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded
[ 2163.262831] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded
[ 2163.284317] ata1.00: configured for UDMA/33
[ 2163.652086] firewire_core: rediscovered device fw0
[ 2165.040073] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 2165.050904] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
[ 2165.050908] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
[ 2165.050912] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
[ 2165.054407] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
[ 2165.054410] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
[ 2165.054414] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
[ 2165.055928] ata3.00: configured for UDMA/100
[ 2165.232125] PM: resume of devices complete after 2138.682 msecs
[ 2165.232405] PM: Finishing wakeup.
[ 2165.232406] Restarting tasks ... done.
[ 2165.233020] video LNXVIDEO:00: Restoring backlight state
[ 2165.479273] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
[ 2165.491597] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
[ 2165.511177] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
[ 2165.536054] usb 2-2: new low speed USB device number 2 using uhci_hcd
[ 2165.563534] tg3 0000:02:00.0: irq 47 for MSI/MSI-X
[ 2165.744753] ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 2165.840997] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 2165.853697] usb 2-2: New USB device found, idVendor=046d, idProduct=c019
[ 2165.853702] usb 2-2: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 2165.853706] usb 2-2: Product: USB Optical Mouse
[ 2165.853708] usb 2-2: Manufacturer: Logitech
[ 2166.107897] input: Logitech USB Optical Mouse as /devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/input/input10
[ 2166.108267] generic-usb 0003:046D:C019.0001: input,hidraw0: USB HID v1.11 Mouse [Logitech USB Optical Mouse] on usb-0000:00:1d.0-2/input0
[ 2166.108296] usbcore: registered new interface driver usbhid
[ 2166.108299] usbhid: USB HID core driver
[ 2166.191576] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
[ 2166.244064] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
[ 2166.268161] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
[ 2168.670914] tg3 0000:02:00.0: eth0: Link is up at 1000 Mbps, full duplex
[ 2168.670925] tg3 0000:02:00.0: eth0: Flow control is on for TX and on for RX
[ 2168.672471] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 2171.568043] wlan0: direct probe to 00:26:f2:fa:e9:92 (try 1/3)
[ 2171.568930] wlan0: direct probe responded
[ 2171.572122] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
[ 2171.572559] wlan0: authenticated
[ 2171.575855] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
[ 2171.576508] wlan0: RX AssocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
[ 2171.576514] wlan0: associated
[ 2171.579287] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[ 2181.580830] wlan0: disassociating from 00:26:f2:fa:e9:92 by local choice (reason=3)
[ 2181.584329] cfg80211: Calling CRDA to update world regulatory domain
[ 2181.584698] wlan0: deauthenticating from 00:26:f2:fa:e9:92 by local choice (reason=3)
[ 2182.480046] wlan0: no IPv6 routers present
[ 2184.050181] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
[ 2184.050668] wlan0: authenticated
[ 2184.050865] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
[ 2184.051560] wlan0: RX ReassocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
[ 2184.051566] wlan0: associated
[ 2799.641408] exe (5327): /proc/5327/oom_adj is deprecated, please use /proc/5327/oom_score_adj instead.
[ 3011.636070] CE: hpet increased min_delta_ns to 20113 nsec

** Model information
sys_vendor: LENOVO
product_name: 9456CTO
product_version: Thinkpad R60
chassis_vendor: LENOVO
chassis_version: Not Available
bios_vendor: LENOVO
bios_version: 7CETD2WW (2.22 )
board_vendor: LENOVO
board_name: 9456CTO
board_version: Not Available

** Loaded modules:
Module Size Used by
usbhid 40516 0
hid 77268 1 usbhid
ecb 12737 1
ecryptfs 85507 1
parport_pc 22395 0
ppdev 12763 0
lp 17270 0
parport 31929 3 parport_pc,ppdev,lp
rfcomm 33848 0
bnep 17615 2
bluetooth 123915 10 rfcomm,bnep
tun 18394 2
cpufreq_stats 12862 0
cpufreq_userspace 12576 0
cpufreq_powersave 12454 0
cpufreq_conservative 13147 0
binfmt_misc 13040 1
uinput 17469 1
deflate 12551 0
ctr 12979 0
twofish_generic 16569 0
twofish_x86_64 12501 0
twofish_common 20544 2 twofish_generic,twofish_x86_64
camellia 29068 0
serpent 29015 0
blowfish 16632 0
cast5 24829 0
des_generic 20851 0
cbc 12755 0
cryptd 14549 0
aes_x86_64 16796 2
aes_generic 33026 1 aes_x86_64
xcbc 12709 0
rmd160 16640 0
sha512_generic 12625 0
sha256_generic 16797 0
sha1_generic 12575 0
hmac 12923 0
crypto_null 12732 0
af_key 31954 0
fuse 62254 3
ext4 322983 3
jbd2 62495 1 ext4
crc16 12343 2 bluetooth,ext4
microcode 25953 0
cpuid 12708 0
coretemp 13085 0
acpi_cpufreq 13009 1
mperf 12453 1 acpi_cpufreq
firewire_sbp2 18062 0
loop 22906 0
joydev 17262 0
kvm_intel 122096 0
kvm 283270 1 kvm_intel
pcmcia 36815 0
evdev 17558 16
arc4 12458 2
snd_hda_codec_analog 77707 1
iwl3945 51770 0
i915 352552 2
psmouse 55719 0
serio_raw 12846 0
thinkpad_acpi 61450 0
snd_hda_intel 26140 2
yenta_socket 22884 0
pcmcia_rsrc 17567 1 yenta_socket
snd_hda_codec 73139 2 snd_hda_codec_analog,snd_hda_intel
iwl_legacy 48256 1 iwl3945
snd_hwdep 13186 1 snd_hda_codec
snd_pcm 68104 2 snd_hda_intel,snd_hda_codec
mac80211 187537 2 iwl3945,iwl_legacy
drm_kms_helper 27216 1 i915
snd_seq 45208 0
pcmcia_core 18333 3 pcmcia,yenta_socket,pcmcia_rsrc
drm 163356 3 i915,drm_kms_helper
snd_timer 22581 2 snd_pcm,snd_seq
snd_seq_device 13137 1 snd_seq
cfg80211 136853 3 iwl3945,iwl_legacy,mac80211
i2c_i801 16870 0
rng_core 12696 0
ac 12624 0
battery 13109 0
power_supply 13475 2 ac,battery
rfkill 19080 4 bluetooth,thinkpad_acpi,cfg80211
tpm_tis 17440 0
tpm 17904 1 tpm_tis
tpm_bios 12944 1 tpm
nvram 13045 1 thinkpad_acpi
snd 52823 13 snd_hda_codec_analog,thinkpad_acpi,snd_hda_intel,s nd_hda_codec,snd_hwdep,snd_pcm,snd_seq,snd_timer,s nd_seq_device
video 17707 1 i915
soundcore 13152 1 snd
snd_page_alloc 13043 2 snd_hda_intel,snd_pcm
button 12930 1 i915
processor 27942 3 acpi_cpufreq
ext3 163015 2
jbd 57348 1 ext3
mbcache 13066 2 ext4,ext3
btrfs 492142 1
zlib_deflate 25570 2 deflate,btrfs
crc32c 12656 1
libcrc32c 12426 1 btrfs
dm_mod 63616 30
i2c_algo_bit 12850 1 i915
i2c_core 23909 5 i915,drm_kms_helper,drm,i2c_i801,i2c_algo_bit
sg 25985 0
sd_mod 36259 4
sr_mod 21811 0
cdrom 35093 1 sr_mod
crc_t10dif 12348 1 sd_mod
ata_generic 12479 0
ahci 24997 3
libahci 22903 1 ahci
uhci_hcd 26787 0
ata_piix 25358 0
libata 141012 4 ata_generic,ahci,libahci,ata_piix
firewire_ohci 35553 0
tg3 122951 0
thermal 17426 0
thermal_sys 18002 3 video,processor,thermal
ehci_hcd 40189 0
firewire_core 48407 2 firewire_sbp2,firewire_ohci
crc_itu_t 12347 1 firewire_core
scsi_mod 162442 5 firewire_sbp2,sg,sr_mod,sd_mod,libata
usbcore 128338 4 usbhid,uhci_hcd,ehci_hcd
libphy 19090 1 tg3

** Network interface configuration:
# This file describes the network interfaces available on your system
# and how to activate them. For more information, see interfaces(5).

# The loopback network interface
auto lo
iface lo inet loopback

# The primary network interface
#allow-hotplug eth0
#iface eth0 inet dhcp

#auto eth0

** Network status:
*** IP interfaces and addresses:
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 16436 qdisc noqueue state UNKNOWN
link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
inet 127.0.0.1/8 scope host lo
inet6 ::1/128 scope host
valid_lft forever preferred_lft forever
2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
link/ether 00:16:d3:b3:80:1e brd ff:ff:ff:ff:ff:ff
inet 172.16.2.249/16 brd 172.16.255.255 scope global eth0
inet6 2001:470:1f05:79:216:d3ff:feb3:801e/64 scope global dynamic
valid_lft 86327sec preferred_lft 14327sec
inet6 fe80::216:d3ff:feb3:801e/64 scope link
valid_lft forever preferred_lft forever
3: wlan0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc mq state UP qlen 1000
link/ether 00:1b:77:08:ed:e2 brd ff:ff:ff:ff:ff:ff
inet 172.16.2.249/16 brd 172.16.255.255 scope global wlan0
inet6 2001:470:1f05:79:21b:77ff:fe08:ede2/64 scope global dynamic
valid_lft 86327sec preferred_lft 14327sec
inet6 fe80::21b:77ff:fe08:ede2/64 scope link
valid_lft forever preferred_lft forever
8: teredo: <POINTOPOINT,MULTICAST,NOARP,UP,LOWER_UP> mtu 1280 qdisc pfifo_fast state UNKNOWN qlen 500
link/none
inet6 2001:0:53aa:64c:2016:3c9a:9d36:970e/32 scope global
valid_lft forever preferred_lft forever
inet6 fe80::ffff:ffff:ffff/64 scope link
valid_lft forever preferred_lft forever

*** Device statistics:
Inter-| Receive | Transmit
face |bytes packets errs drop fifo frame compressed multicast|bytes packets errs drop fifo colls carrier compressed
lo: 59832 760 0 0 0 0 0 0 59832 760 0 0 0 0 0 0
eth0: 586165 929 0 0 0 0 0 55 647840 4644 0 0 0 0 0 0
wlan0: 4539810 7162 0 0 0 0 0 0 471110 3199 0 0 0 0 0 0
teredo: 0 0 0 0 0 0 0 0 16992 354 0 0 0 0 0 0

*** Protocol statistics:
Ip:
8232 total packets received
4 with invalid addresses
0 forwarded
0 incoming packets discarded
8166 incoming packets delivered
7908 requests sent out
176 outgoing packets dropped
39 dropped because of missing route
Icmp:
374 ICMP messages received
0 input ICMP message failed.
ICMP input histogram:
destination unreachable: 374
377 ICMP messages sent
0 ICMP messages failed
ICMP output histogram:
destination unreachable: 377
IcmpMsg:
InType3: 374
OutType3: 377
Tcp:
417 active connections openings
0 passive connection openings
2 failed connection attempts
16 connection resets received
5 connections established
6447 segments received
6184 segments send out
28 segments retransmited
0 bad segments received.
42 resets sent
Udp:
1464 packets received
377 packets to unknown port received.
0 packet receive errors
1824 packets sent
UdpLite:
TcpExt:
1 packets pruned from receive queue because of socket buffer overrun
109 TCP sockets finished time wait in fast timer
315 delayed acks sent
Quick ack mode was activated 45 times
24 packets directly queued to recvmsg prequeue.
200 bytes directly received in process context from prequeue
3201 packet headers predicted
1 packets header predicted and directly queued to user
1265 acknowledgments not containing data payload received
114 predicted acknowledgments
7 congestion windows recovered without slow start after partial ack
5 retransmits in slow start
9 other TCP timeouts
49 packets collapsed in receive queue due to low socket buffer
45 DSACKs sent for old packets
7 DSACKs received
8 connections reset due to unexpected data
12 connections reset due to early user close
5 connections aborted due to timeout
TCPDSACKIgnoredNoUndo: 2
TCPSackShiftFallback: 3
IpExt:
InMcastPkts: 61
OutMcastPkts: 67
InBcastPkts: 24
InOctets: 4581763
OutOctets: 865768
InMcastOctets: 11621
OutMcastOctets: 11769
InBcastOctets: 7204


** PCI devices:
00:00.0 Host bridge [0600]: Intel Corporation Mobile 945GM/PM/GMS, 943/940GML and 945GT Express Memory Controller Hub [8086:27a0] (rev 03)
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:2017]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort+ >SERR- <PERR- INTx-
Latency: 0
Capabilities: <access denied>
Kernel driver in use: agpgart-intel

00:02.0 VGA compatible controller [0300]: Intel Corporation Mobile 945GM/GMS, 943/940GML Express Integrated Graphics Controller [8086:27a2] (rev 03) (prog-if 00 [VGA controller])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:201a]
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin A routed to IRQ 16
Region 0: Memory at ee100000 (32-bit, non-prefetchable) [size=512K]
Region 1: I/O ports at 1800 [size=8]
Region 2: Memory at d0000000 (32-bit, prefetchable) [size=256M]
Region 3: Memory at ee200000 (32-bit, non-prefetchable) [size=256K]
Expansion ROM at <unassigned> [disabled]
Capabilities: <access denied>
Kernel driver in use: i915

00:02.1 Display controller [0380]: Intel Corporation Mobile 945GM/GMS/GME, 943/940GML Express Integrated Graphics Controller [8086:27a6] (rev 03)
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:201a]
Control: I/O+ Mem+ BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Region 0: Memory at ee180000 (32-bit, non-prefetchable) [size=512K]
Capabilities: <access denied>

00:1b.0 Audio device [0403]: Intel Corporation N10/ICH 7 Family High Definition Audio Controller [8086:27d8] (rev 02)
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:2010]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Interrupt: pin B routed to IRQ 45
Region 0: Memory at ee240000 (64-bit, non-prefetchable) [size=16K]
Capabilities: <access denied>
Kernel driver in use: snd_hda_intel

00:1c.0 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 1 [8086:27d0] (rev 02) (prog-if 00 [Normal decode])
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Bus: primary=00, secondary=02, subordinate=02, sec-latency=0
I/O behind bridge: 0000c000-0000cfff
Memory behind bridge: ee000000-ee0fffff
Prefetchable memory behind bridge: 00000000c0000000-00000000c01fffff
Secondary status: 66MHz- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA+ VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>
Kernel driver in use: pcieport

00:1c.1 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 2 [8086:27d2] (rev 02) (prog-if 00 [Normal decode])
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Bus: primary=00, secondary=03, subordinate=03, sec-latency=0
I/O behind bridge: 00002000-00003fff
Memory behind bridge: ec000000-edffffff
Prefetchable memory behind bridge: 00000000e4000000-00000000e40fffff
Secondary status: 66MHz- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA+ VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>
Kernel driver in use: pcieport

00:1c.2 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 3 [8086:27d4] (rev 02) (prog-if 00 [Normal decode])
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Bus: primary=00, secondary=04, subordinate=0b, sec-latency=0
I/O behind bridge: 00004000-00005fff
Memory behind bridge: e8000000-e9ffffff
Prefetchable memory behind bridge: 00000000e4100000-00000000e41fffff
Secondary status: 66MHz- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort+ <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA+ VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>
Kernel driver in use: pcieport

00:1c.3 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI Express Port 4 [8086:27d6] (rev 02) (prog-if 00 [Normal decode])
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Bus: primary=00, secondary=0c, subordinate=13, sec-latency=0
I/O behind bridge: 00006000-00007fff
Memory behind bridge: ea000000-ebffffff
Prefetchable memory behind bridge: 00000000e4200000-00000000e42fffff
Secondary status: 66MHz- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA+ VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>
Kernel driver in use: pcieport

00:1d.0 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #1 [8086:27c8] (rev 02) (prog-if 00 [UHCI])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200a]
Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin A routed to IRQ 16
Region 4: I/O ports at 1820 [size=32]
Kernel driver in use: uhci_hcd

00:1d.1 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #2 [8086:27c9] (rev 02) (prog-if 00 [UHCI])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200a]
Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin B routed to IRQ 17
Region 4: I/O ports at 1840 [size=32]
Kernel driver in use: uhci_hcd

00:1d.2 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #3 [8086:27ca] (rev 02) (prog-if 00 [UHCI])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200a]
Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin C routed to IRQ 18
Region 4: I/O ports at 1860 [size=32]
Kernel driver in use: uhci_hcd

00:1d.3 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB UHCI Controller #4 [8086:27cb] (rev 02) (prog-if 00 [UHCI])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200a]
Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin D routed to IRQ 19
Region 4: I/O ports at 1880 [size=32]
Kernel driver in use: uhci_hcd

00:1d.7 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB2 EHCI Controller [8086:27cc] (rev 02) (prog-if 20 [EHCI])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200b]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin D routed to IRQ 19
Region 0: Memory at ee444000 (32-bit, non-prefetchable) [size=1K]
Capabilities: <access denied>
Kernel driver in use: ehci_hcd

00:1e.0 PCI bridge [0604]: Intel Corporation 82801 Mobile PCI Bridge [8086:2448] (rev e2) (prog-if 01 [Subtractive decode])
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Bus: primary=00, secondary=15, subordinate=18, sec-latency=32
I/O behind bridge: 00008000-0000bfff
Memory behind bridge: e4300000-e7ffffff
Prefetchable memory behind bridge: 00000000e0000000-00000000e3ffffff
Secondary status: 66MHz- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort+ <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA- VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>

00:1f.0 ISA bridge [0601]: Intel Corporation 82801GBM (ICH7-M) LPC Interface Bridge [8086:27b9] (rev 02)
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:2009]
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Capabilities: <access denied>

00:1f.1 IDE interface [0101]: Intel Corporation 82801G (ICH7 Family) IDE Controller [8086:27df] (rev 02) (prog-if 8a [Master SecP PriP])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200c]
Control: I/O+ Mem- BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin C routed to IRQ 16
Region 0: I/O ports at 01f0 [size=8]
Region 1: I/O ports at 03f4 [size=1]
Region 2: I/O ports at 0170 [size=8]
Region 3: I/O ports at 0374 [size=1]
Region 4: I/O ports at 1810 [size=16]
Kernel driver in use: ata_piix

00:1f.2 SATA controller [0106]: Intel Corporation 82801GBM/GHM (ICH7 Family) SATA AHCI Controller [8086:27c5] (rev 02) (prog-if 01 [AHCI 1.0])
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200d]
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx+
Status: Cap+ 66MHz+ UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0
Interrupt: pin B routed to IRQ 44
Region 0: I/O ports at 18d0 [size=8]
Region 1: I/O ports at 18c4 [size=4]
Region 2: I/O ports at 18c8 [size=8]
Region 3: I/O ports at 18c0 [size=4]
Region 4: I/O ports at 18b0 [size=16]
Region 5: Memory at ee444400 (32-bit, non-prefetchable) [size=1K]
Capabilities: <access denied>
Kernel driver in use: ahci

00:1f.3 SMBus [0c05]: Intel Corporation N10/ICH 7 Family SMBus Controller [8086:27da] (rev 02)
Subsystem: Lenovo ThinkPad T60/R60 series [17aa:200f]
Control: I/O+ Mem- BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B+ ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Interrupt: pin A routed to IRQ 23
Region 4: I/O ports at 18e0 [size=32]
Kernel driver in use: i801_smbus

02:00.0 Ethernet controller [0200]: Broadcom Corporation NetXtreme BCM5751M Gigabit Ethernet PCI Express [14e4:167d] (rev 21)
Subsystem: Lenovo ThinkPad R60e [17aa:2081]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Interrupt: pin A routed to IRQ 47
Region 0: Memory at ee000000 (64-bit, non-prefetchable) [size=64K]
Expansion ROM at <ignored> [disabled]
Capabilities: <access denied>
Kernel driver in use: tg3

03:00.0 Network controller [0280]: Intel Corporation PRO/Wireless 3945ABG [Golan] Network Connection [8086:4227] (rev 02)
Subsystem: Intel Corporation Device [8086:1010]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR+ FastB2B- DisINTx+
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 0, Cache Line Size: 64 bytes
Interrupt: pin A routed to IRQ 46
Region 0: Memory at edf00000 (32-bit, non-prefetchable) [size=4K]
Capabilities: <access denied>
Kernel driver in use: iwl3945

15:00.0 CardBus bridge [0607]: Texas Instruments PCIxx12 Cardbus Controller [104c:8039]
Subsystem: Lenovo Device [17aa:202f]
Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 168, Cache Line Size: 64 bytes
Interrupt: pin A routed to IRQ 16
Region 0: Memory at e4300000 (32-bit, non-prefetchable) [size=4K]
Bus: primary=15, secondary=16, subordinate=17, sec-latency=176
Memory window 0: e0000000-e3fff000 (prefetchable)
Memory window 1: c4000000-c7fff000
I/O window 0: 00008400-000084ff
I/O window 1: 00008000-000080ff
Secondary status: SERR
BridgeCtl: Parity- SERR- ISA- VGA- MAbort- >Reset+ 16bInt+ PostWrite+
16-bit legacy interface ports at 0001
Kernel driver in use: yenta_cardbus

15:00.1 FireWire (IEEE 1394) [0c00]: Texas Instruments PCIxx12 OHCI Compliant IEEE 1394 Host Controller [104c:803a] (prog-if 10 [OHCI])
Subsystem: Lenovo Device [17aa:202e]
Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Latency: 64 (500ns min, 1000ns max)
Interrupt: pin B routed to IRQ 17
Region 0: Memory at e4301000 (32-bit, non-prefetchable) [size=2K]
Region 1: Memory at e4304000 (32-bit, non-prefetchable) [size=16K]
Capabilities: <access denied>
Kernel driver in use: firewire_ohci


** USB devices:
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 002 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 002 Device 002: ID 046d:c019 Logitech, Inc. Optical Tilt Wheel Mouse


-- System Information:
Debian Release: wheezy/sid
APT prefers unstable
APT policy: (500, 'unstable'), (1, 'experimental')
Architecture: amd64 (x86_64)

Kernel: Linux 3.1.0-rc7-amd64 (SMP w/2 CPU cores)
Locale: LANG=en_US.UTF-8, LC_CTYPE=en_US.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash

Versions of packages linux-image-3.1.0-rc7-amd64 depends on:
ii cdebconf [debconf-2.0] 0.157
ii debconf [debconf-2.0] 1.5.41
ii initramfs-tools [linux-initramfs-tool] 0.99
ii linux-base 3.3
ii module-init-tools 3.16-1

Versions of packages linux-image-3.1.0-rc7-amd64 recommends:
ii firmware-linux-free 3

Versions of packages linux-image-3.1.0-rc7-amd64 suggests:
pn grub-pc 1.99-12
pn linux-doc-3.1.0 <none>

Versions of packages linux-image-3.1.0-rc7-amd64 is related to:
pn firmware-bnx2 <none>
pn firmware-bnx2x <none>
pn firmware-ipw2x00 <none>
pn firmware-ivtv <none>
pn firmware-iwlwifi 0.33
pn firmware-linux <none>
pn firmware-linux-nonfree <none>
pn firmware-qlogic <none>
pn firmware-ralink <none>
pn xen-hypervisor <none>

-- debconf information:
linux-image-3.1.0-rc7-amd64/postinst/depmod-error-initrd-3.1.0-rc7-amd64: false
linux-image-3.1.0-rc7-amd64/postinst/ignoring-ramdisk:
linux-image-3.1.0-rc7-amd64/prerm/removing-running-kernel-3.1.0-rc7-amd64: true
linux-image-3.1.0-rc7-amd64/postinst/missing-firmware-3.1.0-rc7-amd64:

--
brian m. carlson / brian with sandals: Houston, Texas, US
+1 832 623 2791 | http://www.crustytoothpaste.net/~bmc | My opinion only
OpenPGP: RSA v4 4096b: 88AC E9B2 9196 305B A994 7552 F1BA 225C 0223 B187
Oct 14 12:50:07 lakeview kernel: [129960.588174] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 12:50:07 lakeview kernel: [129960.588182] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 12:50:07 lakeview kernel: [129960.588188] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 12:50:07 lakeview kernel: [129960.588199] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 12:50:07 lakeview kernel: [129960.588210] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 12:50:07 lakeview kernel: [129960.588220] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 12:50:07 lakeview kernel: [129960.588231] Call Trace:
Oct 14 12:50:07 lakeview kernel: [129960.588246] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 12:50:07 lakeview kernel: [129960.588257] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 12:50:07 lakeview kernel: [129960.588282] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 12:50:07 lakeview kernel: [129960.588291] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 12:50:07 lakeview kernel: [129960.588316] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 12:50:07 lakeview kernel: [129960.588322] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 12:50:07 lakeview kernel: [129960.588326] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 12:50:07 lakeview kernel: [129960.588331] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 12:52:07 lakeview kernel: [130080.588215] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 12:52:07 lakeview kernel: [130080.588220] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 12:52:07 lakeview kernel: [130080.588224] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 12:52:07 lakeview kernel: [130080.588231] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 12:52:07 lakeview kernel: [130080.588238] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 12:52:07 lakeview kernel: [130080.588244] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 12:52:07 lakeview kernel: [130080.588250] Call Trace:
Oct 14 12:52:07 lakeview kernel: [130080.588260] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 12:52:07 lakeview kernel: [130080.588267] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 12:52:07 lakeview kernel: [130080.588285] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 12:52:07 lakeview kernel: [130080.588291] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 12:52:07 lakeview kernel: [130080.588299] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 12:52:07 lakeview kernel: [130080.588305] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 12:52:07 lakeview kernel: [130080.588309] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 12:52:07 lakeview kernel: [130080.588314] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 12:54:07 lakeview kernel: [130200.588197] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 12:54:07 lakeview kernel: [130200.588205] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 12:54:07 lakeview kernel: [130200.588211] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 12:54:07 lakeview kernel: [130200.588222] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 12:54:07 lakeview kernel: [130200.588234] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 12:54:07 lakeview kernel: [130200.588244] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 12:54:07 lakeview kernel: [130200.588254] Call Trace:
Oct 14 12:54:07 lakeview kernel: [130200.588270] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 12:54:07 lakeview kernel: [130200.588282] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 12:54:07 lakeview kernel: [130200.588312] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 12:54:07 lakeview kernel: [130200.588317] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 12:54:07 lakeview kernel: [130200.588324] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 12:54:07 lakeview kernel: [130200.588329] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 12:54:07 lakeview kernel: [130200.588333] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 12:54:07 lakeview kernel: [130200.588337] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 12:56:07 lakeview kernel: [130320.588195] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 12:56:07 lakeview kernel: [130320.588203] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 12:56:07 lakeview kernel: [130320.588209] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 12:56:07 lakeview kernel: [130320.588220] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 12:56:07 lakeview kernel: [130320.588231] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 12:56:07 lakeview kernel: [130320.588241] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 12:56:07 lakeview kernel: [130320.588252] Call Trace:
Oct 14 12:56:07 lakeview kernel: [130320.588266] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 12:56:07 lakeview kernel: [130320.588277] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 12:56:07 lakeview kernel: [130320.588301] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 12:56:07 lakeview kernel: [130320.588311] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 12:56:07 lakeview kernel: [130320.588324] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 12:56:07 lakeview kernel: [130320.588333] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 12:56:07 lakeview kernel: [130320.588340] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 12:56:07 lakeview kernel: [130320.588348] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 12:58:07 lakeview kernel: [130440.588297] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 12:58:07 lakeview kernel: [130440.588305] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 12:58:07 lakeview kernel: [130440.588311] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 12:58:07 lakeview kernel: [130440.588322] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 12:58:07 lakeview kernel: [130440.588342] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 12:58:07 lakeview kernel: [130440.588347] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 12:58:07 lakeview kernel: [130440.588353] Call Trace:
Oct 14 12:58:07 lakeview kernel: [130440.588364] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 12:58:07 lakeview kernel: [130440.588370] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 12:58:07 lakeview kernel: [130440.588387] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 12:58:07 lakeview kernel: [130440.588392] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 12:58:07 lakeview kernel: [130440.588399] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 12:58:07 lakeview kernel: [130440.588405] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 12:58:07 lakeview kernel: [130440.588408] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 12:58:07 lakeview kernel: [130440.588413] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 13:00:07 lakeview kernel: [130560.588128] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 13:00:07 lakeview kernel: [130560.588133] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 13:00:07 lakeview kernel: [130560.588136] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 13:00:07 lakeview kernel: [130560.588141] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 13:00:07 lakeview kernel: [130560.588147] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 13:00:07 lakeview kernel: [130560.588152] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 13:00:07 lakeview kernel: [130560.588158] Call Trace:
Oct 14 13:00:07 lakeview kernel: [130560.588167] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 13:00:07 lakeview kernel: [130560.588173] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 13:00:07 lakeview kernel: [130560.588190] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 13:00:07 lakeview kernel: [130560.588195] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 13:00:07 lakeview kernel: [130560.588202] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 13:00:07 lakeview kernel: [130560.588207] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 13:00:07 lakeview kernel: [130560.588210] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 13:00:07 lakeview kernel: [130560.588214] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 13:02:07 lakeview kernel: [130680.588168] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 13:02:07 lakeview kernel: [130680.588176] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 13:02:07 lakeview kernel: [130680.588182] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 13:02:07 lakeview kernel: [130680.588193] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 13:02:07 lakeview kernel: [130680.588205] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 13:02:07 lakeview kernel: [130680.588215] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 13:02:07 lakeview kernel: [130680.588225] Call Trace:
Oct 14 13:02:07 lakeview kernel: [130680.588242] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 13:02:07 lakeview kernel: [130680.588252] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 13:02:07 lakeview kernel: [130680.588276] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 13:02:07 lakeview kernel: [130680.588285] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 13:02:07 lakeview kernel: [130680.588299] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 13:02:07 lakeview kernel: [130680.588308] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 13:02:07 lakeview kernel: [130680.588315] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 13:02:07 lakeview kernel: [130680.588323] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 13:04:07 lakeview kernel: [130800.588118] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 13:04:07 lakeview kernel: [130800.588123] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 13:04:07 lakeview kernel: [130800.588126] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 13:04:07 lakeview kernel: [130800.588132] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 13:04:07 lakeview kernel: [130800.588137] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 13:04:07 lakeview kernel: [130800.588142] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 13:04:07 lakeview kernel: [130800.588148] Call Trace:
Oct 14 13:04:07 lakeview kernel: [130800.588157] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 13:04:07 lakeview kernel: [130800.588163] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 13:04:07 lakeview kernel: [130800.588180] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 13:04:07 lakeview kernel: [130800.588185] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 13:04:07 lakeview kernel: [130800.588192] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 13:04:07 lakeview kernel: [130800.588197] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 13:04:07 lakeview kernel: [130800.588200] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 13:04:07 lakeview kernel: [130800.588204] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 13:06:07 lakeview kernel: [130920.588106] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 13:06:07 lakeview kernel: [130920.588112] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 13:06:07 lakeview kernel: [130920.588115] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 13:06:07 lakeview kernel: [130920.588121] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 13:06:07 lakeview kernel: [130920.588127] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 13:06:07 lakeview kernel: [130920.588132] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 13:06:07 lakeview kernel: [130920.588137] Call Trace:
Oct 14 13:06:07 lakeview kernel: [130920.588148] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 13:06:07 lakeview kernel: [130920.588154] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 13:06:07 lakeview kernel: [130920.588173] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 13:06:07 lakeview kernel: [130920.588179] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 13:06:07 lakeview kernel: [130920.588186] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 13:06:07 lakeview kernel: [130920.588191] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 13:06:07 lakeview kernel: [130920.588194] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 13:06:07 lakeview kernel: [130920.588199] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 13:08:07 lakeview kernel: [131040.588200] INFO: task afio:22818 blocked for more than 120 seconds.
Oct 14 13:08:07 lakeview kernel: [131040.588208] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Oct 14 13:08:07 lakeview kernel: [131040.588214] afio D ffff880086e20300 0 22818 1 0x00000084
Oct 14 13:08:07 lakeview kernel: [131040.588225] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 13:08:07 lakeview kernel: [131040.588236] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 13:08:07 lakeview kernel: [131040.588246] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 13:08:07 lakeview kernel: [131040.588256] Call Trace:
Oct 14 13:08:07 lakeview kernel: [131040.588271] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 13:08:07 lakeview kernel: [131040.588282] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 13:08:07 lakeview kernel: [131040.588305] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 13:08:07 lakeview kernel: [131040.588314] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 13:08:07 lakeview kernel: [131040.588328] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 13:08:07 lakeview kernel: [131040.588337] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 13:08:07 lakeview kernel: [131040.588343] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 13:08:07 lakeview kernel: [131040.588352] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 14:29:55 lakeview kernel: [135948.726956] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Oct 14 14:30:01 lakeview kernel: [135954.840499] wlan0: authenticate with 00:26:f2:fa:e9:90 (try 1)
Oct 14 14:30:01 lakeview kernel: [135954.842603] wlan0: authenticated
Oct 14 14:30:01 lakeview kernel: [135954.848831] wlan0: associate with 00:26:f2:fa:e9:90 (try 1)
Oct 14 14:30:01 lakeview kernel: [135954.852370] wlan0: RX AssocResp from 00:26:f2:fa:e9:90 (capab=0x431 status=0 aid=2)
Oct 14 14:30:01 lakeview kernel: [135954.852377] wlan0: associated
Oct 14 14:30:01 lakeview kernel: [135954.855290] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Oct 14 14:30:06 lakeview kernel: [135959.121928] wlan0: deauthenticating from 00:26:f2:fa:e9:90 by local choice (reason=3)
Oct 14 14:30:06 lakeview kernel: [135959.140276] cfg80211: Calling CRDA to update world regulatory domain
Oct 14 14:30:11 lakeview kernel: [135964.474398] wlan0: authenticate with 00:26:f2:fa:e9:90 (try 1)
Oct 14 14:30:11 lakeview kernel: [135964.476144] wlan0: authenticated
Oct 14 14:30:11 lakeview kernel: [135964.476367] wlan0: associate with 00:26:f2:fa:e9:90 (try 1)
Oct 14 14:30:11 lakeview kernel: [135964.479293] wlan0: RX ReassocResp from 00:26:f2:fa:e9:90 (capab=0x431 status=0 aid=2)
Oct 14 14:30:11 lakeview kernel: [135964.479301] wlan0: associated
Oct 14 14:31:00 lakeview kernel: [136014.009273] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 14:31:00 lakeview kernel: [136014.010399] wlan0: authenticated
Oct 14 14:31:00 lakeview kernel: [136014.025795] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 14:31:00 lakeview kernel: [136014.026511] wlan0: RX ReassocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
Oct 14 14:31:00 lakeview kernel: [136014.026518] wlan0: associated
Oct 14 18:08:25 lakeview kernel: [149058.207769] wlan0: deauthenticating from 00:26:f2:fa:e9:92 by local choice (reason=3)
Oct 14 18:08:25 lakeview kernel: [149058.254540] cfg80211: Calling CRDA for country: US
Oct 14 18:08:30 lakeview kernel: [149063.486574] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:08:30 lakeview kernel: [149063.487039] wlan0: authenticated
Oct 14 18:08:30 lakeview kernel: [149063.487262] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:08:30 lakeview kernel: [149063.488000] wlan0: RX ReassocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
Oct 14 18:08:30 lakeview kernel: [149063.488033] wlan0: associated
Oct 14 18:31:34 lakeview kernel: [150447.836444] tg3 0000:02:00.0: PME# enabled
Oct 14 18:31:34 lakeview kernel: [150447.836473] pcieport 0000:00:1c.0: wake-up capability enabled by ACPI
Oct 14 18:31:34 lakeview kernel: [150448.064917] wlan0: deauthenticating from 00:26:f2:fa:e9:92 by local choice (reason=3)
Oct 14 18:31:34 lakeview kernel: [150448.088296] cfg80211: Calling CRDA to update world regulatory domain
Oct 14 18:31:36 lakeview kernel: [150449.619033] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
Oct 14 18:31:36 lakeview kernel: [150449.891002] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:31:37 lakeview kernel: [150450.133228] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:31:37 lakeview kernel: [150450.921981] PM: Syncing filesystems ... done.
Oct 14 18:31:37 lakeview kernel: [150451.007456] PM: Preparing system for mem sleep
Oct 14 18:31:58 lakeview kernel: [150451.288365] Freezing user space processes ...
Oct 14 18:31:58 lakeview kernel: [150471.304087] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Oct 14 18:31:58 lakeview kernel: [150471.304219] afio D ffff880086e20300 0 22818 1 0x00800084
Oct 14 18:31:58 lakeview kernel: [150471.304232] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 18:31:58 lakeview kernel: [150471.304247] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 18:31:58 lakeview kernel: [150471.304260] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 18:31:58 lakeview kernel: [150471.304274] Call Trace:
Oct 14 18:31:58 lakeview kernel: [150471.304290] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 18:31:58 lakeview kernel: [150471.304309] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 18:31:58 lakeview kernel: [150471.304325] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 18:31:58 lakeview kernel: [150471.304332] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 18:31:58 lakeview kernel: [150471.304339] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 18:31:58 lakeview kernel: [150471.304345] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 18:31:58 lakeview kernel: [150471.304350] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 18:31:58 lakeview kernel: [150471.304355] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 18:31:58 lakeview kernel: [150471.304369]
Oct 14 18:31:58 lakeview kernel: [150471.304371] Restarting tasks ... done.
Oct 14 18:31:58 lakeview kernel: [150471.304834] video LNXVIDEO:00: Restoring backlight state
Oct 14 18:31:58 lakeview kernel: [150471.698766] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
Oct 14 18:31:58 lakeview kernel: [150471.703781] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:31:58 lakeview kernel: [150472.099486] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:31:59 lakeview kernel: [150472.144084] tg3 0000:02:00.0: BAR 0: set to [mem 0xee000000-0xee00ffff 64bit] (PCI address [0xee000000-0xee00ffff])
Oct 14 18:31:59 lakeview kernel: [150472.144196] tg3 0000:02:00.0: irq 47 for MSI/MSI-X
Oct 14 18:31:59 lakeview kernel: [150472.310554] ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct 14 18:31:59 lakeview kernel: [150472.381758] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Oct 14 18:32:01 lakeview kernel: [150474.601566] tg3 0000:02:00.0: eth0: Link is up at 1000 Mbps, full duplex
Oct 14 18:32:01 lakeview kernel: [150474.601577] tg3 0000:02:00.0: eth0: Flow control is on for TX and on for RX
Oct 14 18:32:01 lakeview kernel: [150474.602837] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Oct 14 18:32:05 lakeview kernel: [150478.106337] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:32:05 lakeview kernel: [150478.106796] wlan0: authenticated
Oct 14 18:32:05 lakeview kernel: [150478.107009] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:32:05 lakeview kernel: [150478.107868] wlan0: RX AssocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
Oct 14 18:32:05 lakeview kernel: [150478.107875] wlan0: associated
Oct 14 18:32:05 lakeview kernel: [150478.110965] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Oct 14 18:32:06 lakeview kernel: [150479.686167] tg3 0000:02:00.0: eth0: Link is down
Oct 14 18:32:07 lakeview kernel: [150480.600116] usb 2-2: USB disconnect, device number 3
Oct 14 18:32:07 lakeview kernel: [150480.929812] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=600
Oct 14 18:32:07 lakeview kernel: [150480.934988] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:07 lakeview kernel: [150480.994470] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:08 lakeview kernel: [150481.369169] pcieport 0000:00:1c.0: wake-up capability disabled by ACPI
Oct 14 18:32:08 lakeview kernel: [150481.369187] tg3 0000:02:00.0: PME# disabled
Oct 14 18:32:08 lakeview kernel: [150481.395906] wlan0: deauthenticating from 00:26:f2:fa:e9:92 by local choice (reason=3)
Oct 14 18:32:08 lakeview kernel: [150481.404945] cfg80211: Calling CRDA to update world regulatory domain
Oct 14 18:32:08 lakeview kernel: [150482.041040] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
Oct 14 18:32:08 lakeview kernel: [150482.046028] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:32:08 lakeview kernel: [150482.078768] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:32:09 lakeview kernel: [150482.505155] PM: Syncing filesystems ... done.
Oct 14 18:32:09 lakeview kernel: [150482.612209] PM: Preparing system for mem sleep
Oct 14 18:32:29 lakeview kernel: [150482.832450] Freezing user space processes ...
Oct 14 18:32:29 lakeview kernel: [150502.848153] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Oct 14 18:32:29 lakeview kernel: [150502.848296] afio D ffff880086e20300 0 22818 1 0x00800084
Oct 14 18:32:29 lakeview kernel: [150502.848311] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 18:32:29 lakeview kernel: [150502.848325] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 18:32:29 lakeview kernel: [150502.848338] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 18:32:29 lakeview kernel: [150502.848352] Call Trace:
Oct 14 18:32:29 lakeview kernel: [150502.848378] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 18:32:29 lakeview kernel: [150502.848386] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 18:32:29 lakeview kernel: [150502.848404] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 18:32:29 lakeview kernel: [150502.848411] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 18:32:29 lakeview kernel: [150502.848419] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 18:32:29 lakeview kernel: [150502.848426] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 18:32:29 lakeview kernel: [150502.848430] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 18:32:29 lakeview kernel: [150502.848436] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 18:32:29 lakeview kernel: [150502.848454]
Oct 14 18:32:29 lakeview kernel: [150502.848456] Restarting tasks ... done.
Oct 14 18:32:29 lakeview kernel: [150502.849271] video LNXVIDEO:00: Restoring backlight state
Oct 14 18:32:30 lakeview kernel: [150503.122326] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=600
Oct 14 18:32:30 lakeview kernel: [150503.127822] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:30 lakeview kernel: [150503.137634] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:30 lakeview kernel: [150503.208055] tg3 0000:02:00.0: BAR 0: set to [mem 0xee000000-0xee00ffff 64bit] (PCI address [0xee000000-0xee00ffff])
Oct 14 18:32:30 lakeview kernel: [150503.208153] tg3 0000:02:00.0: irq 47 for MSI/MSI-X
Oct 14 18:32:30 lakeview kernel: [150503.374786] ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct 14 18:32:30 lakeview kernel: [150503.445646] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Oct 14 18:32:36 lakeview kernel: [150509.437718] wlan0: authenticate with 00:26:f2:fa:e9:90 (try 1)
Oct 14 18:32:36 lakeview kernel: [150509.437771] wlan0: deauthenticating from 00:26:f2:fa:e9:90 by local choice (reason=3)
Oct 14 18:32:37 lakeview kernel: [150510.269012] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=0
Oct 14 18:32:37 lakeview kernel: [150510.274198] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:32:37 lakeview kernel: [150510.297714] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=0
Oct 14 18:32:37 lakeview kernel: [150510.603045] PM: Syncing filesystems ... done.
Oct 14 18:32:37 lakeview kernel: [150510.721542] PM: Preparing system for mem sleep
Oct 14 18:32:57 lakeview kernel: [150510.940367] Freezing user space processes ...
Oct 14 18:32:57 lakeview kernel: [150530.956129] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Oct 14 18:32:57 lakeview kernel: [150530.956269] afio D ffff880086e20300 0 22818 1 0x00800084
Oct 14 18:32:57 lakeview kernel: [150530.956283] ffff880086e20300 0000000000000086 ffff8800065c1848 ffffffff81037a71
Oct 14 18:32:57 lakeview kernel: [150530.956297] ffff88003687f120 0000000000012f00 ffff8800001effd8 ffff8800001effd8
Oct 14 18:32:57 lakeview kernel: [150530.956311] 0000000000012f00 ffff880086e20300 0000000000012f00 0000000000012f00
Oct 14 18:32:57 lakeview kernel: [150530.956325] Call Trace:
Oct 14 18:32:57 lakeview kernel: [150530.956341] [<ffffffff81037a71>] ? __wake_up_common+0x41/0x78
Oct 14 18:32:57 lakeview kernel: [150530.956354] [<ffffffff81344bb4>] ? _raw_spin_lock_irqsave+0x9/0x25
Oct 14 18:32:57 lakeview kernel: [150530.956386] [<ffffffffa0577ab3>] ? fuse_request_send+0x1a2/0x251 [fuse]
Oct 14 18:32:57 lakeview kernel: [150530.956393] [<ffffffff8106288b>] ? wake_up_bit+0x23/0x23
Oct 14 18:32:57 lakeview kernel: [150530.956401] [<ffffffffa057dd2f>] ? fuse_flush+0xca/0xfe [fuse]
Oct 14 18:32:57 lakeview kernel: [150530.956408] [<ffffffff810fcae7>] ? filp_close+0x3b/0x6a
Oct 14 18:32:57 lakeview kernel: [150530.956413] [<ffffffff810fcb9d>] ? sys_close+0x87/0xc4
Oct 14 18:32:57 lakeview kernel: [150530.956418] [<ffffffff81349e52>] ? system_call_fastpath+0x16/0x1b
Oct 14 18:32:57 lakeview kernel: [150530.956433]
Oct 14 18:32:57 lakeview kernel: [150530.956435] Restarting tasks ... done.
Oct 14 18:32:57 lakeview kernel: [150530.956778] video LNXVIDEO:00: Restoring backlight state
Oct 14 18:32:58 lakeview kernel: [150531.181357] EXT4-fs (dm-4): re-mounted. Opts: data=ordered,barrier=0,journal_async_commit,user_x attr,commit=600
Oct 14 18:32:58 lakeview kernel: [150531.186459] EXT4-fs (dm-2): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:58 lakeview kernel: [150531.217923] EXT4-fs (dm-3): re-mounted. Opts: data=ordered,barrier=0,commit=600
Oct 14 18:32:58 lakeview kernel: [150531.288057] tg3 0000:02:00.0: BAR 0: set to [mem 0xee000000-0xee00ffff 64bit] (PCI address [0xee000000-0xee00ffff])
Oct 14 18:32:58 lakeview kernel: [150531.288159] tg3 0000:02:00.0: irq 47 for MSI/MSI-X
Oct 14 18:32:58 lakeview kernel: [150531.454841] ADDRCONF(NETDEV_UP): eth0: link is not ready
Oct 14 18:32:58 lakeview kernel: [150531.526239] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Oct 14 18:33:04 lakeview kernel: [150537.227587] wlan0: authenticate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:33:04 lakeview kernel: [150537.228232] wlan0: authenticated
Oct 14 18:33:04 lakeview kernel: [150537.228561] wlan0: associate with 00:26:f2:fa:e9:92 (try 1)
Oct 14 18:33:04 lakeview kernel: [150537.229258] wlan0: RX AssocResp from 00:26:f2:fa:e9:92 (capab=0x411 status=0 aid=1)
Oct 14 18:33:04 lakeview kernel: [150537.229265] wlan0: associated
Oct 14 18:33:04 lakeview kernel: [150537.232948] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes
 
Old 10-15-2011, 04:25 AM
Ben Hutchings
 
Default Bug#645366: linux-image-3.1.0-rc7-amd64: suspend fails with process waiting for IO on unmounted drive

On Fri, 2011-10-14 at 22:52 +0000, brian m. carlson wrote:
> Package: linux-2.6
> Version: 3.1.0~rc7-1~experimental.1
> Severity: normal
>
> This morning I was backing up my laptop to another computer via sshfs
> (and fuse). The afio archiver was writing to this sshfs-mounted
> location. I decided to abort the operation with Ctrl-C, which caused
> the sshfs mount to become unmounted; however, afio was apparently not
> affected by the SIGINT (probably because processes in disk IO are
> unkillable).

I don't understand why SIGINT would be delivered to ssh rather than to
afio.

> Several hours later, I attempted to suspend my computer and it failed to
> do so. The kernel log (attached) indicated that the afio process from
> hours before was preventing the suspend. Since processes waiting on
> disk IO are unkillable (IMO a bug) and the underlying device to which
> afio was writing was long gone, I was forced to reboot the machine in
> order to get it to suspend. If I had not noticed that the machine had
> failed to suspend, it could have stayed running in my bag and seriously
> overheated.
>
> This could be fixed by:
>
> * making processes in the D state killable;

The D state really means that the thread is running some kernel code
that is waiting and cannot handle signals. It *is* possible for kernel
code to wait and allow the current thread (and process) to be killed
(SIGKILL) but without handling any other signal. However, the code has
to be changed to abort if the process is killed. It is not possible to
change all such waits at once, as the cleanup code will be different in
each case.

> * aborting disk IO requests when the underlying device disappears;
[...]

I believe this should have happened.

Ben.

--
Ben Hutchings
This sentence contradicts itself - no actually it doesn't.
 
Old 10-15-2011, 02:33 PM
"brian m. carlson"
 
Default Bug#645366: linux-image-3.1.0-rc7-amd64: suspend fails with process waiting for IO on unmounted drive

On Sat, Oct 15, 2011 at 05:25:26AM +0100, Ben Hutchings wrote:
> On Fri, 2011-10-14 at 22:52 +0000, brian m. carlson wrote:
> I don't understand why SIGINT would be delivered to ssh rather than to
> afio.

Well, sshfs, not just ssh. afio is running under a shell script called
tob (from the package of the same name). tob sets up the mount using:

PRECMD='klist -5s || kinit bmc; sshfs bmc@castro:/media/backup/ /media/backup'

When I hit Ctrl-C, something got sent SIGINT and tob cleaned itself up;
part of the cleanup routine is to unmount the filesystem:

POSTCMD='fusermount -u -z /media/backup'

The command is called from a trap command in the shell script I believe.
I'm not sure which program actually received the SIGINT itself, but
/media/backup was eventually unmounted.

> > * aborting disk IO requests when the underlying device disappears;
> [...]
>
> I believe this should have happened.

Great. If the kernel were fixed so that happened, that would be
satisfactory.

--
brian m. carlson / brian with sandals: Houston, Texas, US
+1 832 623 2791 | http://www.crustytoothpaste.net/~bmc | My opinion only
OpenPGP: RSA v4 4096b: 88AC E9B2 9196 305B A994 7552 F1BA 225C 0223 B187
 

Thread Tools




All times are GMT. The time now is 01:21 PM.

VBulletin, Copyright ©2000 - 2014, Jelsoft Enterprises Ltd.
Content Relevant URLs by vBSEO ©2007, Crawlability, Inc.
Copyright 2007 - 2008, www.linux-archive.org