[dm-devel] dm-crypt low performance
Ritesh Raj Sarraf
rrs at researchut.com
Tue Jan 13 19:52:07 UTC 2009
Okay!! I think I now have the correct steps to reproduce it consistently.
----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
usr sys idl wai hiq siq| read writ| recv send| in out | int csw
10 25 0 64 0 1| 128k 15M| 158B 0 | 0 0 |3475 6007
10 35 0 53 0 2| 75M 15M| 0 0 | 0 0 |3741 6414
9 35 7 47 0 1| 74M 15M| 0 0 | 0 0 |3798 6372
9 36 3 50 0 2| 72M 13M| 0 0 | 0 0 |3476 5915
9 28 0 62 0 1| 31M 14M| 0 0 | 0 0 |3455 5850
10 23 0 65 0 1| 0 14M| 92B 0 | 0 0 |3103 5343
3 21 0 75 0 1| 0 13M| 92B 0 | 0 0 |3056 4698
2 21 0 76 0 1| 0 14M| 92B 0 | 0 0 |3121 4699
3 20 0 76 0 1| 0 13M| 0 0 | 0 0 |2973 4487
1 20 0 78 0 1| 0 13M| 0 65B| 0 0 |2991 4487
4 22 0 72 0 1| 15M 13M| 0 0 | 0 0 |3147 4881
10 21 5 63 0 1| 70M 3084k| 0 0 | 0 0 |2658 4568
9 32 11 46 0 1| 72M 9848k| 0 0 | 0 0 |3192 5481
10 37 0 51 0 2| 74M 17M| 0 0 | 0 0 |4042 6892
10 28 0 61 0 1| 23M 16M| 0 0 | 0 0 |3619 6116
2 26 0 71 0 1| 0 17M| 0 0 | 0 0 |3748 5736
5 29 2 63 0 1| 34M 16M| 0 0 | 0 0 |3763 6144
4 34 4 56 0 2| 40M 17M| 0 0 | 0 0 |3895 6392
7 34 0 58 0 2| 44M 18M| 0 0 | 0 0 |3993 6056
15 31 0 51 1 1| 50M 18M| 0 65B| 0 4096B|3816 7130
1 37 0 60 0 2| 72M 17M| 0 0 | 0 0 |4079 6412 ^C
The above result is from a freshly booted linux with the same suspected faulty
USB HDD enclosure. I ran it on 2 kernels, one standard and one debug, and both
gave similar results.
So shouldn't be faulty hardware.
So then with my standard kernel, I booted + hibernated and then resumed and
then again ran the I/O. Here are the same results.
----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
usr sys idl wai hiq siq| read writ| recv send| in out | int csw
1 1 0 97 0 0| 0 896k| 54B 0 | 0 0 | 666 778
2 2 0 95 0 0| 0 864k| 54B 78B| 0 0 | 693 834
1 1 0 98 0 0| 0 864k| 0 0 | 0 0 | 649 691
1 1 0 98 0 0| 0 896k| 0 0 | 0 0 | 655 727
2 2 0 96 0 0| 0 1112k| 0 0 | 0 0 | 700 854
2 1 0 97 0 0| 0 1032k| 0 0 | 0 0 | 669 865
2 1 0 96 0 0| 0 1048k| 0 0 | 0 0 | 650 816
2 2 0 97 0 0| 0 896k| 0 0 | 0 0 | 663 808
0 2 0 98 0 0| 0 864k| 0 0 | 0 0 | 635 686
3 13 0 82 0 0| 59M 928k| 0 0 | 0 0 |1326 1393
1 13 0 86 0 0| 74M 896k| 0 0 | 0 0 |1472 1388
2 8 0 90 0 0| 40M 928k| 0 0 | 0 0 |1163 1195
1 1 0 97 0 0| 0 864k| 0 0 | 0 0 | 738 829
2 2 0 96 0 0| 0 896k| 0 0 | 0 0 | 787 902
1 2 0 97 0 0| 0 1048k| 0 0 | 0 0 | 766 911
1 1 0 97 0 0| 0 896k| 92B 0 | 0 0 | 766 927
2 2 30 66 0 0| 0 1080k| 92B 0 | 0 0 | 750 868
1 1 51 47 0 0| 0 864k| 92B 0 | 0 0 | 712 808
1 1 50 47 0 0| 0 896k| 92B 0 | 0 0 | 722 872
1 2 10 86 0 0| 0 864k| 184B 0 | 0 0 | 748 972
1 1 0 98 0 0| 0 864k| 92B 0 | 0 0 | 730 817
So this seems to be happening on my laptop when the OS has used the
hibernation feature. I'm of-course doing a luksClose and USB device
disconnection before hibernation.
Here's the usb device listing after hibernation/resume.
rrs at learner:~$ cat /tmp/lsusb.suspend
Bus 005 Device 005: ID 046d:08c6 Logitech, Inc. QuickCam for DELL Notebooks
Bus 005 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 004 Device 007: ID 05e3:0702 Genesys Logic, Inc. USB 2.0 IDE Adapter
Bus 004 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 002 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 001 Device 005: ID 046d:c00c Logitech, Inc. Optical Wheel Mouse
Bus 001 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
And here's the usb device listing after a fresh boot.
rrs at learner:~$ lsusb
Bus 005 Device 004: ID 05e3:0702 Genesys Logic, Inc. USB 2.0 IDE Adapter
Bus 005 Device 003: ID 046d:08c6 Logitech, Inc. QuickCam for DELL Notebooks
Bus 005 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 001 Device 004: ID 046d:c00c Logitech, Inc. Optical Wheel Mouse
Bus 001 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Ritesh
On Tuesday 13 Jan 2009 23:07:45 Ritesh Raj Sarraf wrote:
> On Tuesday 13 Jan 2009 21:20:48 Milan Broz wrote:
> > Ritesh Raj Sarraf wrote:
> > > I'm using dm-crypt on an external USB enclosure ide hdd. I copied 20Gb
> > > of data on to the encrypted device and am suffering severe performance
> > > penalty. After a couple of seconds, all processes involved in the I/O
> > > keep stalling. They periodically resume, just for a couple of seconds
> > > and then again stall.
> > >
> > > Running linux 2.6.26.
> >
> > Please can you try it without dm-crypt involved?
> > Just copy 20Gb to your unencrypted disk attached through USB.
> >
> > I saw this problem with plain USB attached storage some time ago too.
> >
> > There is only one thread in dm-crypt and it is waiting for io_schedule,
> > so I think it is not dm-crypt who is blocking it, but the layer
> > below the dm-crypt.
>
> So I tried the following.
>
> Copied 20Gb of data to a partition on the External USB disk. Here are the
> results:
>
> ----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
> usr sys idl wai hiq siq| read writ| recv send| in out | int csw
> 11 10 0 79 0 1| 22M 39M|2864B 2454B| 0 0 |2048 3793
> 12 9 1 76 0 1| 23M 39M| 81k 8686B| 0 0 |2166 3635
> 13 8 16 62 0 1| 27M 43M| 12k 5036B| 0 0 |2127 3526
> 14 8 37 40 0 1| 24M 42M|7138B 5140B| 0 0 |2047 3415
> 7 8 47 36 0 0| 35M 40M|2451B 2538B| 0 0 |2002 3179
> 4 9 49 37 0 0| 41M 40M|4081B 276B| 0 0 |1974 2956
> 1 9 50 38 0 1| 40M 40M| 0 276B| 0 0 |1912 2774
> 1 8 50 39 0 1| 40M 40M| 92B 0 | 0 0 |2018 2958
> 2 9 48 39 0 0| 44M 40M| 362B 276B| 0 0 |2097 3191
> 8 8 45 38 0 1| 27M 33M| 23k 4181B| 0 0 |1919 3009
> 8 8 50 34 0 0| 31M 26M| 10k 2570B| 0 0 |1760 2724
> 21 11 33 30 0 3| 40M 40M| 204k 17k| 0 0 |2360 3845
> 13 8 43 36 0 0| 35M 39M| 12k 5354B| 0 0 |2083 3349
> 16 8 41 35 0 0| 30M 35M|5738B 4158B| 0 0 |1904 3118
> 8 10 47 33 0 1| 40M 37M|1718B 1255B| 0 0 |1932 3130
> 3 9 49 39 0 1| 40M 40M| 0 0 | 0 0 |2124 3065
> 4 9 46 41 0 0| 40M 40M| 0 0 | 0 0 |1971 3088
> 6 9 46 40 0 0| 40M 41M| 850B 723B| 0 0 |2059 3155
> 3 10 46 39 0 1| 40M 42M|1958B 1651B| 0 0 |2054 3217
> 8 12 41 38 0 1| 41M 39M|2741B 1342B| 0 0 |2083 3647
> 4 8 47 40 0 0| 39M 39M|2062B 1299B| 0 0 |2060 3328
>
> Looks good.
>
> Then I tried copying 20Gb of data to the dm-crypted partition on the same
> USB disk. Here are the results:
>
> ----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
> usr sys idl wai hiq siq| read writ| recv send| in out | int csw
> 3 28 0 67 0 1| 20M 41M| 0 0 | 0 0 |1972 3036
> 25 29 0 44 0 2| 39M 42M| 0 78B| 52k 0 |1800 3612
> 41 22 0 35 0 1|8952k 40M| 54B 65B| 0 0 |1493 3471
> 21 24 0 54 0 1|2040k 42M|1469B 1591B| 0 0 |2180 5170
> 16 24 0 59 0 1| 14M 44M| 25k 4962B| 0 0 |1991 4541
> 12 11 17 58 0 2| 36M 19M| 28k 2964B| 44k 0 |2351 3774
> 19 28 14 37 0 1| 40M 19M| 72k 5062B| 0 0 |1707 3906
> 14 29 0 54 0 3| 58M 42M| 108k 7586B| 0 0 |2431 4646
> 8 23 0 67 0 2| 44M 35M| 77k 4188B| 0 0 |2948 4587
> 22 19 6 50 0 1| 30M 38M| 41k 2666B| 0 0 |2127 3924
> 6 33 29 31 0 1| 52M 38M|7628B 1511B| 0 0 |2055 3375
> 4 25 0 70 0 1|4624k 39M|4447B 1429B| 0 0 |1808 2749
> 10 32 3 52 1 2| 53M 42M| 27k 2296B| 0 0 |2144 4474
> 5 17 0 77 0 1| 88k 38M|5515B 420B| 0 0 |2261 3338
> 6 24 1 67 0 1| 66M 37M| 0 0 | 0 0 |2741 4099
> 2 27 17 53 0 1| 64M 32M| 0 0 | 32k 0 |2331 3356
> 2 35 17 43 0 2| 71M 39M| 0 0 | 0 0 |2460 3713
> 3 33 5 57 0 2| 69M 40M| 189B 202B| 0 0 |2212 3366
> 1 36 0 61 0 1| 72M 42M| 0 0 | 0 0 |2296 3481
> 1 35 0 62 0 2| 69M 40M| 0 65B| 0 0 |2235 3425
> 2 24 0 73 0 1| 37M 39M| 0 0 | 0 0 |2033 2912 ^C
>
> The above 2 results are from a 2.5" SATA disk attached to a USB 2.0
> enclosure which has one USB connector connected to the laptop's USB port.
> This is a self-powered disk enclosure. Filesystems is use were, vfat for
> the former result and ext3 for the latter.
>
> Below are results from a different disk.
>
> ----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
> usr sys idl wai hiq siq| read writ| recv send| in out | int csw
> 10 17 26 44 0 2| 32M 35M| 0 0 | 0 0 |3889 18k
> 12 20 34 35 0 0| 34M 36M| 0 0 | 0 0 |3923 19k
> 14 20 21 42 0 1| 36M 36M| 0 648B| 0 0 |4036 20k
> 14 22 21 41 0 0| 45M 37M| 0 324B| 0 0 |4140 24k
> 15 21 10 52 0 2| 35M 35M| 448B 520B| 0 0 |3947 19k
> 10 19 31 40 0 0| 30M 35M| 0 0 | 0 0 |3885 17k
> 18 22 14 46 0 0| 36M 37M| 92B 0 | 0 0 |4029 21k
> 16 21 18 43 0 1| 40M 36M| 92B 0 | 0 0 |3966 21k
> 11 23 28 37 0 0| 37M 36M| 92B 0 | 0 0 |3986 20k
> 11 17 31 41 0 0| 30M 35M| 0 0 | 0 0 |3893 19k
> 12 19 6 62 0 1| 29M 34M| 0 0 | 0 0 |3895 18k
> 12 19 0 67 0 2| 29M 35M| 0 0 | 0 0 |3974 17k
> 17 15 0 66 0 1| 15M 33M| 0 0 | 0 0 |3802 11k
> 32 17 5 46 0 0| 27M 36M| 108B 357B| 0 0 |3943 14k
> 17 14 2 65 0 1| 14M 33M| 0 0 | 0 0 |3884 11k
> 21 20 17 40 0 2| 28M 35M| 0 0 | 0 0 |3916 17k
> 17 24 8 50 0 0| 40M 37M| 55B 96B| 0 0 |3982 22k
> 19 27 13 41 0 0| 52M 37M| 0 0 | 0 0 |4265 29k
> 20 25 13 42 0 0| 40M 36M| 0 0 | 0 0 |3979 22k
> 21 28 8 41 1 2| 52M 36M| 420B 520B| 0 0 |4082 27k
> 20 32 16 31 0 0| 68M 38M| 0 0 | 0 0 |4343 33k^C
>
> This result is from a 2.5" SATA disk connected to a USB 2.0 enclosure with
> 2 USB connectors connected to the laptop. The filesystem is fuse (ntfs-3g).
> Looks good.
>
>
> Here's the interesting one.
>
> ----total-cpu-usage---- -dsk/total- -net/total- ---paging-- ---system--
> usr sys idl wai hiq siq| read writ| recv send| in out | int csw
> 11 3 82 2 0 1|1655k 267k| 0 0 |5486B 12k|1259 1863
> 16 23 25 35 0 0|1360k 0 |3022B 336B| 32k 0 | 972 3043
> 2 44 15 40 0 0| 64k 0 | 0 0 | 0 0 | 902 1141
> 4 3 93 0 0 0| 0 0 | 0 0 | 0 0 | 769 1235
> 5 2 92 0 0 0| 0 368k| 426B 520B| 0 0 | 557 1100
> 4 3 93 0 0 0| 0 0 | 92B 0 | 0 0 | 506 1041
> 4 3 94 0 0 0| 0 0 | 0 0 | 0 0 | 628 1005
> 4 2 93 0 0 0| 0 0 | 0 0 | 0 0 | 547 1036
> 6 2 92 0 0 0| 0 0 | 0 0 | 0 0 | 574 995
> 4 2 94 0 0 0| 0 0 | 0 0 | 0 0 | 593 1126
> 6 3 91 0 0 0| 0 0 | 141B 84B| 0 0 | 684 1165
> 4 3 93 0 0 0| 0 0 | 0 0 | 0 0 | 514 1044
> 4 2 93 0 0 0| 0 0 | 0 0 | 0 0 | 485 850
> 4 3 92 0 0 0| 0 0 | 227B 484B| 0 0 | 645 1116
> 3 2 94 0 0 0| 0 0 | 0 0 | 0 0 | 619 1009
> 4 3 92 1 0 0|8192B 1472k| 108B 292B| 0 0 | 608 1072
> 5 3 92 0 0 0| 0 0 | 187B 72B| 0 0 | 786 1208
> 4 2 94 0 0 0| 0 0 | 0 0 | 0 0 | 587 1098
> 3 3 94 0 0 0| 0 0 | 0 0 | 0 0 | 500 939 ^C
>
>
> This result is from a *3.5"* ATA disk connected to a USB 2.0 enclosure with
> 2 USB connectors connected to the laptop. The enclosure is externally
> powered. The disk is partition-less. The entire disk (/dev/sdb) is LUKS
> encrypted. The filesystem is ext3.
>
> As soon as I initiated the I/O, the performance went down (as mentioned in
> the above result). Also, the usb port was reset immediately which resulted
> in a read-only filesystem.
>
> Here are the relevant logs.
>
> [44125.008940] usb 5-8: new high speed USB device using ehci_hcd and
> address 10
> [44125.375160] usb 4-2: new full speed USB device using uhci_hcd and
> address 2 [44125.488926] usb 4-2: device descriptor read/64, error -71
> [44125.717839] usb 4-2: not running at top speed; connect to a high speed
> hub [44125.732838] usb 4-2: configuration #1 chosen from 1 choice
> [44125.735518] scsi5 : SCSI emulation for USB Mass Storage devices
> [44125.736912] usb 4-2: New USB device found, idVendor=05e3, idProduct=0702
> [44125.736928] usb 4-2: New USB device strings: Mfr=0, Product=1,
> SerialNumber=0
> [44125.736933] usb 4-2: Product: USB TO IDE
> [44125.737807] usb-storage: device found at 2
> [44125.737814] usb-storage: waiting for device to settle before scanning
> [44130.771126] usb-storage: device scan complete
> [44130.774592] scsi 5:0:0:0: Direct-Access ST325082 4A
> 0811 PQ: 0 ANSI: 0
> [44130.780522] sd 5:0:0:0: [sdb] 488397168 512-byte hardware sectors
> (250059 MB)
> [44130.787520] sd 5:0:0:0: [sdb] Test WP failed, assume Write Enabled
> [44130.787520] sd 5:0:0:0: [sdb] Assuming drive cache: write through
> [44130.792520] sd 5:0:0:0: [sdb] 488397168 512-byte hardware sectors
> (250059 MB)
> [44130.799520] sd 5:0:0:0: [sdb] Test WP failed, assume Write Enabled
> [44130.799520] sd 5:0:0:0: [sdb] Assuming drive cache: write through
> [44130.799520] sdb: unknown partition table
> [44130.830056] sd 5:0:0:0: [sdb] Attached SCSI disk
> [44130.830056] sd 5:0:0:0: Attached scsi generic sg2 type 0
> [44273.057272] kjournald starting. Commit interval 5 seconds
> [44273.064954] EXT3 FS on dm-2, internal journal
> [44273.065232] EXT3-fs: mounted filesystem with ordered data mode.
> [44306.991719] usb 4-2: reset full speed USB device using uhci_hcd and
> address 2
> [44307.232054] usb 4-2: reset full speed USB device using uhci_hcd and
> address 2
> [44307.468171] usb 4-2: reset full speed USB device using uhci_hcd and
> address 2
> [44307.600787] usb 4-2: failed to restore interface 0 altsetting 0
> (error=-71) [44307.601609] usb 4-2: USB disconnect, address 2
> [44307.601609] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.601609] end_request: I/O error, dev sdb, sector 248121664
> [44307.601609] Buffer I/O error on device dm-2, logical block 31015079
> [44307.601609] lost page write due to I/O error on dm-2
> [44307.601609] Buffer I/O error on device dm-2, logical block 31015080
> [44307.601609] lost page write due to I/O error on dm-2
> [44307.601609] Buffer I/O error on device dm-2, logical block 31015081
> [44307.601609] lost page write due to I/O error on dm-2
> [44307.601609] Buffer I/O error on device dm-2, logical block 31015082
> [44307.601609] lost page write due to I/O error on dm-2
> [44307.601635] Buffer I/O error on device dm-2, logical block 31015083
> [44307.601639] lost page write due to I/O error on dm-2
> [44307.601648] Buffer I/O error on device dm-2, logical block 31015084
> [44307.602572] lost page write due to I/O error on dm-2
> [44307.602572] Buffer I/O error on device dm-2, logical block 31015085
> [44307.602572] lost page write due to I/O error on dm-2
> [44307.602572] Buffer I/O error on device dm-2, logical block 31015086
> [44307.602572] lost page write due to I/O error on dm-2
> [44307.602572] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.602572] end_request: I/O error, dev sdb, sector 248121728
> [44307.602572] Buffer I/O error on device dm-2, logical block 31015087
> [44307.602572] lost page write due to I/O error on dm-2
> [44307.602572] Buffer I/O error on device dm-2, logical block 31015088
> [44307.602572] lost page write due to I/O error on dm-2
> [44307.602572] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.602572] end_request: I/O error, dev sdb, sector 248121792
> [44307.602572] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.602572] end_request: I/O error, dev sdb, sector 248121856
> [44307.602572] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.602572] end_request: I/O error, dev sdb, sector 248121920
> [44307.602573] sd 5:0:0:0: [sdb] Result: hostbyte=DID_ERROR
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.602573] end_request: I/O error, dev sdb, sector 248121984
> [44307.603601] sd 5:0:0:0: [sdb] Result: hostbyte=DID_NO_CONNECT
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.603609] end_request: I/O error, dev sdb, sector 248122048
> [44307.604568] sd 5:0:0:0: [sdb] Result: hostbyte=DID_NO_CONNECT
> driverbyte=DRIVER_OK,SUGGEST_OK
> [44307.604568] end_request: I/O error, dev sdb, sector 248122112
> [44307.625509] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44307.763898] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44307.763898] ------------[ cut here ]------------
> [44307.763898] WARNING: at fs/buffer.c:1186 mark_buffer_dirty+0x20/0x67()
> [44307.763898] Modules linked in: sha256_generic aes_i586 aes_generic cbc
> nls_utf8 nls_cp437 vfat fat nls_base usb_storage usbhid hid ff_memless
> tcp_diag inet_diag tun nvidia(P) rfcomm l2cap bluetooth xt_limit
> nf_conntrack_ipv6 ipv6 nf_conntrack_proto_dccp ts_kmp nf_conntrack_amanda
> nf_conntrack_irc nf_conntrack_sip nf_conntrack_netbios_ns nf_conntrack_pptp
> nf_conntrack_proto_gre nf_conntrack_netlink nfnetlink nf_conntrack_ftp
> nf_conntrack_tftp nf_conntrack_sane xt_conntrack nf_conntrack_proto_sctp
> nf_conntrack_proto_udplite nf_conntrack_h323 acpi_cpufreq
> cpufreq_conservative cpufreq_stats cpufreq_userspace cpufreq_powersave
> ipt_MASQUERADE iptable_nat nf_nat nf_conntrack_ipv4 xt_state nf_conntrack
> ipt_REJECT xt_tcpudp iptable_filter ip_tables x_tables bridge kvm_intel kvm
> fuse configfs loop firewire_sbp2 dm_crypt snd_hda_intel snd_usb_audio
> snd_pcm_oss snd_mixer_oss snd_pcm snd_usb_lib snd_hwdep arc4 snd_seq_dummy
> ecb crypto_blkcipher snd_seq_oss snd_seq_midi snd_rawmidi uvcvideo iwl3945
> snd_seq_midi_event compat_ioctl32 snd_seq joydev mac80211 videodev i2c_i801
> snd_timer snd_seq_device iTCO_wdt led_class serio_raw snd v4l1_compat
> intel_agp wmi rng_core i2c_core ac cfg80211 psmouse pcspkr agpgart button
> battery video output soundcore snd_page_alloc evdev dcdbas ext3 jbd mbcache
> dm_mirror dm_log dm_snapshot dm_mod sg sr_mod cdrom sd_mod ata_generic
> ata_piix firewire_ohci firewire_core libata scsi_mod crc_itu_t dock b44
> ide_pci_generic ide_core ohci1394 sdhci ieee1394 mmc_core ricoh_mmc ssb
> pcmcia pcmcia_core
> firmware_class mii ehci_hcd uhci_hcd usbcore thermal processor fan
> thermal_sys [44307.763898] Pid: 8632, comm: cp Tainted: P
> 2.6.26-custom #1 [44307.763921] [<c01219c0>] warn_on_slowpath+0x40/0x79
> [44307.763921] [<c0119aee>] check_preempt_wakeup+0x97/0xd1
> [44307.763921] [<c011a404>] try_to_wake_up+0xe8/0xf1
> [44307.763922] [<c023397e>] vt_console_print+0x32/0x278
> [44307.763922] [<c023397e>] vt_console_print+0x32/0x278
> [44307.763922] [<c023394c>] vt_console_print+0x0/0x278
> [44307.763937] [<c0121c56>] __call_console_drivers+0x4f/0x5b
> [44307.763950] [<c013484a>] up+0x9/0x2a
> [44307.763969] [<c0122066>] release_console_sem+0x172/0x18b
> [44307.764087] [<c0194ed5>] mark_buffer_dirty+0x20/0x67
> [44307.764102] [<f8b9dccb>] ext3_commit_super+0x3a/0x4e [ext3]
> [44307.764147] [<f8b9f0e2>] ext3_handle_error+0x6e/0x8e [ext3]
> [44307.764178] [<f8b9f18d>] ext3_error+0x3a/0x40 [ext3]
> [44307.764237] [<f8b94707>] read_block_bitmap+0x90/0x115 [ext3]
> [44307.764307] [<f8b95272>] ext3_new_blocks+0x199/0x569 [ext3]
> [44307.764395] [<f8b98c45>] ext3_get_blocks_handle+0x332/0x785 [ext3]
> [44307.764395] [<c0194ac9>] __find_get_block+0x162/0x16c
> [44307.764395] [<c015bad2>] __rmqueue+0x16/0x1b5
> [44307.764395] [<f8b99137>] ext3_get_block+0x9f/0xd3 [ext3]
> [44307.764469] [<c0195ef8>] __block_prepare_write+0x16e/0x373
> [44307.764469] [<c0196245>] block_write_begin+0x6c/0xc3
> [44307.764469] [<f8b99098>] ext3_get_block+0x0/0xd3 [ext3]
> [44307.764469] [<f8b98814>] ext3_write_begin+0xc1/0x168 [ext3]
> [44307.764487] [<f8b99098>] ext3_get_block+0x0/0xd3 [ext3]
> [44307.764896] [<c015912d>] generic_file_buffered_write+0xfa/0x56a
> [44307.764997] [<f8b11925>] journal_stop+0x145/0x14e [jbd]
> [44307.765065] [<c0159b98>] __generic_file_aio_write_nolock+0x3fa/0x445
> [44307.765141] [<c018acfa>] mnt_want_write+0x1a/0x5e
> [44307.765157] [<c018b649>] mnt_drop_write+0x1a/0xb2
> [44307.765172] [<c015a194>] generic_file_aio_read+0x474/0x4fa
> [44307.765203] [<c0159c43>] generic_file_aio_write+0x60/0xb7
> [44307.765253] [<f8b95f6c>] ext3_file_write+0x19/0x85 [ext3]
> [44307.765289] [<c017815d>] do_sync_write+0xc0/0x107
> [44307.765369] [<c013140a>] autoremove_wake_function+0x0/0x2d
> [44307.765394] [<c011e114>] hrtick_set+0x7b/0xe6
> [44307.765455] [<c017809d>] do_sync_write+0x0/0x107
> [44307.765469] [<c01789d9>] vfs_write+0x84/0x121
> [44307.765495] [<c0178b0e>] sys_write+0x3c/0x63
> [44307.765525] [<c010398a>] syscall_call+0x7/0xb
> [44307.765894] =======================
> [44307.765894] ---[ end trace 2a0ce193654d04fb ]---
> [44307.884076] usb 4-2: new full speed USB device using uhci_hcd and
> address 3 [44308.017388] usb 4-2: device descriptor read/all, error -71
> [44308.026550] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.047000] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.056026] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.075044] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.090090] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.102860] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.117901] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.122647] usb 4-2: new full speed USB device using uhci_hcd and
> address 4 [44308.127745] EXT3-fs error (device dm-2): read_block_bitmap:
> Cannot read block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.136581] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.150331] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.159068] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.168617] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.185580] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.200611] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.204343] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.217310] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.228915] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.254557] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.270601] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.300419] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.301453] usb 4-2: string descriptor 0 read error: -71
> [44308.301572] usb 4-2: configuration #1 chosen from 1 choice
> [44308.308850] usb 4-2: can't set config #1, error -71
> [44308.308899] usb 4-2: New USB device found, idVendor=05e3, idProduct=0702
> [44308.308899] usb 4-2: New USB device strings: Mfr=0, Product=1,
> SerialNumber=0
> [44308.328418] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.336523] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.367727] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.384314] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.399502] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.423943] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.439201] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.450486] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.460527] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.464059] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.477362] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.498686] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.516538] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.520738] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.540687] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.557256] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.579235] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.590239] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.605335] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.628031] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44308.990689] EXT3-fs error (device dm-2): read_block_bitmap: Cannot read
> block bitmap - block_group = 966, block_bitmap = 31653888
> [44309.667656] Aborting journal on device dm-2.
> [44309.668659] __journal_remove_journal_head: freeing b_committed_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.668659] __journal_remove_journal_head: freeing b_frozen_data
> [44309.679137] ext3_abort called.
> [44309.679137] EXT3-fs error (device dm-2): ext3_journal_start_sb: Detected
> aborted journal
> [44309.679137] Remounting filesystem read-only
> [44338.161517] __ratelimit: 26116 messages suppressed
> [44338.161517] Buffer I/O error on device dm-2, logical block 8
> [44338.161517] lost page write due to I/O error on dm-2
> [44338.161517] Buffer I/O error on device dm-2, logical block 1027
> [44338.161517] lost page write due to I/O error on dm-2
> [44338.161517] Buffer I/O error on device dm-2, logical block 1539
> [44338.161517] lost page write due to I/O error on dm-2
> [44338.161531] Buffer I/O error on device dm-2, logical block 30998528
> [44338.161538] lost page write due to I/O error on dm-2
> [44338.162759] Buffer I/O error on device dm-2, logical block 30998529
> [44338.162767] lost page write due to I/O error on dm-2
> [44338.162776] Buffer I/O error on device dm-2, logical block 30998530
> [44338.162781] lost page write due to I/O error on dm-2
>
>
> This makes me feel that it might be a hardware issue.
>
> Ritesh
--
Ritesh Raj Sarraf
RESEARCHUT - http://www.researchut.com
"Necessity is the mother of invention."
-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 197 bytes
Desc: This is a digitally signed message part.
URL: <http://listman.redhat.com/archives/dm-devel/attachments/20090114/a0e26e28/attachment.sig>
More information about the dm-devel
mailing list