LKML Archive on lore.kernel.org
help / color / mirror / Atom feed
* usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
@ 2008-03-30 7:49 Sergey Dolgov
2008-03-30 18:59 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Sergey Dolgov @ 2008-03-30 7:49 UTC (permalink / raw)
To: linux-kernel, linux-usb
Hi!
If I boot Asus Eee PC with 8 Gb Transcend SDHC card inserted into the
internal card reader, 2.6.25-rc7 prints the following:
[ 9.914968] scsi 2:0:0:0: Direct-Access USB2.0 CardReader SD0 0100 PQ: 0 ANSI: 0
[ 10.248951] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 10.249695] sd 2:0:0:0: [sdb] Write Protect is off
[ 10.249928] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 10.249935] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 10.256632] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 10.257440] sd 2:0:0:0: [sdb] Write Protect is off
[ 10.257546] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 10.257552] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 10.257657] sdb: sdb1 sdb2 sdb3
[ 10.259560] sd 2:0:0:0: [sdb] Attached SCSI removable disk
[ 10.260489] usb-storage: device scan complete
[ 10.380590] sd 2:0:0:0: [sdb] Result: hostbyte=0x00 driverbyte=0x08
[ 10.380590] sd 2:0:0:0: [sdb] Sense Key : 0x4 [current]
[ 10.380590] sd 2:0:0:0: [sdb] ASC=0x11 ASCQ=0x0
[ 10.380590] end_request: I/O error, dev sdb, sector 15660024
As a result, no sdb device is created by udev.
If the card is inserted after the boot, it sometimes works fine (I've
tested with "dd if=/dev/sdb of=/dev/null bs=512 skip=15660000"), and
sometimes fails in the same way (the same I/O error message, dd
hangs).
2.6.24.4 is fine (no problems at boot, always can dd read the whole
card, all 15660032 sectors of it).
The other SD card I've got, 2 Gb, also works ok even with 2.6.25-rc7.
--
Sergey
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-03-30 7:49 usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7 Sergey Dolgov
@ 2008-03-30 18:59 ` Alan Stern
2008-03-30 22:32 ` Sergey Dolgov
0 siblings, 1 reply; 18+ messages in thread
From: Alan Stern @ 2008-03-30 18:59 UTC (permalink / raw)
To: Sergey Dolgov; +Cc: linux-kernel, linux-usb
On Sun, 30 Mar 2008, Sergey Dolgov wrote:
> Hi!
>
> If I boot Asus Eee PC with 8 Gb Transcend SDHC card inserted into the
> internal card reader, 2.6.25-rc7 prints the following:
>
> [ 9.914968] scsi 2:0:0:0: Direct-Access USB2.0 CardReader SD0 0100 PQ: 0 ANSI: 0
> [ 10.248951] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
> [ 10.249695] sd 2:0:0:0: [sdb] Write Protect is off
> [ 10.249928] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
> [ 10.249935] sd 2:0:0:0: [sdb] Assuming drive cache: write through
> [ 10.256632] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
> [ 10.257440] sd 2:0:0:0: [sdb] Write Protect is off
> [ 10.257546] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
> [ 10.257552] sd 2:0:0:0: [sdb] Assuming drive cache: write through
> [ 10.257657] sdb: sdb1 sdb2 sdb3
> [ 10.259560] sd 2:0:0:0: [sdb] Attached SCSI removable disk
> [ 10.260489] usb-storage: device scan complete
> [ 10.380590] sd 2:0:0:0: [sdb] Result: hostbyte=0x00 driverbyte=0x08
> [ 10.380590] sd 2:0:0:0: [sdb] Sense Key : 0x4 [current]
> [ 10.380590] sd 2:0:0:0: [sdb] ASC=0x11 ASCQ=0x0
> [ 10.380590] end_request: I/O error, dev sdb, sector 15660024
>
> As a result, no sdb device is created by udev.
>
> If the card is inserted after the boot, it sometimes works fine (I've
> tested with "dd if=/dev/sdb of=/dev/null bs=512 skip=15660000"), and
> sometimes fails in the same way (the same I/O error message, dd
> hangs).
>
> 2.6.24.4 is fine (no problems at boot, always can dd read the whole
> card, all 15660032 sectors of it).
>
> The other SD card I've got, 2 Gb, also works ok even with 2.6.25-rc7.
Can you build both 2.6.24.4 and 2.6.25-rc7 with
CONFIG_USB_STORAGE_DEBUG enabled, and post the dmesg logs from both
kernels showing what happens when the SDHC card is probed during boot?
Comparing the two logs should indicate where the crucial difference
lies.
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-03-30 18:59 ` Alan Stern
@ 2008-03-30 22:32 ` Sergey Dolgov
2008-04-01 1:18 ` Sergey Dolgov
0 siblings, 1 reply; 18+ messages in thread
From: Sergey Dolgov @ 2008-03-30 22:32 UTC (permalink / raw)
To: Alan Stern; +Cc: linux-kernel, linux-usb
[-- Attachment #1: Type: text/plain, Size: 2273 bytes --]
On Sun, Mar 30, 2008 at 02:59:49PM -0400, Alan Stern wrote:
> On Sun, 30 Mar 2008, Sergey Dolgov wrote:
>
> > Hi!
> >
> > If I boot Asus Eee PC with 8 Gb Transcend SDHC card inserted into the
> > internal card reader, 2.6.25-rc7 prints the following:
> >
> > [ 9.914968] scsi 2:0:0:0: Direct-Access USB2.0 CardReader SD0 0100 PQ: 0 ANSI: 0
> > [ 10.248951] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
> > [ 10.249695] sd 2:0:0:0: [sdb] Write Protect is off
> > [ 10.249928] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
> > [ 10.249935] sd 2:0:0:0: [sdb] Assuming drive cache: write through
> > [ 10.256632] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
> > [ 10.257440] sd 2:0:0:0: [sdb] Write Protect is off
> > [ 10.257546] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
> > [ 10.257552] sd 2:0:0:0: [sdb] Assuming drive cache: write through
> > [ 10.257657] sdb: sdb1 sdb2 sdb3
> > [ 10.259560] sd 2:0:0:0: [sdb] Attached SCSI removable disk
> > [ 10.260489] usb-storage: device scan complete
> > [ 10.380590] sd 2:0:0:0: [sdb] Result: hostbyte=0x00 driverbyte=0x08
> > [ 10.380590] sd 2:0:0:0: [sdb] Sense Key : 0x4 [current]
> > [ 10.380590] sd 2:0:0:0: [sdb] ASC=0x11 ASCQ=0x0
> > [ 10.380590] end_request: I/O error, dev sdb, sector 15660024
> >
> > As a result, no sdb device is created by udev.
> >
> > If the card is inserted after the boot, it sometimes works fine (I've
> > tested with "dd if=/dev/sdb of=/dev/null bs=512 skip=15660000"), and
> > sometimes fails in the same way (the same I/O error message, dd
> > hangs).
> >
> > 2.6.24.4 is fine (no problems at boot, always can dd read the whole
> > card, all 15660032 sectors of it).
> >
> > The other SD card I've got, 2 Gb, also works ok even with 2.6.25-rc7.
>
> Can you build both 2.6.24.4 and 2.6.25-rc7 with
> CONFIG_USB_STORAGE_DEBUG enabled, and post the dmesg logs from both
> kernels showing what happens when the SDHC card is probed during boot?
> Comparing the two logs should indicate where the crucial difference
> lies.
The dmesg output for 2.6.25-rc7 with USB storage debugging enabled is
attached. I hope to produce the same for 2.6.24.4 on Monday.
--
Sergey
[-- Attachment #2: dmesg.25.8G-dbg --]
[-- Type: text/plain, Size: 71042 bytes --]
[ 0.000000] Linux version 2.6.25-rc7-storage-dbg (root@slke) (gcc version 4.2.3 (Debian 4.2.3-3)) #2 Mon Mar 31 02:15:20 MSD 2008
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
[ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000001f780000 (usable)
[ 0.000000] BIOS-e820: 000000001f780000 - 000000001f790000 (ACPI data)
[ 0.000000] BIOS-e820: 000000001f790000 - 000000001f7d0000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000001f7d0000 - 000000001f7de000 (reserved)
[ 0.000000] BIOS-e820: 000000001f7e0000 - 000000001f800000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] BIOS-e820: 00000000fff80000 - 0000000100000000 (reserved)
[ 0.000000] 503MB LOWMEM available.
[ 0.000000] Scan SMP from c0000000 for 1024 bytes.
[ 0.000000] Scan SMP from c009fc00 for 1024 bytes.
[ 0.000000] Scan SMP from c00f0000 for 65536 bytes.
[ 0.000000] found SMP MP-table at [c00ff780] 000ff780
[ 0.000000] Entering add_active_range(0, 0, 128896) 0 entries of 256 used
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0 -> 4096
[ 0.000000] Normal 4096 -> 128896
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[1] active PFN ranges
[ 0.000000] 0: 0 -> 128896
[ 0.000000] On node 0 totalpages: 128896
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 4064 pages, LIFO batch:0
[ 0.000000] Normal zone: 975 pages used for memmap
[ 0.000000] Normal zone: 123825 pages, LIFO batch:31
[ 0.000000] Movable zone: 0 pages used for memmap
[ 0.000000] DMI present.
[ 0.000000] ACPI: RSDP 000FBE60, 0014 (r0 ACPIAM)
[ 0.000000] ACPI: RSDT 1F780000, 0034 (r1 A M I OEMRSDT 1000808 MSFT 97)
[ 0.000000] ACPI: FACP 1F780200, 0081 (r1 A M I OEMFACP 1000808 MSFT 97)
[ 0.000000] ACPI: DSDT 1F780400, 5F2B (r1 A0797 A0797000 0 INTL 20051117)
[ 0.000000] ACPI: FACS 1F790000, 0040
[ 0.000000] ACPI: APIC 1F780390, 0068 (r1 A M I OEMAPIC 1000808 MSFT 97)
[ 0.000000] ACPI: OEMB 1F790040, 0046 (r1 A M I AMI_OEM 1000808 MSFT 97)
[ 0.000000] ACPI: MCFG 1F786330, 003C (r1 A M I OEMMCFG 1000808 MSFT 97)
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] Processor #0 6:13 APIC version 20
[ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] Allocating PCI resources starting at 20000000 (gap: 1f800000:df600000)
[ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e4000
[ 0.000000] PM: Registered nosave memory: 00000000000e4000 - 0000000000100000
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 127889
[ 0.000000] Kernel command line: root=LABEL=root ro
[ 0.000000] mapped APIC to ffffb000 (fee00000)
[ 0.000000] mapped IOAPIC to ffffa000 (fec00000)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] PID hash table entries: 2048 (order: 11, 8192 bytes)
[ 0.000000] Detected 630.086 MHz processor.
[ 0.010000] Console: colour VGA+ 80x25
[ 0.010000] console [tty0] enabled
[ 0.010000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.010000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.010000] Memory: 504820k/515584k available (1999k kernel code, 10172k reserved, 954k data, 256k init, 0k highmem)
[ 0.010000] virtual kernel memory layout:
[ 0.010000] fixmap : 0xfffb5000 - 0xfffff000 ( 296 kB)
[ 0.010000] vmalloc : 0xe0000000 - 0xfffb3000 ( 511 MB)
[ 0.010000] lowmem : 0xc0000000 - 0xdf780000 ( 503 MB)
[ 0.010000] .init : 0xc03e6000 - 0xc0426000 ( 256 kB)
[ 0.010000] .data : 0xc02f3c2a - 0xc03e2808 ( 954 kB)
[ 0.010000] .text : 0xc0100000 - 0xc02f3c2a (1999 kB)
[ 0.010000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.010000] CPA: page pool initialized 1 of 1 pages preallocated
[ 0.010000] SLUB: Genslabs=12, HWalign=64, Order=0-1, MinObjects=4, CPUs=1, Nodes=1
[ 0.160004] Calibrating delay using timer specific routine.. 1261.29 BogoMIPS (lpj=6306478)
[ 0.160230] Mount-cache hash table entries: 512
[ 0.160625] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.160768] CPU: L2 cache: 512K
[ 0.160859] Intel machine check architecture supported.
[ 0.160961] Intel machine check reporting enabled on CPU#0.
[ 0.161063] Compat vDSO mapped to ffffe000.
[ 0.161161] CPU: Intel(R) Celeron(R) M processor 900MHz stepping 08
[ 0.161357] Checking 'hlt' instruction... OK.
[ 0.205596] Freeing SMP alternatives: 0k freed
[ 0.205694] ACPI: Core revision 20070126
[ 0.228125] Parsing all Control Methods:
[ 0.228530] Table [DSDT](id 0001) - 841 Objects with 56 Devices 257 Methods 20 Regions
[ 0.228742] tbxface-0598 [00] tb_load_namespace : ACPI Tables successfully acquired
[ 0.230008] evxfevnt-0091 [00] enable : Transition to ACPI mode successful
[ 0.230525] ENABLING IO-APIC IRQs
[ 0.230842] ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.350000] net_namespace: 152 bytes
[ 0.350000] Booting paravirtualized kernel on bare hardware
[ 0.350000] NET: Registered protocol family 16
[ 0.350000] No dock devices found.
[ 0.350000] ACPI: bus type pci registered
[ 0.350000] PCI: Using configuration type 1
[ 0.350000] Setting up standard PCI resources
[ 0.363333] evgpeblk-0956 [00] ev_create_gpe_block : GPE 00 to 1F [_GPE] 4 regs on int 0x9
[ 0.368950] evgpeblk-1052 [00] ev_initialize_gpe_bloc: Found 9 Wake, Enabled 0 Runtime GPEs in this block
[ 0.369190] ACPI: EC: Look up EC in DSDT
[ 0.371443] Completing Region/Field/Buffer/Package initialization:..............................................................................................
[ 0.384077] Initialized 19/20 Regions 18/18 Fields 33/34 Buffers 24/26 Packages (850 nodes)
[ 0.384289] Initializing Device/Processor/Thermal objects by executing _INI methods:..
[ 0.390372] Executed 2 _INI methods requiring 0 _STA executions (examined 60 objects)
[ 0.390597] ACPI: Interpreter enabled
[ 0.390689] ACPI: (supports S0 S1 S3 S4 S5)
[ 0.391041] ACPI: Using IOAPIC for interrupt routing
[ 0.417959] ACPI: EC: GPE = 0x18, I/O: command/status = 0x66, data = 0x62
[ 0.418073] ACPI: EC: driver started in poll mode
[ 0.418495] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.419587] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[ 0.419605] pci 0000:00:1f.0: quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO
[ 0.419745] pci 0000:00:1f.0: quirk: region 0480-04bf claimed by ICH6 GPIO
[ 0.420460] PCI: Transparent bridge - 0000:00:1e.0
[ 0.420611] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.421176] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P3._PRT]
[ 0.421456] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P5._PRT]
[ 0.421725] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P6._PRT]
[ 0.435912] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 6 7 10 11 12 14 15)
[ 0.436949] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 *11 12 14 15)
[ 0.437966] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 *10 11 12 14 15)
[ 0.438979] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 *7 10 11 12 14 15)
[ 0.440066] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.441215] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.442352] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.443487] ACPI: PCI Interrupt Link [LNKH] (IRQs *3 4 5 6 7 10 11 12 14 15)
[ 0.444577] Linux Plug and Play Support v0.97 (c) Adam Belay
[ 0.444760] pnp: PnP ACPI init
[ 0.444865] ACPI: bus type pnp registered
[ 0.451660] pnp: PnP ACPI: found 13 devices
[ 0.451762] ACPI: ACPI bus type pnp unregistered
[ 0.452373] SCSI subsystem initialized
[ 0.452544] libata version 3.00 loaded.
[ 0.453052] PCI: Using ACPI for IRQ routing
[ 0.453151] PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report
[ 0.454008] hpet clockevent registered
[ 0.454124] system 00:01: iomem range 0xfed13000-0xfed19fff has been reserved
[ 0.454274] system 00:08: ioport range 0x380-0x383 has been reserved
[ 0.454379] system 00:08: ioport range 0x4d0-0x4d1 has been reserved
[ 0.454482] system 00:08: ioport range 0x800-0x87f has been reserved
[ 0.454585] system 00:08: ioport range 0x480-0x4bf has been reserved
[ 0.454689] system 00:08: iomem range 0xfed1c000-0xfed1ffff has been reserved
[ 0.454795] system 00:08: iomem range 0xfed20000-0xfed8ffff has been reserved
[ 0.454901] system 00:08: iomem range 0xfff00000-0xffffffff could not be reserved
[ 0.455046] system 00:09: iomem range 0xfec00000-0xfec00fff has been reserved
[ 0.455152] system 00:09: iomem range 0xfee00000-0xfee00fff could not be reserved
[ 0.455295] system 00:0a: iomem range 0xe0000000-0xefffffff has been reserved
[ 0.455412] system 00:0b: iomem range 0xe0000000-0xefffffff has been reserved
[ 0.455528] system 00:0c: iomem range 0x0-0x9ffff could not be reserved
[ 0.455632] system 00:0c: iomem range 0xc0000-0xcffff could not be reserved
[ 0.455738] system 00:0c: iomem range 0xe0000-0xfffff could not be reserved
[ 0.455843] system 00:0c: iomem range 0x100000-0x1f7fffff could not be reserved
[ 0.455978] system 00:0c: iomem range 0x0-0x0 could not be reserved
[ 0.487095] PCI: Bridge: 0000:00:1c.0
[ 0.487191] IO window: disabled.
[ 0.487283] MEM window: disabled.
[ 0.487374] PREFETCH window: disabled.
[ 0.487470] PCI: Bridge: 0000:00:1c.1
[ 0.487559] IO window: disabled.
[ 0.487651] MEM window: 0xfbf00000-0xfbffffff
[ 0.487746] PREFETCH window: disabled.
[ 0.487844] PCI: Bridge: 0000:00:1c.2
[ 0.487932] IO window: disabled.
[ 0.488027] MEM window: 0xf8000000-0xfbefffff
[ 0.488123] PREFETCH window: 0x00000000f0000000-0x00000000f6ffffff
[ 0.488229] PCI: Bridge: 0000:00:1e.0
[ 0.488317] IO window: disabled.
[ 0.488408] MEM window: disabled.
[ 0.488499] PREFETCH window: disabled.
[ 0.488648] ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 0.488834] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 0.488864] ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 17 (level, low) -> IRQ 17
[ 0.490006] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 0.490037] ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 0.490218] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 0.490236] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[ 0.490264] NET: Registered protocol family 2
[ 0.490568] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.491102] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.491497] TCP bind hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.491738] TCP: Hash tables configured (established 16384 bind 16384)
[ 0.491841] TCP reno registered
[ 0.492298] checking if image is initramfs... it is
[ 0.960024] Switched to high resolution mode on CPU 0
[ 0.990710] Freeing initrd memory: 2015k freed
[ 0.999395] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[ 0.999552] io scheduler noop registered
[ 0.999644] io scheduler deadline registered (default)
[ 0.999756] pci 0000:00:02.0: Boot video device
[ 1.000122] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 1.000172] assign_interrupt_mode Found MSI capability
[ 1.000275] Allocate Port Service[0000:00:1c.0:pcie00]
[ 1.000395] Allocate Port Service[0000:00:1c.0:pcie02]
[ 1.000562] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 1.000608] assign_interrupt_mode Found MSI capability
[ 1.000707] Allocate Port Service[0000:00:1c.1:pcie00]
[ 1.000813] Allocate Port Service[0000:00:1c.1:pcie02]
[ 1.000972] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 1.001018] assign_interrupt_mode Found MSI capability
[ 1.001117] Allocate Port Service[0000:00:1c.2:pcie00]
[ 1.001239] Allocate Port Service[0000:00:1c.2:pcie02]
[ 1.074455] Linux agpgart interface v0.103
[ 1.074601] agpgart: Detected an Intel 915GM Chipset.
[ 1.075138] agpgart: Detected 7932K stolen memory.
[ 1.105045] agpgart: AGP aperture is 256M @ 0xd0000000
[ 1.105360] [drm] Initialized drm 1.1.0 20060810
[ 1.105501] ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 1.105686] PCI: Setting latency timer of device 0000:00:02.0 to 64
[ 1.105905] [drm] Initialized i915 1.6.0 20060119 on minor 0
[ 1.107580] brd: module loaded
[ 1.108480] loop: module loaded
[ 1.108588] tun: Universal TUN/TAP device driver, 1.6
[ 1.108684] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[ 1.108954] Driver 'sd' needs updating - please use bus_type methods
[ 1.109171] ata_piix 0000:00:1f.2: version 2.12
[ 1.109232] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 19 (level, low) -> IRQ 19
[ 1.109416] ata_piix 0000:00:1f.2: MAP [ P0 P2 IDE IDE ]
[ 1.109746] PCI: Setting latency timer of device 0000:00:1f.2 to 64
[ 1.109922] scsi0 : ata_piix
[ 1.110230] scsi1 : ata_piix
[ 1.114779] ata1: SATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 1.114887] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 1.463155] ata2.00: ATA-4: SILICONMOTION SM223AC, , max UDMA/66
[ 1.463155] ata2.00: 7815024 sectors, multi 0: LBA
[ 1.463155] ata2.00: limited to UDMA/33 due to 40-wire cable
[ 1.502062] ata2.00: configured for UDMA/33
[ 1.502062] scsi 1:0:0:0: Direct-Access ATA SILICONMOTION SM n/a PQ: 0 ANSI: 5
[ 1.502062] sd 1:0:0:0: [sda] 7815024 512-byte hardware sectors (4001 MB)
[ 1.502062] sd 1:0:0:0: [sda] Write Protect is off
[ 1.502062] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.502062] sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 1.502062] sd 1:0:0:0: [sda] 7815024 512-byte hardware sectors (4001 MB)
[ 1.502062] sd 1:0:0:0: [sda] Write Protect is off
[ 1.502062] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 1.502062] sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 1.502062] sda: sda1 sda2
[ 1.502304] sd 1:0:0:0: [sda] Attached SCSI disk
[ 1.502304] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 1.527550] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 1.527653] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 1.528112] mice: PS/2 mouse device common for all mice
[ 1.556643] input: AT Translated Set 2 keyboard as /class/input/input0
[ 1.563532] cpuidle: using governor ladder
[ 1.563532] cpuidle: using governor menu
[ 1.563532] TCP cubic registered
[ 1.563532] NET: Registered protocol family 1
[ 1.563532] NET: Registered protocol family 17
[ 1.563532] Using IPI Shortcut mode
[ 1.563532] registered taskstats version 1
[ 1.563532] Freeing unused kernel memory: 256k freed
[ 1.721802] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
[ 1.722199] ACPI: ACPI0007:00 is registered as cooling_device0
[ 1.722316] ACPI: Processor [CPU1] (supports 8 throttling states)
[ 1.730278] ACPI: EC: non-query interrupt received, switching to interrupt mode
[ 1.730506] Marking TSC unstable due to: TSC halts in idle.
[ 1.738682] ACPI: LNXTHERM:01 is registered as thermal_zone0
[ 1.749426] ACPI: Thermal Zone [TZ00] (56 C)
[ 2.513871] Synaptics Touchpad, model: 1, fw: 6.5, id: 0x1c0b1, caps: 0xa04751/0xa00000
[ 2.603185] input: SynPS/2 Synaptics TouchPad as /class/input/input1
[ 3.511679] usbcore: registered new interface driver usbfs
[ 3.511854] usbcore: registered new interface driver hub
[ 3.519687] usbcore: registered new device driver usb
[ 3.522795] USB Universal Host Controller Interface driver v3.0
[ 3.523009] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 23
[ 3.523203] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[ 3.523213] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 3.524033] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[ 3.524225] uhci_hcd 0000:00:1d.0: irq 23, io base 0x0000e400
[ 3.524649] usb usb1: configuration #1 chosen from 1 choice
[ 3.524804] hub 1-0:1.0: USB hub found
[ 3.524906] hub 1-0:1.0: 2 ports detected
[ 3.629716] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
[ 3.629832] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 3.629965] usb usb1: Product: UHCI Host Controller
[ 3.630060] usb usb1: Manufacturer: Linux 2.6.25-rc7-storage-dbg uhci_hcd
[ 3.630163] usb usb1: SerialNumber: 0000:00:1d.0
[ 3.630321] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
[ 3.630518] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[ 3.630527] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 3.630677] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[ 3.630862] uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000e480
[ 3.631232] usb usb2: configuration #1 chosen from 1 choice
[ 3.631393] hub 2-0:1.0: USB hub found
[ 3.631495] hub 2-0:1.0: 2 ports detected
[ 3.739600] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 3.739717] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 3.739852] usb usb2: Product: UHCI Host Controller
[ 3.739946] usb usb2: Manufacturer: Linux 2.6.25-rc7-storage-dbg uhci_hcd
[ 3.740049] usb usb2: SerialNumber: 0000:00:1d.1
[ 3.740203] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 3.740396] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[ 3.740405] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 3.740570] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3
[ 3.740754] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000e800
[ 3.741125] usb usb3: configuration #1 chosen from 1 choice
[ 3.741288] hub 3-0:1.0: USB hub found
[ 3.741389] hub 3-0:1.0: 2 ports detected
[ 3.849295] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[ 3.849406] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 3.849548] usb usb3: Product: UHCI Host Controller
[ 3.849643] usb usb3: Manufacturer: Linux 2.6.25-rc7-storage-dbg uhci_hcd
[ 3.849745] usb usb3: SerialNumber: 0000:00:1d.2
[ 3.849886] ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 16 (level, low) -> IRQ 16
[ 3.850084] PCI: Setting latency timer of device 0000:00:1d.3 to 64
[ 3.850095] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 3.850246] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 4
[ 3.850428] uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000e880
[ 3.850791] usb usb4: configuration #1 chosen from 1 choice
[ 3.850955] hub 4-0:1.0: USB hub found
[ 3.851056] hub 4-0:1.0: 2 ports detected
[ 3.938943] Clocksource tsc unstable (delta = -216649331 ns)
[ 3.959038] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[ 3.959143] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 3.959277] usb usb4: Product: UHCI Host Controller
[ 3.959372] usb usb4: Manufacturer: Linux 2.6.25-rc7-storage-dbg uhci_hcd
[ 3.959474] usb usb4: SerialNumber: 0000:00:1d.3
[ 3.961428] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 23
[ 3.961639] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[ 3.961648] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 3.961831] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 5
[ 3.965889] ehci_hcd 0000:00:1d.7: debug port 1
[ 3.965989] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[ 3.966006] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xf7eb7c00
[ 3.988939] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 3.989420] usb usb5: configuration #1 chosen from 1 choice
[ 3.989583] hub 5-0:1.0: USB hub found
[ 3.989692] hub 5-0:1.0: 8 ports detected
[ 4.099048] usb usb5: New USB device found, idVendor=1d6b, idProduct=0002
[ 4.099164] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.099299] usb usb5: Product: EHCI Host Controller
[ 4.099394] usb usb5: Manufacturer: Linux 2.6.25-rc7-storage-dbg ehci_hcd
[ 4.099497] usb usb5: SerialNumber: 0000:00:1d.7
[ 4.189116] kjournald starting. Commit interval 5 seconds
[ 4.189241] EXT3-fs: mounted filesystem with ordered data mode.
[ 4.573048] usb 5-5: new high speed USB device using ehci_hcd and address 2
[ 4.725046] usb 5-5: configuration #1 chosen from 1 choice
[ 4.728586] usb 5-5: New USB device found, idVendor=0951, idProduct=1606
[ 4.728700] usb 5-5: New USB device strings: Mfr=1, Product=2, SerialNumber=4
[ 4.728807] usb 5-5: Product: UB6225
[ 4.728900] usb 5-5: Manufacturer: ENE
[ 4.728991] usb 5-5: SerialNumber: 146030377350
[ 5.004515] usb 5-8: new high speed USB device using ehci_hcd and address 3
[ 5.156605] usb 5-8: configuration #1 chosen from 1 choice
[ 5.157480] usb 5-8: New USB device found, idVendor=eb1a, idProduct=2761
[ 5.157590] usb 5-8: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 5.167699] usbcore: registered new interface driver libusual
[ 5.217631] Initializing USB Mass Storage driver...
[ 5.217794] usb-storage: USB Mass Storage device detected
[ 5.227852] usb-storage: -- associate_dev
[ 5.227864] usb-storage: Vendor: 0x0951, Product: 0x1606, Revision: 0x0100
[ 5.227871] usb-storage: Interface Subclass: 0x06, Protocol: 0x50
[ 5.227888] usb-storage: Transport: Bulk
[ 5.227893] usb-storage: Protocol: Transparent SCSI
[ 5.237414] scsi2 : SCSI emulation for USB Mass Storage devices
[ 5.237656] usb-storage: *** thread sleeping.
[ 5.246113] usbcore: registered new interface driver usb-storage
[ 5.246233] USB Mass Storage support registered.
[ 5.246554] usb-storage: device found at 2
[ 5.246560] usb-storage: waiting for device to settle before scanning
[ 6.959069] input: Power Button (FF) as /class/input/input2
[ 7.026546] ACPI: Power Button (FF) [PWRF]
[ 7.026852] input: Lid Switch as /class/input/input3
[ 7.081144] ACPI: Lid Switch [LID]
[ 7.081441] input: Sleep Button (CM) as /class/input/input4
[ 7.143348] ACPI: Sleep Button (CM) [SLPB]
[ 7.143603] input: Power Button (CM) as /class/input/input5
[ 7.213152] ACPI: Power Button (CM) [PWRB]
[ 7.505795] ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 7.506030] PCI: Setting latency timer of device 0000:00:1b.0 to 64
[ 7.512095] power_supply AC0: uevent
[ 7.512104] power_supply AC0: No power supply yet
[ 7.512130] power_supply AC0: power_supply_changed
[ 7.512151] ACPI: AC Adapter [AC0] (off-line)
[ 7.512891] power_supply AC0: power_supply_changed_work
[ 7.512900] power_supply AC0: power_supply_update_gen_leds 0
[ 7.512924] power_supply AC0: uevent
[ 7.512928] power_supply AC0: POWER_SUPPLY_NAME=AC0
[ 7.512940] power_supply AC0: Static prop TYPE=Mains
[ 7.512947] power_supply AC0: 1 dynamic props
[ 7.512954] power_supply AC0: prop ONLINE=0
[ 7.942018] power_supply BAT0: uevent
[ 7.942029] power_supply BAT0: No power supply yet
[ 7.942083] power_supply BAT0: power_supply_changed
[ 7.943000] power_supply BAT0: power_supply_changed_work
[ 8.208838] ACPI: Battery Slot [BAT0] (battery present)
[ 8.209607] input: Video Bus as /class/input/input6
[ 8.211689] ACPI: PCI Interrupt 0000:00:1f.3[B] -> GSI 19 (level, low) -> IRQ 19
[ 8.303160] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no)
[ 8.407939] power_supply BAT0: power_supply_update_bat_leds 2
[ 8.407973] power_supply BAT0: uevent
[ 8.407979] power_supply BAT0: POWER_SUPPLY_NAME=BAT0
[ 8.407994] power_supply BAT0: Static prop TYPE=Battery
[ 8.408001] power_supply BAT0: 12 dynamic props
[ 8.408008] power_supply BAT0: prop STATUS=Discharging
[ 8.408016] power_supply BAT0: prop PRESENT=1
[ 8.408025] power_supply BAT0: prop TECHNOLOGY=Li-ion
[ 8.408033] power_supply BAT0: prop VOLTAGE_MIN_DESIGN=8400000
[ 8.408042] power_supply BAT0: prop VOLTAGE_NOW=7325000
[ 8.408050] power_supply BAT0: prop CURRENT_NOW=-1000
[ 8.408058] power_supply BAT0: prop CHARGE_FULL_DESIGN=5200000
[ 8.408066] power_supply BAT0: prop CHARGE_FULL=100000
[ 8.408074] power_supply BAT0: prop CHARGE_NOW=30000
[ 8.408081] power_supply BAT0: prop MODEL_NAME=701
[ 8.408089] power_supply BAT0: prop MANUFACTURER=ASUS
[ 8.408096] power_supply BAT0: prop SERIAL_NUMBER=
[ 9.949215] EXT3 FS on sda2, internal journal
[ 10.237060] usb-storage: usb_stor_control_msg: rq=fe rqtype=a1 value=0000 index=00 len=1
[ 10.237234] usb-storage: GetMaxLUN command result is 1, data is 0
[ 10.237346] usb-storage: queuecommand called
[ 10.237367] usb-storage: *** thread awakened.
[ 10.237374] usb-storage: Command INQUIRY (6 bytes)
[ 10.237379] usb-storage: 12 00 00 00 24 00
[ 10.237394] usb-storage: Bulk Command S 0x43425355 T 0x1 L 36 F 128 Trg 0 LUN 0 CL 6
[ 10.237402] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.242370] usb-storage: Status code 0; transferred 31/31
[ 10.242376] usb-storage: -- transfer complete
[ 10.242381] usb-storage: Bulk command transfer result=0
[ 10.242388] usb-storage: usb_stor_bulk_transfer_sglist: xfer 36 bytes, 1 entries
[ 10.242474] usb-storage: Status code 0; transferred 36/36
[ 10.242479] usb-storage: -- transfer complete
[ 10.242483] usb-storage: Bulk data transfer result 0x0
[ 10.242488] usb-storage: Attempting to get CSW...
[ 10.242493] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.242590] usb-storage: Status code 0; transferred 13/13
[ 10.242595] usb-storage: -- transfer complete
[ 10.242600] usb-storage: Bulk status result = 0
[ 10.242606] usb-storage: Bulk Status S 0x53425355 T 0x1 R 0 Stat 0x0
[ 10.242612] usb-storage: scsi cmd done, result=0x0
[ 10.242621] usb-storage: *** thread sleeping.
[ 10.242713] scsi 2:0:0:0: Direct-Access USB2.0 CardReader SD0 0100 PQ: 0 ANSI: 0
[ 10.243050] usb-storage: queuecommand called
[ 10.243068] usb-storage: *** thread awakened.
[ 10.243075] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.243079] usb-storage: 00 00 00 00 00 00
[ 10.243091] usb-storage: Bulk Command S 0x43425355 T 0x2 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.243098] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.243235] usb-storage: Status code 0; transferred 31/31
[ 10.243240] usb-storage: -- transfer complete
[ 10.243245] usb-storage: Bulk command transfer result=0
[ 10.243250] usb-storage: Attempting to get CSW...
[ 10.243256] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.611486] usb-storage: Status code 0; transferred 13/13
[ 10.611498] usb-storage: -- transfer complete
[ 10.611503] usb-storage: Bulk status result = 0
[ 10.611510] usb-storage: Bulk Status S 0x53425355 T 0x2 R 0 Stat 0x1
[ 10.611517] usb-storage: -- transport indicates command failure
[ 10.611522] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.611534] usb-storage: Bulk Command S 0x43425355 T 0x3 L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.611541] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.611593] usb-storage: Status code 0; transferred 31/31
[ 10.611598] usb-storage: -- transfer complete
[ 10.611602] usb-storage: Bulk command transfer result=0
[ 10.611609] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.611844] usb-storage: Status code 0; transferred 18/18
[ 10.611849] usb-storage: -- transfer complete
[ 10.611854] usb-storage: Bulk data transfer result 0x0
[ 10.611859] usb-storage: Attempting to get CSW...
[ 10.611864] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.611966] usb-storage: Status code 0; transferred 13/13
[ 10.611971] usb-storage: -- transfer complete
[ 10.611976] usb-storage: Bulk status result = 0
[ 10.611982] usb-storage: Bulk Status S 0x53425355 T 0x3 R 0 Stat 0x0
[ 10.611990] usb-storage: -- Result from auto-sense is 0
[ 10.611997] usb-storage: -- code: 0x70, key: 0x6, ASC: 0x28, ASCQ: 0x0
[ 10.612003] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.612010] usb-storage: scsi cmd done, result=0x2
[ 10.612023] usb-storage: *** thread sleeping.
[ 10.612084] usb-storage: queuecommand called
[ 10.612098] usb-storage: *** thread awakened.
[ 10.612104] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.612109] usb-storage: 00 00 00 00 00 00
[ 10.612121] usb-storage: Bulk Command S 0x43425355 T 0x4 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.612128] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.617089] usb-storage: Status code 0; transferred 31/31
[ 10.617094] usb-storage: -- transfer complete
[ 10.617098] usb-storage: Bulk command transfer result=0
[ 10.617103] usb-storage: Attempting to get CSW...
[ 10.617108] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.617220] usb-storage: Status code 0; transferred 13/13
[ 10.617225] usb-storage: -- transfer complete
[ 10.617229] usb-storage: Bulk status result = 0
[ 10.617237] usb-storage: Bulk Status S 0x53425355 T 0x4 R 0 Stat 0x0
[ 10.617243] usb-storage: scsi cmd done, result=0x0
[ 10.617250] usb-storage: *** thread sleeping.
[ 10.617287] usb-storage: queuecommand called
[ 10.617300] usb-storage: *** thread awakened.
[ 10.617306] usb-storage: Command READ_CAPACITY (10 bytes)
[ 10.617311] usb-storage: 25 00 00 00 00 00 00 00 00 00
[ 10.617325] usb-storage: Bulk Command S 0x43425355 T 0x5 L 8 F 128 Trg 0 LUN 0 CL 10
[ 10.617337] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.617470] usb-storage: Status code 0; transferred 31/31
[ 10.617474] usb-storage: -- transfer complete
[ 10.617479] usb-storage: Bulk command transfer result=0
[ 10.617485] usb-storage: usb_stor_bulk_transfer_sglist: xfer 8 bytes, 1 entries
[ 10.617718] usb-storage: Status code 0; transferred 8/8
[ 10.617723] usb-storage: -- transfer complete
[ 10.617728] usb-storage: Bulk data transfer result 0x0
[ 10.617732] usb-storage: Attempting to get CSW...
[ 10.617738] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.617841] usb-storage: Status code 0; transferred 13/13
[ 10.617846] usb-storage: -- transfer complete
[ 10.617850] usb-storage: Bulk status result = 0
[ 10.617856] usb-storage: Bulk Status S 0x53425355 T 0x5 R 0 Stat 0x0
[ 10.617862] usb-storage: scsi cmd done, result=0x0
[ 10.617869] usb-storage: *** thread sleeping.
[ 10.617898] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 10.618020] usb-storage: queuecommand called
[ 10.618036] usb-storage: *** thread awakened.
[ 10.618041] usb-storage: Command MODE_SENSE (6 bytes)
[ 10.618046] usb-storage: 1a 00 3f 00 c0 00
[ 10.618058] usb-storage: Bulk Command S 0x43425355 T 0x6 L 192 F 128 Trg 0 LUN 0 CL 6
[ 10.618065] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.618221] usb-storage: Status code 0; transferred 31/31
[ 10.618225] usb-storage: -- transfer complete
[ 10.618230] usb-storage: Bulk command transfer result=0
[ 10.618236] usb-storage: usb_stor_bulk_transfer_sglist: xfer 192 bytes, 1 entries
[ 10.618472] usb-storage: Status code -121; transferred 4/192
[ 10.618477] usb-storage: -- short read transfer
[ 10.618481] usb-storage: Bulk data transfer result 0x1
[ 10.618486] usb-storage: Attempting to get CSW...
[ 10.618491] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.618718] usb-storage: Status code 0; transferred 13/13
[ 10.618723] usb-storage: -- transfer complete
[ 10.618728] usb-storage: Bulk status result = 0
[ 10.618734] usb-storage: Bulk Status S 0x53425355 T 0x6 R 188 Stat 0x0
[ 10.618740] usb-storage: scsi cmd done, result=0x0
[ 10.618747] usb-storage: *** thread sleeping.
[ 10.618774] sd 2:0:0:0: [sdb] Write Protect is off
[ 10.618878] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 10.618884] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 10.619079] usb-storage: queuecommand called
[ 10.619098] usb-storage: *** thread awakened.
[ 10.619104] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.619109] usb-storage: 00 00 00 00 00 00
[ 10.619120] usb-storage: Bulk Command S 0x43425355 T 0x7 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.619127] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.624087] usb-storage: Status code 0; transferred 31/31
[ 10.624092] usb-storage: -- transfer complete
[ 10.624097] usb-storage: Bulk command transfer result=0
[ 10.624102] usb-storage: Attempting to get CSW...
[ 10.624107] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.624218] usb-storage: Status code 0; transferred 13/13
[ 10.624223] usb-storage: -- transfer complete
[ 10.624227] usb-storage: Bulk status result = 0
[ 10.624233] usb-storage: Bulk Status S 0x53425355 T 0x7 R 0 Stat 0x0
[ 10.624239] usb-storage: scsi cmd done, result=0x0
[ 10.624247] usb-storage: *** thread sleeping.
[ 10.624281] usb-storage: queuecommand called
[ 10.624295] usb-storage: *** thread awakened.
[ 10.624300] usb-storage: Command ALLOW_MEDIUM_REMOVAL (6 bytes)
[ 10.624305] usb-storage: 1e 00 00 00 01 00
[ 10.624317] usb-storage: Bulk Command S 0x43425355 T 0x8 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.624323] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.625107] usb-storage: Status code 0; transferred 31/31
[ 10.625114] usb-storage: -- transfer complete
[ 10.625119] usb-storage: Bulk command transfer result=0
[ 10.625124] usb-storage: Attempting to get CSW...
[ 10.625129] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.625894] usb-storage: Status code 0; transferred 13/13
[ 10.625901] usb-storage: -- transfer complete
[ 10.625906] usb-storage: Bulk status result = 0
[ 10.625914] usb-storage: Bulk Status S 0x53425355 T 0x8 R 0 Stat 0x1
[ 10.625921] usb-storage: -- transport indicates command failure
[ 10.625926] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.625936] usb-storage: Bulk Command S 0x43425355 T 0x9 L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.625943] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.626627] usb-storage: Status code 0; transferred 31/31
[ 10.626634] usb-storage: -- transfer complete
[ 10.626639] usb-storage: Bulk command transfer result=0
[ 10.626646] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.626727] usb-storage: Status code 0; transferred 18/18
[ 10.626732] usb-storage: -- transfer complete
[ 10.626737] usb-storage: Bulk data transfer result 0x0
[ 10.626742] usb-storage: Attempting to get CSW...
[ 10.626747] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.626840] usb-storage: Status code 0; transferred 13/13
[ 10.626844] usb-storage: -- transfer complete
[ 10.626849] usb-storage: Bulk status result = 0
[ 10.626855] usb-storage: Bulk Status S 0x53425355 T 0x9 R 0 Stat 0x0
[ 10.626861] usb-storage: -- Result from auto-sense is 0
[ 10.626868] usb-storage: -- code: 0x70, key: 0x5, ASC: 0x24, ASCQ: 0x0
[ 10.626874] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.626881] usb-storage: scsi cmd done, result=0x2
[ 10.626891] usb-storage: *** thread sleeping.
[ 10.626963] usb-storage: queuecommand called
[ 10.626978] usb-storage: *** thread awakened.
[ 10.626984] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.626989] usb-storage: 00 00 00 00 00 00
[ 10.627001] usb-storage: Bulk Command S 0x43425355 T 0xa L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.627008] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.631966] usb-storage: Status code 0; transferred 31/31
[ 10.631971] usb-storage: -- transfer complete
[ 10.631976] usb-storage: Bulk command transfer result=0
[ 10.631981] usb-storage: Attempting to get CSW...
[ 10.631986] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.632090] usb-storage: Status code 0; transferred 13/13
[ 10.632094] usb-storage: -- transfer complete
[ 10.632099] usb-storage: Bulk status result = 0
[ 10.632105] usb-storage: Bulk Status S 0x53425355 T 0xa R 0 Stat 0x0
[ 10.632111] usb-storage: scsi cmd done, result=0x0
[ 10.632118] usb-storage: *** thread sleeping.
[ 10.632160] usb-storage: queuecommand called
[ 10.632173] usb-storage: *** thread awakened.
[ 10.632179] usb-storage: Command READ_CAPACITY (10 bytes)
[ 10.632184] usb-storage: 25 00 00 00 00 00 00 00 00 00
[ 10.632199] usb-storage: Bulk Command S 0x43425355 T 0xb L 8 F 128 Trg 0 LUN 0 CL 10
[ 10.632213] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.632338] usb-storage: Status code 0; transferred 31/31
[ 10.632343] usb-storage: -- transfer complete
[ 10.632348] usb-storage: Bulk command transfer result=0
[ 10.632354] usb-storage: usb_stor_bulk_transfer_sglist: xfer 8 bytes, 1 entries
[ 10.632587] usb-storage: Status code 0; transferred 8/8
[ 10.632592] usb-storage: -- transfer complete
[ 10.632596] usb-storage: Bulk data transfer result 0x0
[ 10.632601] usb-storage: Attempting to get CSW...
[ 10.632606] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.632710] usb-storage: Status code 0; transferred 13/13
[ 10.632715] usb-storage: -- transfer complete
[ 10.632720] usb-storage: Bulk status result = 0
[ 10.632726] usb-storage: Bulk Status S 0x53425355 T 0xb R 0 Stat 0x0
[ 10.632732] usb-storage: scsi cmd done, result=0x0
[ 10.632740] usb-storage: *** thread sleeping.
[ 10.632768] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 10.632892] usb-storage: queuecommand called
[ 10.632906] usb-storage: *** thread awakened.
[ 10.632912] usb-storage: Command MODE_SENSE (6 bytes)
[ 10.632916] usb-storage: 1a 00 3f 00 c0 00
[ 10.632929] usb-storage: Bulk Command S 0x43425355 T 0xc L 192 F 128 Trg 0 LUN 0 CL 6
[ 10.632936] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.633089] usb-storage: Status code 0; transferred 31/31
[ 10.633094] usb-storage: -- transfer complete
[ 10.633098] usb-storage: Bulk command transfer result=0
[ 10.633104] usb-storage: usb_stor_bulk_transfer_sglist: xfer 192 bytes, 1 entries
[ 10.633340] usb-storage: Status code -121; transferred 4/192
[ 10.633345] usb-storage: -- short read transfer
[ 10.633350] usb-storage: Bulk data transfer result 0x1
[ 10.633354] usb-storage: Attempting to get CSW...
[ 10.633360] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.633586] usb-storage: Status code 0; transferred 13/13
[ 10.633591] usb-storage: -- transfer complete
[ 10.633595] usb-storage: Bulk status result = 0
[ 10.633601] usb-storage: Bulk Status S 0x53425355 T 0xc R 188 Stat 0x0
[ 10.633607] usb-storage: scsi cmd done, result=0x0
[ 10.633615] usb-storage: *** thread sleeping.
[ 10.633641] sd 2:0:0:0: [sdb] Write Protect is off
[ 10.633743] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 10.633749] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 10.633852] sdb:<7>usb-storage: queuecommand called
[ 10.634043] usb-storage: *** thread awakened.
[ 10.634048] usb-storage: Command READ_10 (10 bytes)
[ 10.634053] usb-storage: 28 00 00 00 00 00 00 00 08 00
[ 10.634068] usb-storage: Bulk Command S 0x43425355 T 0xd L 4096 F 128 Trg 0 LUN 0 CL 10
[ 10.634075] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.634215] usb-storage: Status code 0; transferred 31/31
[ 10.634220] usb-storage: -- transfer complete
[ 10.634224] usb-storage: Bulk command transfer result=0
[ 10.634231] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 10.635212] usb-storage: Status code 0; transferred 4096/4096
[ 10.635217] usb-storage: -- transfer complete
[ 10.635222] usb-storage: Bulk data transfer result 0x0
[ 10.635227] usb-storage: Attempting to get CSW...
[ 10.635232] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.635335] usb-storage: Status code 0; transferred 13/13
[ 10.635340] usb-storage: -- transfer complete
[ 10.635345] usb-storage: Bulk status result = 0
[ 10.635351] usb-storage: Bulk Status S 0x53425355 T 0xd R 0 Stat 0x0
[ 10.635356] usb-storage: scsi cmd done, result=0x0
[ 10.635363] usb-storage: *** thread sleeping.
[ 10.635396] sdb1 sdb2
[ 10.635775] sd 2:0:0:0: [sdb] Attached SCSI removable disk
[ 10.636029] usb-storage: queuecommand called
[ 10.636050] usb-storage: *** thread awakened.
[ 10.636055] usb-storage: Bad target number (1:0)
[ 10.636060] usb-storage: scsi cmd done, result=0x40000
[ 10.636069] usb-storage: *** thread sleeping.
[ 10.636154] usb-storage: queuecommand called
[ 10.636170] usb-storage: *** thread awakened.
[ 10.636176] usb-storage: Bad target number (2:0)
[ 10.636180] usb-storage: scsi cmd done, result=0x40000
[ 10.636188] usb-storage: *** thread sleeping.
[ 10.636254] usb-storage: queuecommand called
[ 10.636272] usb-storage: *** thread awakened.
[ 10.636277] usb-storage: Bad target number (3:0)
[ 10.636282] usb-storage: scsi cmd done, result=0x40000
[ 10.636290] usb-storage: *** thread sleeping.
[ 10.636358] usb-storage: queuecommand called
[ 10.636375] usb-storage: *** thread awakened.
[ 10.636380] usb-storage: Bad target number (4:0)
[ 10.636385] usb-storage: scsi cmd done, result=0x40000
[ 10.636392] usb-storage: *** thread sleeping.
[ 10.636457] usb-storage: queuecommand called
[ 10.636474] usb-storage: *** thread awakened.
[ 10.636479] usb-storage: Bad target number (5:0)
[ 10.636483] usb-storage: scsi cmd done, result=0x40000
[ 10.636491] usb-storage: *** thread sleeping.
[ 10.636556] usb-storage: queuecommand called
[ 10.636573] usb-storage: *** thread awakened.
[ 10.636578] usb-storage: Bad target number (6:0)
[ 10.636583] usb-storage: scsi cmd done, result=0x40000
[ 10.636590] usb-storage: *** thread sleeping.
[ 10.636655] usb-storage: queuecommand called
[ 10.636671] usb-storage: *** thread awakened.
[ 10.636676] usb-storage: Bad target number (7:0)
[ 10.636681] usb-storage: scsi cmd done, result=0x40000
[ 10.636689] usb-storage: *** thread sleeping.
[ 10.636725] usb-storage: device scan complete
[ 10.646639] usb-storage: queuecommand called
[ 10.646679] usb-storage: *** thread awakened.
[ 10.646687] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.646694] usb-storage: 00 00 00 00 00 00
[ 10.646708] usb-storage: Bulk Command S 0x43425355 T 0xe L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.646715] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.646859] usb-storage: Status code 0; transferred 31/31
[ 10.646865] usb-storage: -- transfer complete
[ 10.646870] usb-storage: Bulk command transfer result=0
[ 10.646875] usb-storage: Attempting to get CSW...
[ 10.646880] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.647100] usb-storage: Status code 0; transferred 13/13
[ 10.647106] usb-storage: -- transfer complete
[ 10.647111] usb-storage: Bulk status result = 0
[ 10.647117] usb-storage: Bulk Status S 0x53425355 T 0xe R 0 Stat 0x0
[ 10.647124] usb-storage: scsi cmd done, result=0x0
[ 10.647133] usb-storage: *** thread sleeping.
[ 10.657153] usb-storage: queuecommand called
[ 10.657189] usb-storage: *** thread awakened.
[ 10.657196] usb-storage: Command INQUIRY (6 bytes)
[ 10.657201] usb-storage: 12 00 00 00 fe 00
[ 10.657216] usb-storage: Bulk Command S 0x43425355 T 0xf L 254 F 128 Trg 0 LUN 0 CL 6
[ 10.657224] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.657357] usb-storage: Status code 0; transferred 31/31
[ 10.657363] usb-storage: -- transfer complete
[ 10.657368] usb-storage: Bulk command transfer result=0
[ 10.657374] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 10.657603] usb-storage: Status code -121; transferred 36/254
[ 10.657612] usb-storage: -- short read transfer
[ 10.657617] usb-storage: Bulk data transfer result 0x1
[ 10.657622] usb-storage: Attempting to get CSW...
[ 10.657627] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.657841] usb-storage: Status code 0; transferred 13/13
[ 10.657846] usb-storage: -- transfer complete
[ 10.657851] usb-storage: Bulk status result = 0
[ 10.657858] usb-storage: Bulk Status S 0x53425355 T 0xf R 218 Stat 0x0
[ 10.657865] usb-storage: scsi cmd done, result=0x0
[ 10.657876] usb-storage: *** thread sleeping.
[ 10.658131] usb-storage: queuecommand called
[ 10.658159] usb-storage: *** thread awakened.
[ 10.658165] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.658170] usb-storage: 00 00 00 00 00 00
[ 10.658183] usb-storage: Bulk Command S 0x43425355 T 0x10 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.658190] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.658350] usb-storage: Status code 0; transferred 31/31
[ 10.658357] usb-storage: -- transfer complete
[ 10.658361] usb-storage: Bulk command transfer result=0
[ 10.658366] usb-storage: Attempting to get CSW...
[ 10.658372] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.658587] usb-storage: Status code 0; transferred 13/13
[ 10.658593] usb-storage: -- transfer complete
[ 10.658597] usb-storage: Bulk status result = 0
[ 10.658604] usb-storage: Bulk Status S 0x53425355 T 0x10 R 0 Stat 0x0
[ 10.658610] usb-storage: scsi cmd done, result=0x0
[ 10.658619] usb-storage: *** thread sleeping.
[ 10.658713] usb-storage: queuecommand called
[ 10.658732] usb-storage: *** thread awakened.
[ 10.658738] usb-storage: Command INQUIRY (6 bytes)
[ 10.658743] usb-storage: 12 01 00 00 fe 00
[ 10.658755] usb-storage: Bulk Command S 0x43425355 T 0x11 L 254 F 128 Trg 0 LUN 0 CL 6
[ 10.658763] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.660730] usb-storage: Status code 0; transferred 31/31
[ 10.660735] usb-storage: -- transfer complete
[ 10.660740] usb-storage: Bulk command transfer result=0
[ 10.660746] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 10.660948] usb-storage: Status code -121; transferred 36/254
[ 10.660954] usb-storage: -- short read transfer
[ 10.660959] usb-storage: Bulk data transfer result 0x1
[ 10.660964] usb-storage: Attempting to get CSW...
[ 10.660969] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.662543] usb-storage: Status code 0; transferred 13/13
[ 10.662551] usb-storage: -- transfer complete
[ 10.662556] usb-storage: Bulk status result = 0
[ 10.662563] usb-storage: Bulk Status S 0x53425355 T 0x11 R 218 Stat 0x0
[ 10.662570] usb-storage: scsi cmd done, result=0x0
[ 10.662583] usb-storage: *** thread sleeping.
[ 10.746778] usb-storage: queuecommand called
[ 10.746822] usb-storage: *** thread awakened.
[ 10.746829] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 10.746834] usb-storage: 00 00 00 00 00 00
[ 10.746849] usb-storage: Bulk Command S 0x43425355 T 0x12 L 0 F 0 Trg 0 LUN 0 CL 6
[ 10.746856] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.750465] usb-storage: Status code 0; transferred 31/31
[ 10.750471] usb-storage: -- transfer complete
[ 10.750476] usb-storage: Bulk command transfer result=0
[ 10.750481] usb-storage: Attempting to get CSW...
[ 10.750487] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.750587] usb-storage: Status code 0; transferred 13/13
[ 10.750592] usb-storage: -- transfer complete
[ 10.750596] usb-storage: Bulk status result = 0
[ 10.750603] usb-storage: Bulk Status S 0x53425355 T 0x12 R 0 Stat 0x0
[ 10.750609] usb-storage: scsi cmd done, result=0x0
[ 10.750618] usb-storage: *** thread sleeping.
[ 10.752050] usb-storage: queuecommand called
[ 10.752077] usb-storage: *** thread awakened.
[ 10.752087] usb-storage: Command READ_10 (10 bytes)
[ 10.752092] usb-storage: 28 00 00 ee f3 80 00 00 08 00
[ 10.752110] usb-storage: Bulk Command S 0x43425355 T 0x13 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 10.752117] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.753579] usb-storage: Status code 0; transferred 31/31
[ 10.753588] usb-storage: -- transfer complete
[ 10.753594] usb-storage: Bulk command transfer result=0
[ 10.753602] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 10.754042] usb-storage: Status code 0; transferred 4096/4096
[ 10.754049] usb-storage: -- transfer complete
[ 10.754054] usb-storage: Bulk data transfer result 0x0
[ 10.754059] usb-storage: Attempting to get CSW...
[ 10.754066] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.757671] usb-storage: Status code 0; transferred 13/13
[ 10.757676] usb-storage: -- transfer complete
[ 10.757681] usb-storage: Bulk status result = 0
[ 10.757687] usb-storage: Bulk Status S 0x53425355 T 0x13 R 0 Stat 0x0
[ 10.757698] usb-storage: scsi cmd done, result=0x0
[ 10.757708] usb-storage: *** thread sleeping.
[ 10.757889] usb-storage: queuecommand called
[ 10.757909] usb-storage: *** thread awakened.
[ 10.757915] usb-storage: Command READ_10 (10 bytes)
[ 10.757920] usb-storage: 28 00 00 00 00 00 00 00 08 00
[ 10.757937] usb-storage: Bulk Command S 0x43425355 T 0x14 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 10.757944] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.758095] usb-storage: Status code 0; transferred 31/31
[ 10.758100] usb-storage: -- transfer complete
[ 10.758105] usb-storage: Bulk command transfer result=0
[ 10.758111] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 10.758592] usb-storage: Status code 0; transferred 4096/4096
[ 10.758597] usb-storage: -- transfer complete
[ 10.758602] usb-storage: Bulk data transfer result 0x0
[ 10.758606] usb-storage: Attempting to get CSW...
[ 10.758612] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.758710] usb-storage: Status code 0; transferred 13/13
[ 10.758715] usb-storage: -- transfer complete
[ 10.758719] usb-storage: Bulk status result = 0
[ 10.758725] usb-storage: Bulk Status S 0x53425355 T 0x14 R 0 Stat 0x0
[ 10.758731] usb-storage: scsi cmd done, result=0x0
[ 10.758739] usb-storage: *** thread sleeping.
[ 10.758853] usb-storage: queuecommand called
[ 10.758869] usb-storage: *** thread awakened.
[ 10.758874] usb-storage: Command READ_10 (10 bytes)
[ 10.758879] usb-storage: 28 00 00 00 00 08 00 00 20 00
[ 10.758894] usb-storage: Bulk Command S 0x43425355 T 0x15 L 16384 F 128 Trg 0 LUN 0 CL 10
[ 10.758902] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.758965] usb-storage: Status code 0; transferred 31/31
[ 10.758970] usb-storage: -- transfer complete
[ 10.758974] usb-storage: Bulk command transfer result=0
[ 10.758980] usb-storage: usb_stor_bulk_transfer_sglist: xfer 16384 bytes, 4 entries
[ 10.760092] usb-storage: Status code 0; transferred 16384/16384
[ 10.760097] usb-storage: -- transfer complete
[ 10.760102] usb-storage: Bulk data transfer result 0x0
[ 10.760107] usb-storage: Attempting to get CSW...
[ 10.760112] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.760210] usb-storage: Status code 0; transferred 13/13
[ 10.760215] usb-storage: -- transfer complete
[ 10.760219] usb-storage: Bulk status result = 0
[ 10.760226] usb-storage: Bulk Status S 0x53425355 T 0x15 R 0 Stat 0x0
[ 10.760231] usb-storage: scsi cmd done, result=0x0
[ 10.760239] usb-storage: *** thread sleeping.
[ 10.760337] usb-storage: queuecommand called
[ 10.760351] usb-storage: *** thread awakened.
[ 10.760357] usb-storage: Command READ_10 (10 bytes)
[ 10.760361] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.760376] usb-storage: Bulk Command S 0x43425355 T 0x16 L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.760384] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.760466] usb-storage: Status code 0; transferred 31/31
[ 10.760471] usb-storage: -- transfer complete
[ 10.760475] usb-storage: Bulk command transfer result=0
[ 10.760482] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.761089] usb-storage: Status code 0; transferred 3584/3584
[ 10.761094] usb-storage: -- transfer complete
[ 10.761099] usb-storage: Bulk data transfer result 0x0
[ 10.761104] usb-storage: Attempting to get CSW...
[ 10.761109] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.761214] usb-storage: Status code -32; transferred 0/13
[ 10.761220] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.761231] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.761337] usb-storage: usb_stor_clear_halt: result = 0
[ 10.761342] usb-storage: Attempting to get CSW (2nd try)...
[ 10.761348] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.761461] usb-storage: Status code 0; transferred 13/13
[ 10.761466] usb-storage: -- transfer complete
[ 10.761470] usb-storage: Bulk status result = 0
[ 10.761477] usb-storage: Bulk Status S 0x53425355 T 0x16 R 0 Stat 0x1
[ 10.761483] usb-storage: -- transport indicates command failure
[ 10.761488] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.761497] usb-storage: Bulk Command S 0x43425355 T 0x17 L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.761504] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.761588] usb-storage: Status code 0; transferred 31/31
[ 10.761593] usb-storage: -- transfer complete
[ 10.761597] usb-storage: Bulk command transfer result=0
[ 10.761603] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.761838] usb-storage: Status code 0; transferred 18/18
[ 10.761843] usb-storage: -- transfer complete
[ 10.761848] usb-storage: Bulk data transfer result 0x0
[ 10.761853] usb-storage: Attempting to get CSW...
[ 10.761858] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.761962] usb-storage: Status code 0; transferred 13/13
[ 10.761967] usb-storage: -- transfer complete
[ 10.761971] usb-storage: Bulk status result = 0
[ 10.761977] usb-storage: Bulk Status S 0x53425355 T 0x17 R 0 Stat 0x0
[ 10.761984] usb-storage: -- Result from auto-sense is 0
[ 10.761990] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.761996] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.762003] usb-storage: scsi cmd done, result=0x2
[ 10.762010] usb-storage: *** thread sleeping.
[ 10.762025] usb-storage: queuecommand called
[ 10.762037] usb-storage: *** thread awakened.
[ 10.762042] usb-storage: Command READ_10 (10 bytes)
[ 10.762047] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.762062] usb-storage: Bulk Command S 0x43425355 T 0x18 L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.762069] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.762214] usb-storage: Status code 0; transferred 31/31
[ 10.762219] usb-storage: -- transfer complete
[ 10.762223] usb-storage: Bulk command transfer result=0
[ 10.762229] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.762586] usb-storage: Status code 0; transferred 3584/3584
[ 10.762591] usb-storage: -- transfer complete
[ 10.762596] usb-storage: Bulk data transfer result 0x0
[ 10.762601] usb-storage: Attempting to get CSW...
[ 10.762606] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.762712] usb-storage: Status code -32; transferred 0/13
[ 10.762718] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.762725] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.762835] usb-storage: usb_stor_clear_halt: result = 0
[ 10.762840] usb-storage: Attempting to get CSW (2nd try)...
[ 10.762846] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.762961] usb-storage: Status code 0; transferred 13/13
[ 10.762966] usb-storage: -- transfer complete
[ 10.762971] usb-storage: Bulk status result = 0
[ 10.762978] usb-storage: Bulk Status S 0x53425355 T 0x18 R 0 Stat 0x1
[ 10.762984] usb-storage: -- transport indicates command failure
[ 10.762989] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.762997] usb-storage: Bulk Command S 0x43425355 T 0x19 L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.763004] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.763091] usb-storage: Status code 0; transferred 31/31
[ 10.763096] usb-storage: -- transfer complete
[ 10.763101] usb-storage: Bulk command transfer result=0
[ 10.763107] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.763338] usb-storage: Status code 0; transferred 18/18
[ 10.763343] usb-storage: -- transfer complete
[ 10.763348] usb-storage: Bulk data transfer result 0x0
[ 10.763352] usb-storage: Attempting to get CSW...
[ 10.763358] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.763459] usb-storage: Status code 0; transferred 13/13
[ 10.763463] usb-storage: -- transfer complete
[ 10.763468] usb-storage: Bulk status result = 0
[ 10.763474] usb-storage: Bulk Status S 0x53425355 T 0x19 R 0 Stat 0x0
[ 10.763480] usb-storage: -- Result from auto-sense is 0
[ 10.763486] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.763492] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.763498] usb-storage: scsi cmd done, result=0x2
[ 10.763506] usb-storage: *** thread sleeping.
[ 10.763518] usb-storage: queuecommand called
[ 10.763530] usb-storage: *** thread awakened.
[ 10.763535] usb-storage: Command READ_10 (10 bytes)
[ 10.763540] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.763555] usb-storage: Bulk Command S 0x43425355 T 0x1a L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.763562] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.763711] usb-storage: Status code 0; transferred 31/31
[ 10.763716] usb-storage: -- transfer complete
[ 10.763721] usb-storage: Bulk command transfer result=0
[ 10.763727] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.764088] usb-storage: Status code 0; transferred 3584/3584
[ 10.764093] usb-storage: -- transfer complete
[ 10.764098] usb-storage: Bulk data transfer result 0x0
[ 10.764103] usb-storage: Attempting to get CSW...
[ 10.764108] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.764211] usb-storage: Status code -32; transferred 0/13
[ 10.764217] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.764224] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.764337] usb-storage: usb_stor_clear_halt: result = 0
[ 10.764342] usb-storage: Attempting to get CSW (2nd try)...
[ 10.764348] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.764464] usb-storage: Status code 0; transferred 13/13
[ 10.764469] usb-storage: -- transfer complete
[ 10.764473] usb-storage: Bulk status result = 0
[ 10.764479] usb-storage: Bulk Status S 0x53425355 T 0x1a R 0 Stat 0x1
[ 10.764485] usb-storage: -- transport indicates command failure
[ 10.764490] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.764498] usb-storage: Bulk Command S 0x43425355 T 0x1b L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.764505] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.764586] usb-storage: Status code 0; transferred 31/31
[ 10.764591] usb-storage: -- transfer complete
[ 10.764595] usb-storage: Bulk command transfer result=0
[ 10.764601] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.764839] usb-storage: Status code 0; transferred 18/18
[ 10.764844] usb-storage: -- transfer complete
[ 10.764849] usb-storage: Bulk data transfer result 0x0
[ 10.764854] usb-storage: Attempting to get CSW...
[ 10.764859] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.764962] usb-storage: Status code 0; transferred 13/13
[ 10.764967] usb-storage: -- transfer complete
[ 10.764971] usb-storage: Bulk status result = 0
[ 10.764978] usb-storage: Bulk Status S 0x53425355 T 0x1b R 0 Stat 0x0
[ 10.764983] usb-storage: -- Result from auto-sense is 0
[ 10.764990] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.764996] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.765002] usb-storage: scsi cmd done, result=0x2
[ 10.765009] usb-storage: *** thread sleeping.
[ 10.765021] usb-storage: queuecommand called
[ 10.765033] usb-storage: *** thread awakened.
[ 10.765039] usb-storage: Command READ_10 (10 bytes)
[ 10.765043] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.765058] usb-storage: Bulk Command S 0x43425355 T 0x1c L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.765065] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.765212] usb-storage: Status code 0; transferred 31/31
[ 10.765216] usb-storage: -- transfer complete
[ 10.765221] usb-storage: Bulk command transfer result=0
[ 10.765227] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.765588] usb-storage: Status code 0; transferred 3584/3584
[ 10.765593] usb-storage: -- transfer complete
[ 10.765598] usb-storage: Bulk data transfer result 0x0
[ 10.765602] usb-storage: Attempting to get CSW...
[ 10.765608] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.765711] usb-storage: Status code -32; transferred 0/13
[ 10.765716] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.765724] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.765834] usb-storage: usb_stor_clear_halt: result = 0
[ 10.765839] usb-storage: Attempting to get CSW (2nd try)...
[ 10.765845] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.765960] usb-storage: Status code 0; transferred 13/13
[ 10.765965] usb-storage: -- transfer complete
[ 10.765969] usb-storage: Bulk status result = 0
[ 10.765976] usb-storage: Bulk Status S 0x53425355 T 0x1c R 0 Stat 0x1
[ 10.765981] usb-storage: -- transport indicates command failure
[ 10.765986] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.765994] usb-storage: Bulk Command S 0x43425355 T 0x1d L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.766001] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.766088] usb-storage: Status code 0; transferred 31/31
[ 10.766093] usb-storage: -- transfer complete
[ 10.766098] usb-storage: Bulk command transfer result=0
[ 10.766104] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.766337] usb-storage: Status code 0; transferred 18/18
[ 10.766342] usb-storage: -- transfer complete
[ 10.766347] usb-storage: Bulk data transfer result 0x0
[ 10.766352] usb-storage: Attempting to get CSW...
[ 10.766357] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.766458] usb-storage: Status code 0; transferred 13/13
[ 10.766463] usb-storage: -- transfer complete
[ 10.766468] usb-storage: Bulk status result = 0
[ 10.766474] usb-storage: Bulk Status S 0x53425355 T 0x1d R 0 Stat 0x0
[ 10.766480] usb-storage: -- Result from auto-sense is 0
[ 10.766486] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.766492] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.766498] usb-storage: scsi cmd done, result=0x2
[ 10.766505] usb-storage: *** thread sleeping.
[ 10.766517] usb-storage: queuecommand called
[ 10.766529] usb-storage: *** thread awakened.
[ 10.766534] usb-storage: Command READ_10 (10 bytes)
[ 10.766539] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.766554] usb-storage: Bulk Command S 0x43425355 T 0x1e L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.766561] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.766714] usb-storage: Status code 0; transferred 31/31
[ 10.766719] usb-storage: -- transfer complete
[ 10.766723] usb-storage: Bulk command transfer result=0
[ 10.766730] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.767094] usb-storage: Status code 0; transferred 3584/3584
[ 10.767099] usb-storage: -- transfer complete
[ 10.767104] usb-storage: Bulk data transfer result 0x0
[ 10.767109] usb-storage: Attempting to get CSW...
[ 10.767114] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.767218] usb-storage: Status code -32; transferred 0/13
[ 10.767224] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.767232] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.767341] usb-storage: usb_stor_clear_halt: result = 0
[ 10.767346] usb-storage: Attempting to get CSW (2nd try)...
[ 10.767351] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.767465] usb-storage: Status code 0; transferred 13/13
[ 10.767470] usb-storage: -- transfer complete
[ 10.767474] usb-storage: Bulk status result = 0
[ 10.767480] usb-storage: Bulk Status S 0x53425355 T 0x1e R 0 Stat 0x1
[ 10.767486] usb-storage: -- transport indicates command failure
[ 10.767491] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.767500] usb-storage: Bulk Command S 0x43425355 T 0x1f L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.767507] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.767589] usb-storage: Status code 0; transferred 31/31
[ 10.767594] usb-storage: -- transfer complete
[ 10.767599] usb-storage: Bulk command transfer result=0
[ 10.767605] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.767843] usb-storage: Status code 0; transferred 18/18
[ 10.767848] usb-storage: -- transfer complete
[ 10.767853] usb-storage: Bulk data transfer result 0x0
[ 10.767858] usb-storage: Attempting to get CSW...
[ 10.767863] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.767962] usb-storage: Status code 0; transferred 13/13
[ 10.767967] usb-storage: -- transfer complete
[ 10.767972] usb-storage: Bulk status result = 0
[ 10.767978] usb-storage: Bulk Status S 0x53425355 T 0x1f R 0 Stat 0x0
[ 10.767983] usb-storage: -- Result from auto-sense is 0
[ 10.767990] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.767995] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.768002] usb-storage: scsi cmd done, result=0x2
[ 10.768009] usb-storage: *** thread sleeping.
[ 10.768023] usb-storage: queuecommand called
[ 10.768036] usb-storage: *** thread awakened.
[ 10.768041] usb-storage: Command READ_10 (10 bytes)
[ 10.768045] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.768060] usb-storage: Bulk Command S 0x43425355 T 0x20 L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.768068] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.768216] usb-storage: Status code 0; transferred 31/31
[ 10.768221] usb-storage: -- transfer complete
[ 10.768225] usb-storage: Bulk command transfer result=0
[ 10.768231] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.768589] usb-storage: Status code 0; transferred 3584/3584
[ 10.768594] usb-storage: -- transfer complete
[ 10.768599] usb-storage: Bulk data transfer result 0x0
[ 10.768604] usb-storage: Attempting to get CSW...
[ 10.768609] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.768717] usb-storage: Status code -32; transferred 0/13
[ 10.768722] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.768730] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.768838] usb-storage: usb_stor_clear_halt: result = 0
[ 10.768843] usb-storage: Attempting to get CSW (2nd try)...
[ 10.768849] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.768966] usb-storage: Status code 0; transferred 13/13
[ 10.768971] usb-storage: -- transfer complete
[ 10.768975] usb-storage: Bulk status result = 0
[ 10.768982] usb-storage: Bulk Status S 0x53425355 T 0x20 R 0 Stat 0x1
[ 10.768987] usb-storage: -- transport indicates command failure
[ 10.768993] usb-storage: Issuing auto-REQUEST_SENSE
[ 10.769001] usb-storage: Bulk Command S 0x43425355 T 0x21 L 18 F 128 Trg 0 LUN 0 CL 6
[ 10.769007] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.769091] usb-storage: Status code 0; transferred 31/31
[ 10.769096] usb-storage: -- transfer complete
[ 10.769101] usb-storage: Bulk command transfer result=0
[ 10.769107] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 10.769341] usb-storage: Status code 0; transferred 18/18
[ 10.769346] usb-storage: -- transfer complete
[ 10.769351] usb-storage: Bulk data transfer result 0x0
[ 10.769356] usb-storage: Attempting to get CSW...
[ 10.769361] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.769462] usb-storage: Status code 0; transferred 13/13
[ 10.769467] usb-storage: -- transfer complete
[ 10.769472] usb-storage: Bulk status result = 0
[ 10.769478] usb-storage: Bulk Status S 0x53425355 T 0x21 R 0 Stat 0x0
[ 10.769484] usb-storage: -- Result from auto-sense is 0
[ 10.769490] usb-storage: -- code: 0x70, key: 0x4, ASC: 0x11, ASCQ: 0x0
[ 10.769496] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 10.769502] usb-storage: scsi cmd done, result=0x2
[ 10.769509] usb-storage: *** thread sleeping.
[ 10.769527] sd 2:0:0:0: [sdb] Result: hostbyte=0x00 driverbyte=0x08
[ 10.769683] sd 2:0:0:0: [sdb] Sense Key : 0x4 [current]
[ 10.769922] sd 2:0:0:0: [sdb] ASC=0x11 ASCQ=0x0
[ 10.770110] end_request: I/O error, dev sdb, sector 15660024
[ 11.197280] fuse init (API version 7.9)
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-03-30 22:32 ` Sergey Dolgov
@ 2008-04-01 1:18 ` Sergey Dolgov
2008-04-01 1:58 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Sergey Dolgov @ 2008-04-01 1:18 UTC (permalink / raw)
To: Alan Stern; +Cc: linux-kernel, linux-usb
[-- Attachment #1: Type: text/plain, Size: 625 bytes --]
On Mon, Mar 31, 2008 at 02:32:12AM +0400, Sergey Dolgov wrote:
> On Sun, Mar 30, 2008 at 02:59:49PM -0400, Alan Stern wrote:
> > On Sun, 30 Mar 2008, Sergey Dolgov wrote:
> >
> > Can you build both 2.6.24.4 and 2.6.25-rc7 with
> > CONFIG_USB_STORAGE_DEBUG enabled, and post the dmesg logs from both
> > kernels showing what happens when the SDHC card is probed during boot?
> > Comparing the two logs should indicate where the crucial difference
> > lies.
>
> The dmesg output for 2.6.25-rc7 with USB storage debugging enabled is
> attached. I hope to produce the same for 2.6.24.4 on Monday.
>
Here goes...
--
Sergey
[-- Attachment #2: dmesg.24.8G-dbg --]
[-- Type: text/plain, Size: 97223 bytes --]
[ 0.000000] Linux version 2.6.24.4-storage-dbg (root@slke) (gcc version 4.2.3 (Debian 4.2.3-3)) #1 Tue Apr 1 00:40:57 MSD 2008
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
[ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e4000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000001f780000 (usable)
[ 0.000000] BIOS-e820: 000000001f780000 - 000000001f790000 (ACPI data)
[ 0.000000] BIOS-e820: 000000001f790000 - 000000001f7d0000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000001f7d0000 - 000000001f7de000 (reserved)
[ 0.000000] BIOS-e820: 000000001f7e0000 - 000000001f800000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] BIOS-e820: 00000000fff80000 - 0000000100000000 (reserved)
[ 0.000000] 503MB LOWMEM available.
[ 0.000000] found SMP MP-table at 000ff780
[ 0.000000] Entering add_active_range(0, 0, 128896) 0 entries of 256 used
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0 -> 4096
[ 0.000000] Normal 4096 -> 128896
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[1] active PFN ranges
[ 0.000000] 0: 0 -> 128896
[ 0.000000] On node 0 totalpages: 128896
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 4064 pages, LIFO batch:0
[ 0.000000] Normal zone: 975 pages used for memmap
[ 0.000000] Normal zone: 123825 pages, LIFO batch:31
[ 0.000000] Movable zone: 0 pages used for memmap
[ 0.000000] DMI present.
[ 0.000000] ACPI: RSDP 000FBE60, 0014 (r0 ACPIAM)
[ 0.000000] ACPI: RSDT 1F780000, 0034 (r1 A M I OEMRSDT 1000808 MSFT 97)
[ 0.000000] ACPI: FACP 1F780200, 0081 (r1 A M I OEMFACP 1000808 MSFT 97)
[ 0.000000] ACPI: DSDT 1F780400, 5F2B (r1 A0797 A0797000 0 INTL 20051117)
[ 0.000000] ACPI: FACS 1F790000, 0040
[ 0.000000] ACPI: APIC 1F780390, 0068 (r1 A M I OEMAPIC 1000808 MSFT 97)
[ 0.000000] ACPI: OEMB 1F790040, 0046 (r1 A M I AMI_OEM 1000808 MSFT 97)
[ 0.000000] ACPI: MCFG 1F786330, 003C (r1 A M I OEMMCFG 1000808 MSFT 97)
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] Processor #0 6:13 APIC version 20
[ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 1, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] Allocating PCI resources starting at 20000000 (gap: 1f800000:df600000)
[ 0.000000] swsusp: Registered nosave memory region: 000000000009f000 - 00000000000a0000
[ 0.000000] swsusp: Registered nosave memory region: 00000000000a0000 - 00000000000e4000
[ 0.000000] swsusp: Registered nosave memory region: 00000000000e4000 - 0000000000100000
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 127889
[ 0.000000] Kernel command line: root=LABEL=root ro
[ 0.000000] mapped APIC to ffffb000 (fee00000)
[ 0.000000] mapped IOAPIC to ffffa000 (fec00000)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] PID hash table entries: 2048 (order: 11, 8192 bytes)
[ 0.000000] Detected 630.072 MHz processor.
[ 13.122224] Console: colour VGA+ 80x25
[ 13.122233] console [tty0] enabled
[ 13.127442] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 13.128148] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 13.154801] Memory: 504936k/515584k available (1979k kernel code, 10052k reserved, 925k data, 224k init, 0k highmem)
[ 13.154965] virtual kernel memory layout:
[ 13.154968] fixmap : 0xfffb5000 - 0xfffff000 ( 296 kB)
[ 13.154971] vmalloc : 0xe0000000 - 0xfffb3000 ( 511 MB)
[ 13.154975] lowmem : 0xc0000000 - 0xdf780000 ( 503 MB)
[ 13.154978] .init : 0xc03da000 - 0xc0412000 ( 224 kB)
[ 13.154981] .data : 0xc02eef8c - 0xc03d6694 ( 925 kB)
[ 13.154984] .text : 0xc0100000 - 0xc02eef8c (1979 kB)
[ 13.155637] Checking if this processor honours the WP bit even in supervisor mode... Ok.
[ 13.155899] SLUB: Genslabs=11, HWalign=64, Order=0-1, MinObjects=4, CPUs=1, Nodes=1
[ 13.306041] Calibrating delay using timer specific routine.. 1261.19 BogoMIPS (lpj=6305978)
[ 13.306276] Mount-cache hash table entries: 512
[ 13.306618] CPU: After generic identify, caps: afe9fbff 00100000 00000000 00000000 00000000 00000000 00000000 00000000
[ 13.306644] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 13.306785] CPU: L2 cache: 512K
[ 13.306873] CPU: After all inits, caps: afe9fbff 00100000 00000000 00002040 00000000 00000000 00000000 00000000
[ 13.306889] Intel machine check architecture supported.
[ 13.306993] Intel machine check reporting enabled on CPU#0.
[ 13.307094] Compat vDSO mapped to ffffe000.
[ 13.307209] CPU: Intel(R) Celeron(R) M processor 900MHz stepping 08
[ 13.307405] Checking 'hlt' instruction... OK.
[ 13.350959] Freeing SMP alternatives: 0k freed
[ 13.351055] ACPI: Core revision 20070126
[ 13.360267] Parsing all Control Methods:
[ 13.360677] Table [DSDT](id 0001) - 841 Objects with 56 Devices 257 Methods 20 Regions
[ 13.360887] tbxface-0598 [00] tb_load_namespace : ACPI Tables successfully acquired
[ 13.578921] evxfevnt-0091 [00] enable : Transition to ACPI mode successful
[ 13.579445] ENABLING IO-APIC IRQs
[ 13.579760] ..TIMER: vector=0x31 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 13.796293] net_namespace: 64 bytes
[ 13.796409] Booting paravirtualized kernel on bare hardware
[ 13.797628] NET: Registered protocol family 16
[ 13.798090] No dock devices found.
[ 13.798394] ACPI: bus type pci registered
[ 13.798665] PCI: Using configuration type 1
[ 13.798758] Setting up standard PCI resources
[ 13.818498] evgpeblk-0956 [00] ev_create_gpe_block : GPE 00 to 1F [_GPE] 4 regs on int 0x9
[ 13.823476] evgpeblk-1052 [00] ev_initialize_gpe_bloc: Found 9 Wake, Enabled 0 Runtime GPEs in this block
[ 13.823717] ACPI: EC: Look up EC in DSDT
[ 13.825917] Completing Region/Field/Buffer/Package initialization:..............................................................................................
[ 13.837030] Initialized 19/20 Regions 18/18 Fields 33/34 Buffers 24/26 Packages (850 nodes)
[ 13.837242] Initializing Device/Processor/Thermal objects by executing _INI methods:..
[ 13.865694] Executed 2 _INI methods requiring 0 _STA executions (examined 60 objects)
[ 13.865919] ACPI: Interpreter enabled
[ 13.866015] ACPI: (supports S0 S1 S3 S4 S5)
[ 13.866372] ACPI: Using IOAPIC for interrupt routing
[ 13.885742] ACPI: EC: GPE = 0x18, I/O: command/status = 0x66, data = 0x62
[ 13.885856] ACPI: EC: driver started in poll mode
[ 13.886442] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 13.887486] Force enabled HPET at base address 0xfed00000
[ 13.887501] PCI quirk: region 0800-087f claimed by ICH6 ACPI/GPIO/TCO
[ 13.887606] PCI quirk: region 0480-04bf claimed by ICH6 GPIO
[ 13.888566] PCI: Transparent bridge - 0000:00:1e.0
[ 13.888720] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 13.889176] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P3._PRT]
[ 13.889436] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P5._PRT]
[ 13.889683] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.P0P6._PRT]
[ 13.904352] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 6 7 10 11 12 14 15)
[ 13.905364] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 10 *11 12 14 15)
[ 13.906381] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 *10 11 12 14 15)
[ 13.907381] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 *7 10 11 12 14 15)
[ 13.908392] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 13.909519] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 13.910641] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 13.911757] ACPI: PCI Interrupt Link [LNKH] (IRQs *3 4 5 6 7 10 11 12 14 15)
[ 13.912730] Linux Plug and Play Support v0.97 (c) Adam Belay
[ 13.912909] pnp: PnP ACPI init
[ 13.913013] ACPI: bus type pnp registered
[ 13.919090] pnp: PnP ACPI: found 13 devices
[ 13.919189] ACPI: ACPI bus type pnp unregistered
[ 13.919727] SCSI subsystem initialized
[ 13.919878] libata version 3.00 loaded.
[ 13.920229] PCI: Using ACPI for IRQ routing
[ 13.920324] PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report
[ 13.936424] hpet clockevent registered
[ 13.945977] Time: tsc clocksource has been installed.
[ 13.966083] system 00:01: iomem range 0xfed13000-0xfed19fff has been reserved
[ 13.966207] system 00:08: ioport range 0x380-0x383 has been reserved
[ 13.966310] system 00:08: ioport range 0x4d0-0x4d1 has been reserved
[ 13.966413] system 00:08: ioport range 0x800-0x87f has been reserved
[ 13.966516] system 00:08: ioport range 0x480-0x4bf has been reserved
[ 13.966620] system 00:08: iomem range 0xfed1c000-0xfed1ffff has been reserved
[ 13.966728] system 00:08: iomem range 0xfed20000-0xfed8ffff has been reserved
[ 13.966835] system 00:08: iomem range 0xfff00000-0xffffffff could not be reserved
[ 13.966977] system 00:09: iomem range 0xfec00000-0xfec00fff has been reserved
[ 13.967083] system 00:09: iomem range 0xfee00000-0xfee00fff could not be reserved
[ 13.967225] system 00:0a: iomem range 0xe0000000-0xefffffff has been reserved
[ 13.967341] system 00:0b: iomem range 0xe0000000-0xefffffff has been reserved
[ 13.967454] system 00:0c: iomem range 0x0-0x9ffff could not be reserved
[ 13.967560] system 00:0c: iomem range 0xc0000-0xcffff could not be reserved
[ 13.967665] system 00:0c: iomem range 0xe0000-0xfffff could not be reserved
[ 13.967770] system 00:0c: iomem range 0x100000-0x1f7fffff could not be reserved
[ 13.967905] system 00:0c: iomem range 0x0-0x0 could not be reserved
[ 13.998894] PCI: Bridge: 0000:00:1c.0
[ 13.998990] IO window: disabled.
[ 13.999083] MEM window: disabled.
[ 13.999173] PREFETCH window: disabled.
[ 13.999268] PCI: Bridge: 0000:00:1c.1
[ 13.999356] IO window: disabled.
[ 13.999448] MEM window: fbf00000-fbffffff
[ 13.999541] PREFETCH window: disabled.
[ 13.999635] PCI: Bridge: 0000:00:1c.2
[ 13.999724] IO window: disabled.
[ 13.999816] MEM window: f8000000-fbefffff
[ 13.999910] PREFETCH window: f0000000-f6ffffff
[ 14.000007] PCI: Bridge: 0000:00:1e.0
[ 14.000095] IO window: disabled.
[ 14.000186] MEM window: disabled.
[ 14.000276] PREFETCH window: disabled.
[ 14.000423] ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 14.000607] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 14.000637] ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 17 (level, low) -> IRQ 17
[ 14.000818] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 14.000847] ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 14.001028] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 14.001045] PCI: Setting latency timer of device 0000:00:1e.0 to 64
[ 14.001070] NET: Registered protocol family 2
[ 14.096096] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
[ 14.096649] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[ 14.097038] TCP bind hash table entries: 16384 (order: 4, 65536 bytes)
[ 14.097275] TCP: Hash tables configured (established 16384 bind 16384)
[ 14.097376] TCP reno registered
[ 14.126253] checking if image is initramfs... it is
[ 14.445936] Switched to high resolution mode on CPU 0
[ 14.611616] Freeing initrd memory: 2006k freed
[ 14.619203] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[ 14.619355] io scheduler noop registered
[ 14.619446] io scheduler deadline registered (default)
[ 14.619556] Boot video device is 0000:00:02.0
[ 14.619899] PCI: Setting latency timer of device 0000:00:1c.0 to 64
[ 14.619956] assign_interrupt_mode Found MSI capability
[ 14.620055] Allocate Port Service[0000:00:1c.0:pcie00]
[ 14.620156] Allocate Port Service[0000:00:1c.0:pcie02]
[ 14.620320] PCI: Setting latency timer of device 0000:00:1c.1 to 64
[ 14.620377] assign_interrupt_mode Found MSI capability
[ 14.620476] Allocate Port Service[0000:00:1c.1:pcie00]
[ 14.620559] Allocate Port Service[0000:00:1c.1:pcie02]
[ 14.620708] PCI: Setting latency timer of device 0000:00:1c.2 to 64
[ 14.620764] assign_interrupt_mode Found MSI capability
[ 14.620863] Allocate Port Service[0000:00:1c.2:pcie00]
[ 14.620949] Allocate Port Service[0000:00:1c.2:pcie02]
[ 14.685698] Linux agpgart interface v0.102
[ 14.685915] agpgart: Detected an Intel 915GM Chipset.
[ 14.686503] agpgart: Detected 7932K stolen memory.
[ 14.716330] agpgart: AGP aperture is 256M @ 0xd0000000
[ 14.716564] [drm] Initialized drm 1.1.0 20060810
[ 14.716710] ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 14.716893] PCI: Setting latency timer of device 0000:00:02.0 to 64
[ 14.717065] [drm] Initialized i915 1.6.0 20060119 on minor 0
[ 14.718460] RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
[ 14.719256] loop: module loaded
[ 14.719360] tun: Universal TUN/TAP device driver, 1.6
[ 14.719455] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[ 14.719711] Driver 'sd' needs updating - please use bus_type methods
[ 14.719963] ata_piix 0000:00:1f.2: version 2.12
[ 14.719977] ata_piix 0000:00:1f.2: MAP [ P0 P2 IDE IDE ]
[ 14.720306] ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 19 (level, low) -> IRQ 19
[ 14.720553] PCI: Setting latency timer of device 0000:00:1f.2 to 64
[ 14.720705] scsi0 : ata_piix
[ 14.720959] scsi1 : ata_piix
[ 14.725120] ata1: SATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 14.725230] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 15.066225] ata2.00: ATA-4: SILICONMOTION SM223AC, , max UDMA/66
[ 15.066328] ata2.00: 7815024 sectors, multi 0: LBA
[ 15.066450] ata2.00: limited to UDMA/33 due to 40-wire cable
[ 15.106159] ata2.00: configured for UDMA/33
[ 15.106518] scsi 1:0:0:0: Direct-Access ATA SILICONMOTION SM n/a PQ: 0 ANSI: 5
[ 15.106968] sd 1:0:0:0: [sda] 7815024 512-byte hardware sectors (4001 MB)
[ 15.107096] sd 1:0:0:0: [sda] Write Protect is off
[ 15.107193] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 15.107237] sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 15.107486] sd 1:0:0:0: [sda] 7815024 512-byte hardware sectors (4001 MB)
[ 15.107607] sd 1:0:0:0: [sda] Write Protect is off
[ 15.107701] sd 1:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 15.107739] sd 1:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 15.107881] sda: sda1 sda2
[ 15.108766] sd 1:0:0:0: [sda] Attached SCSI disk
[ 15.109319] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 15.141253] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 15.141356] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 15.141771] mice: PS/2 mouse device common for all mice
[ 15.168492] input: AT Translated Set 2 keyboard as /class/input/input0
[ 15.234297] cpuidle: using governor ladder
[ 15.234391] cpuidle: using governor menu
[ 15.236933] TCP cubic registered
[ 15.237060] NET: Registered protocol family 1
[ 15.237179] NET: Registered protocol family 17
[ 15.237279] Using IPI Shortcut mode
[ 15.237431] registered taskstats version 1
[ 15.237951] Freeing unused kernel memory: 224k freed
[ 15.401417] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
[ 15.401704] ACPI: Processor [CPU1] (supports 8 throttling states)
[ 15.406179] ACPI: EC: non-query interrupt received, switching to interrupt mode
[ 15.411506] Marking TSC unstable due to: TSC halts in idle.
[ 15.412128] ACPI: Thermal Zone [TZ00] (51 C)
[ 15.416015] Time: hpet clocksource has been installed.
[ 16.165478] Synaptics Touchpad, model: 1, fw: 6.5, id: 0x1c0b1, caps: 0xa04751/0xa00000
[ 16.252669] input: SynPS/2 Synaptics TouchPad as /class/input/input1
[ 17.175353] usbcore: registered new interface driver usbfs
[ 17.175553] usbcore: registered new interface driver hub
[ 17.180715] usbcore: registered new device driver usb
[ 17.183832] USB Universal Host Controller Interface driver v3.0
[ 17.184050] ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 20
[ 17.184246] PCI: Setting latency timer of device 0000:00:1d.0 to 64
[ 17.184257] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 17.184784] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[ 17.184962] uhci_hcd 0000:00:1d.0: irq 20, io base 0x0000e400
[ 17.185375] usb usb1: configuration #1 chosen from 1 choice
[ 17.185897] hub 1-0:1.0: USB hub found
[ 17.186004] hub 1-0:1.0: 2 ports detected
[ 17.295811] ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
[ 17.296016] PCI: Setting latency timer of device 0000:00:1d.1 to 64
[ 17.296028] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 17.296177] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[ 17.296359] uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000e480
[ 17.296753] usb usb2: configuration #1 chosen from 1 choice
[ 17.296907] hub 2-0:1.0: USB hub found
[ 17.297008] hub 2-0:1.0: 2 ports detected
[ 17.359487] ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
[ 17.359691] PCI: Setting latency timer of device 0000:00:1d.2 to 64
[ 17.359703] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 17.359853] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 3
[ 17.360025] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000e800
[ 17.360391] usb usb3: configuration #1 chosen from 1 choice
[ 17.360550] hub 3-0:1.0: USB hub found
[ 17.360648] hub 3-0:1.0: 2 ports detected
[ 17.362958] Clocksource tsc unstable (delta = -72540628 ns)
[ 17.364510] ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 16 (level, low) -> IRQ 16
[ 17.364703] PCI: Setting latency timer of device 0000:00:1d.3 to 64
[ 17.364713] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 17.364863] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 4
[ 17.365033] uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000e880
[ 17.365391] usb usb4: configuration #1 chosen from 1 choice
[ 17.365551] hub 4-0:1.0: USB hub found
[ 17.365655] hub 4-0:1.0: 2 ports detected
[ 17.370320] ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 20
[ 17.370518] PCI: Setting latency timer of device 0000:00:1d.7 to 64
[ 17.370526] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 17.370682] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 5
[ 17.374744] ehci_hcd 0000:00:1d.7: debug port 1
[ 17.374843] PCI: cache line size of 32 is not supported by device 0000:00:1d.7
[ 17.374858] ehci_hcd 0000:00:1d.7: irq 20, io mem 0xf7eb7c00
[ 17.389918] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 17.390373] usb usb5: configuration #1 chosen from 1 choice
[ 17.390534] hub 5-0:1.0: USB hub found
[ 17.390637] hub 5-0:1.0: 8 ports detected
[ 17.537982] kjournald starting. Commit interval 5 seconds
[ 17.538107] EXT3-fs: mounted filesystem with ordered data mode.
[ 17.825045] usb 5-5: new high speed USB device using ehci_hcd and address 2
[ 17.964111] usb 5-5: configuration #1 chosen from 1 choice
[ 18.242593] usb 5-8: new high speed USB device using ehci_hcd and address 3
[ 18.394447] usb 5-8: configuration #1 chosen from 1 choice
[ 18.405367] usbcore: registered new interface driver libusual
[ 18.426078] Initializing USB Mass Storage driver...
[ 18.426248] usb-storage: USB Mass Storage device detected
[ 18.437628] usb-storage: -- associate_dev
[ 18.437642] usb-storage: Vendor: 0x0951, Product: 0x1606, Revision: 0x0100
[ 18.437648] usb-storage: Interface Subclass: 0x06, Protocol: 0x50
[ 18.437664] usb-storage: Transport: Bulk
[ 18.437668] usb-storage: Protocol: Transparent SCSI
[ 18.453532] scsi2 : SCSI emulation for USB Mass Storage devices
[ 18.453766] usb-storage: *** thread sleeping.
[ 18.464863] usbcore: registered new interface driver usb-storage
[ 18.464981] USB Mass Storage support registered.
[ 18.465273] usb-storage: device found at 2
[ 18.465278] usb-storage: waiting for device to settle before scanning
[ 20.156603] input: Power Button (FF) as /class/input/input2
[ 20.232723] ACPI: Power Button (FF) [PWRF]
[ 20.233014] input: Lid Switch as /class/input/input3
[ 20.276797] ACPI: Lid Switch [LID]
[ 20.277078] input: Sleep Button (CM) as /class/input/input4
[ 20.342374] ACPI: Sleep Button (CM) [SLPB]
[ 20.342622] input: Power Button (CM) as /class/input/input5
[ 20.389007] ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 16 (level, low) -> IRQ 16
[ 20.389234] PCI: Setting latency timer of device 0000:00:1b.0 to 64
[ 20.422330] ACPI: Power Button (CM) [PWRB]
[ 20.583876] power_supply AC0: uevent
[ 20.583886] power_supply AC0: No power supply yet
[ 20.583910] power_supply AC0: power_supply_changed
[ 20.583930] ACPI: AC Adapter [AC0] (on-line)
[ 20.584042] power_supply AC0: power_supply_changed_work
[ 20.584049] power_supply AC0: power_supply_update_gen_leds 1
[ 20.584065] power_supply AC0: uevent
[ 20.584069] power_supply AC0: POWER_SUPPLY_NAME=AC0
[ 20.584079] power_supply AC0: Static prop TYPE=Mains
[ 20.584085] power_supply AC0: 1 dynamic props
[ 20.584092] power_supply AC0: prop ONLINE=1
[ 20.667703] input: Video Bus as /class/input/input6
[ 20.742319] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no)
[ 21.017292] power_supply BAT0: uevent
[ 21.017304] power_supply BAT0: No power supply yet
[ 21.017353] power_supply BAT0: power_supply_changed
[ 21.017372] power_supply BAT0: power_supply_changed_work
[ 21.032677] power_supply BAT0: power_supply_update_bat_leds 4
[ 21.032710] power_supply BAT0: uevent
[ 21.032715] power_supply BAT0: POWER_SUPPLY_NAME=BAT0
[ 21.032728] power_supply BAT0: Static prop TYPE=Battery
[ 21.032734] power_supply BAT0: 11 dynamic props
[ 21.032741] power_supply BAT0: prop STATUS=Full
[ 21.032749] power_supply BAT0: prop PRESENT=1
[ 21.032757] power_supply BAT0: prop TECHNOLOGY=Li-ion
[ 21.032766] power_supply BAT0: prop VOLTAGE_MIN_DESIGN=8400000
[ 21.032773] power_supply BAT0: prop VOLTAGE_NOW=8372000
[ 21.032781] power_supply BAT0: prop CURRENT_NOW=-1000
[ 21.032788] power_supply BAT0: prop CHARGE_FULL_DESIGN=5200000
[ 21.032796] power_supply BAT0: prop CHARGE_FULL=100000
[ 21.032804] power_supply BAT0: prop CHARGE_NOW=100000
[ 21.032811] power_supply BAT0: prop MODEL_NAME=701
[ 21.032818] power_supply BAT0: prop MANUFACTURER=ASUS
[ 21.047114] ACPI: Battery Slot [BAT0] (battery present)
[ 21.283113] ACPI: PCI Interrupt 0000:00:1f.3[B] -> GSI 19 (level, low) -> IRQ 19
[ 23.252178] EXT3 FS on sda2, internal journal
[ 23.398685] usb-storage: usb_stor_control_msg: rq=fe rqtype=a1 value=0000 index=00 len=1
[ 23.398783] usb-storage: GetMaxLUN command result is 1, data is 0
[ 23.398897] usb-storage: queuecommand called
[ 23.398913] usb-storage: *** thread awakened.
[ 23.398919] usb-storage: Command INQUIRY (6 bytes)
[ 23.398923] usb-storage: 12 00 00 00 24 00
[ 23.398940] usb-storage: Bulk Command S 0x43425355 T 0x1 L 36 F 128 Trg 0 LUN 0 CL 6
[ 23.398947] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.399026] usb-storage: Status code 0; transferred 31/31
[ 23.399034] usb-storage: -- transfer complete
[ 23.399038] usb-storage: Bulk command transfer result=0
[ 23.399044] usb-storage: usb_stor_bulk_transfer_sglist: xfer 36 bytes, 1 entries
[ 23.399149] usb-storage: Status code 0; transferred 36/36
[ 23.399154] usb-storage: -- transfer complete
[ 23.399158] usb-storage: Bulk data transfer result 0x0
[ 23.399163] usb-storage: Attempting to get CSW...
[ 23.399167] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.399273] usb-storage: Status code 0; transferred 13/13
[ 23.399277] usb-storage: -- transfer complete
[ 23.399281] usb-storage: Bulk status result = 0
[ 23.399287] usb-storage: Bulk Status S 0x53425355 T 0x1 R 0 Stat 0x0
[ 23.399293] usb-storage: scsi cmd done, result=0x0
[ 23.399301] usb-storage: *** thread sleeping.
[ 23.399384] scsi 2:0:0:0: Direct-Access USB2.0 CardReader SD0 0100 PQ: 0 ANSI: 0
[ 23.399738] usb-storage: queuecommand called
[ 23.400300] usb-storage: *** thread awakened.
[ 23.400309] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.400314] usb-storage: 00 00 00 00 00 00
[ 23.400326] usb-storage: Bulk Command S 0x43425355 T 0x2 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.400334] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.400583] usb-storage: Status code 0; transferred 31/31
[ 23.400589] usb-storage: -- transfer complete
[ 23.400594] usb-storage: Bulk command transfer result=0
[ 23.400599] usb-storage: Attempting to get CSW...
[ 23.400604] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.762989] usb-storage: Status code 0; transferred 13/13
[ 23.762998] usb-storage: -- transfer complete
[ 23.763003] usb-storage: Bulk status result = 0
[ 23.763010] usb-storage: Bulk Status S 0x53425355 T 0x2 R 0 Stat 0x1
[ 23.763016] usb-storage: -- transport indicates command failure
[ 23.763021] usb-storage: Issuing auto-REQUEST_SENSE
[ 23.763031] usb-storage: Bulk Command S 0x43425355 T 0x3 L 18 F 128 Trg 0 LUN 0 CL 6
[ 23.763038] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.763097] usb-storage: Status code 0; transferred 31/31
[ 23.763101] usb-storage: -- transfer complete
[ 23.763106] usb-storage: Bulk command transfer result=0
[ 23.763112] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 23.763346] usb-storage: Status code 0; transferred 18/18
[ 23.763351] usb-storage: -- transfer complete
[ 23.763355] usb-storage: Bulk data transfer result 0x0
[ 23.763359] usb-storage: Attempting to get CSW...
[ 23.763364] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.763469] usb-storage: Status code 0; transferred 13/13
[ 23.763473] usb-storage: -- transfer complete
[ 23.763477] usb-storage: Bulk status result = 0
[ 23.763483] usb-storage: Bulk Status S 0x53425355 T 0x3 R 0 Stat 0x0
[ 23.763489] usb-storage: -- Result from auto-sense is 0
[ 23.763495] usb-storage: -- code: 0x70, key: 0x6, ASC: 0x28, ASCQ: 0x0
[ 23.763501] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 23.763508] usb-storage: scsi cmd done, result=0x2
[ 23.763517] usb-storage: *** thread sleeping.
[ 23.763571] usb-storage: queuecommand called
[ 23.763579] usb-storage: *** thread awakened.
[ 23.763585] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.763590] usb-storage: 00 00 00 00 00 00
[ 23.763602] usb-storage: Bulk Command S 0x43425355 T 0x4 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.763608] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.763722] usb-storage: Status code 0; transferred 31/31
[ 23.763726] usb-storage: -- transfer complete
[ 23.763731] usb-storage: Bulk command transfer result=0
[ 23.763735] usb-storage: Attempting to get CSW...
[ 23.763740] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.763969] usb-storage: Status code 0; transferred 13/13
[ 23.763974] usb-storage: -- transfer complete
[ 23.763978] usb-storage: Bulk status result = 0
[ 23.763983] usb-storage: Bulk Status S 0x53425355 T 0x4 R 0 Stat 0x0
[ 23.763991] usb-storage: scsi cmd done, result=0x0
[ 23.763997] usb-storage: *** thread sleeping.
[ 23.764029] usb-storage: queuecommand called
[ 23.764037] usb-storage: *** thread awakened.
[ 23.764042] usb-storage: Command READ_CAPACITY (10 bytes)
[ 23.764047] usb-storage: 25 00 00 00 00 00 00 00 00 00
[ 23.764061] usb-storage: Bulk Command S 0x43425355 T 0x5 L 8 F 128 Trg 0 LUN 0 CL 10
[ 23.764068] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.764223] usb-storage: Status code 0; transferred 31/31
[ 23.764227] usb-storage: -- transfer complete
[ 23.764232] usb-storage: Bulk command transfer result=0
[ 23.764238] usb-storage: usb_stor_bulk_transfer_sglist: xfer 8 bytes, 1 entries
[ 23.764469] usb-storage: Status code 0; transferred 8/8
[ 23.764473] usb-storage: -- transfer complete
[ 23.764477] usb-storage: Bulk data transfer result 0x0
[ 23.764482] usb-storage: Attempting to get CSW...
[ 23.764487] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.764592] usb-storage: Status code 0; transferred 13/13
[ 23.764597] usb-storage: -- transfer complete
[ 23.764601] usb-storage: Bulk status result = 0
[ 23.764607] usb-storage: Bulk Status S 0x53425355 T 0x5 R 0 Stat 0x0
[ 23.764612] usb-storage: scsi cmd done, result=0x0
[ 23.764618] usb-storage: *** thread sleeping.
[ 23.764639] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 23.764764] usb-storage: queuecommand called
[ 23.764773] usb-storage: *** thread awakened.
[ 23.764778] usb-storage: Command MODE_SENSE (6 bytes)
[ 23.764783] usb-storage: 1a 00 3f 00 c0 00
[ 23.764794] usb-storage: Bulk Command S 0x43425355 T 0x6 L 192 F 128 Trg 0 LUN 0 CL 6
[ 23.764801] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.764847] usb-storage: Status code 0; transferred 31/31
[ 23.764852] usb-storage: -- transfer complete
[ 23.764856] usb-storage: Bulk command transfer result=0
[ 23.764862] usb-storage: usb_stor_bulk_transfer_sglist: xfer 192 bytes, 1 entries
[ 23.765098] usb-storage: Status code -121; transferred 4/192
[ 23.765103] usb-storage: -- short read transfer
[ 23.765108] usb-storage: Bulk data transfer result 0x1
[ 23.765112] usb-storage: Attempting to get CSW...
[ 23.765117] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.765343] usb-storage: Status code 0; transferred 13/13
[ 23.765347] usb-storage: -- transfer complete
[ 23.765351] usb-storage: Bulk status result = 0
[ 23.765357] usb-storage: Bulk Status S 0x53425355 T 0x6 R 188 Stat 0x0
[ 23.765363] usb-storage: scsi cmd done, result=0x0
[ 23.765368] usb-storage: *** thread sleeping.
[ 23.765386] sd 2:0:0:0: [sdb] Write Protect is off
[ 23.765484] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 23.765490] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 23.765695] usb-storage: queuecommand called
[ 23.765711] usb-storage: *** thread awakened.
[ 23.765716] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.765720] usb-storage: 00 00 00 00 00 00
[ 23.765732] usb-storage: Bulk Command S 0x43425355 T 0x7 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.765739] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.765850] usb-storage: Status code 0; transferred 31/31
[ 23.765854] usb-storage: -- transfer complete
[ 23.765859] usb-storage: Bulk command transfer result=0
[ 23.765864] usb-storage: Attempting to get CSW...
[ 23.765869] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.766093] usb-storage: Status code 0; transferred 13/13
[ 23.766097] usb-storage: -- transfer complete
[ 23.766101] usb-storage: Bulk status result = 0
[ 23.766107] usb-storage: Bulk Status S 0x53425355 T 0x7 R 0 Stat 0x0
[ 23.766113] usb-storage: scsi cmd done, result=0x0
[ 23.766118] usb-storage: *** thread sleeping.
[ 23.766139] usb-storage: queuecommand called
[ 23.766147] usb-storage: *** thread awakened.
[ 23.766152] usb-storage: Command ALLOW_MEDIUM_REMOVAL (6 bytes)
[ 23.766156] usb-storage: 1e 00 00 00 01 00
[ 23.766170] usb-storage: Bulk Command S 0x43425355 T 0x8 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.766177] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.766220] usb-storage: Status code 0; transferred 31/31
[ 23.766225] usb-storage: -- transfer complete
[ 23.766229] usb-storage: Bulk command transfer result=0
[ 23.766234] usb-storage: Attempting to get CSW...
[ 23.766239] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.766470] usb-storage: Status code 0; transferred 13/13
[ 23.766475] usb-storage: -- transfer complete
[ 23.766479] usb-storage: Bulk status result = 0
[ 23.766485] usb-storage: Bulk Status S 0x53425355 T 0x8 R 0 Stat 0x1
[ 23.766490] usb-storage: -- transport indicates command failure
[ 23.766498] usb-storage: Issuing auto-REQUEST_SENSE
[ 23.766505] usb-storage: Bulk Command S 0x43425355 T 0x9 L 18 F 128 Trg 0 LUN 0 CL 6
[ 23.766511] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.766595] usb-storage: Status code 0; transferred 31/31
[ 23.766600] usb-storage: -- transfer complete
[ 23.766604] usb-storage: Bulk command transfer result=0
[ 23.766610] usb-storage: usb_stor_bulk_transfer_sglist: xfer 18 bytes, 1 entries
[ 23.766845] usb-storage: Status code 0; transferred 18/18
[ 23.766849] usb-storage: -- transfer complete
[ 23.766853] usb-storage: Bulk data transfer result 0x0
[ 23.766858] usb-storage: Attempting to get CSW...
[ 23.766863] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.766969] usb-storage: Status code 0; transferred 13/13
[ 23.766973] usb-storage: -- transfer complete
[ 23.766978] usb-storage: Bulk status result = 0
[ 23.766983] usb-storage: Bulk Status S 0x53425355 T 0x9 R 0 Stat 0x0
[ 23.766989] usb-storage: -- Result from auto-sense is 0
[ 23.766995] usb-storage: -- code: 0x70, key: 0x5, ASC: 0x24, ASCQ: 0x0
[ 23.767000] usb-storage: (Unknown Key): (unknown ASC/ASCQ)
[ 23.767006] usb-storage: scsi cmd done, result=0x2
[ 23.767012] usb-storage: *** thread sleeping.
[ 23.767041] usb-storage: queuecommand called
[ 23.767050] usb-storage: *** thread awakened.
[ 23.767055] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.767059] usb-storage: 00 00 00 00 00 00
[ 23.767070] usb-storage: Bulk Command S 0x43425355 T 0xa L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.767076] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.767222] usb-storage: Status code 0; transferred 31/31
[ 23.767227] usb-storage: -- transfer complete
[ 23.767232] usb-storage: Bulk command transfer result=0
[ 23.767236] usb-storage: Attempting to get CSW...
[ 23.767241] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.767468] usb-storage: Status code 0; transferred 13/13
[ 23.767473] usb-storage: -- transfer complete
[ 23.767477] usb-storage: Bulk status result = 0
[ 23.767483] usb-storage: Bulk Status S 0x53425355 T 0xa R 0 Stat 0x0
[ 23.767488] usb-storage: scsi cmd done, result=0x0
[ 23.767493] usb-storage: *** thread sleeping.
[ 23.767515] usb-storage: queuecommand called
[ 23.767522] usb-storage: *** thread awakened.
[ 23.767527] usb-storage: Command READ_CAPACITY (10 bytes)
[ 23.767531] usb-storage: 25 00 00 00 00 00 00 00 00 00
[ 23.767546] usb-storage: Bulk Command S 0x43425355 T 0xb L 8 F 128 Trg 0 LUN 0 CL 10
[ 23.767552] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.767598] usb-storage: Status code 0; transferred 31/31
[ 23.767602] usb-storage: -- transfer complete
[ 23.767607] usb-storage: Bulk command transfer result=0
[ 23.767613] usb-storage: usb_stor_bulk_transfer_sglist: xfer 8 bytes, 1 entries
[ 23.767844] usb-storage: Status code 0; transferred 8/8
[ 23.767848] usb-storage: -- transfer complete
[ 23.767852] usb-storage: Bulk data transfer result 0x0
[ 23.767857] usb-storage: Attempting to get CSW...
[ 23.767862] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.767966] usb-storage: Status code 0; transferred 13/13
[ 23.767971] usb-storage: -- transfer complete
[ 23.767975] usb-storage: Bulk status result = 0
[ 23.767984] usb-storage: Bulk Status S 0x53425355 T 0xb R 0 Stat 0x0
[ 23.767989] usb-storage: scsi cmd done, result=0x0
[ 23.767995] usb-storage: *** thread sleeping.
[ 23.768011] sd 2:0:0:0: [sdb] 15660032 512-byte hardware sectors (8018 MB)
[ 23.768123] usb-storage: queuecommand called
[ 23.768132] usb-storage: *** thread awakened.
[ 23.768138] usb-storage: Command MODE_SENSE (6 bytes)
[ 23.768142] usb-storage: 1a 00 3f 00 c0 00
[ 23.768153] usb-storage: Bulk Command S 0x43425355 T 0xc L 192 F 128 Trg 0 LUN 0 CL 6
[ 23.768160] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.768224] usb-storage: Status code 0; transferred 31/31
[ 23.768228] usb-storage: -- transfer complete
[ 23.768233] usb-storage: Bulk command transfer result=0
[ 23.768238] usb-storage: usb_stor_bulk_transfer_sglist: xfer 192 bytes, 1 entries
[ 23.768470] usb-storage: Status code -121; transferred 4/192
[ 23.768477] usb-storage: -- short read transfer
[ 23.768481] usb-storage: Bulk data transfer result 0x1
[ 23.768486] usb-storage: Attempting to get CSW...
[ 23.768491] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.768621] usb-storage: Status code 0; transferred 13/13
[ 23.768625] usb-storage: -- transfer complete
[ 23.768630] usb-storage: Bulk status result = 0
[ 23.768635] usb-storage: Bulk Status S 0x53425355 T 0xc R 188 Stat 0x0
[ 23.768643] usb-storage: scsi cmd done, result=0x0
[ 23.768648] usb-storage: *** thread sleeping.
[ 23.768664] sd 2:0:0:0: [sdb] Write Protect is off
[ 23.768770] sd 2:0:0:0: [sdb] Mode Sense: 03 00 00 00
[ 23.768776] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 23.768884] sdb:<7>usb-storage: queuecommand called
[ 23.769064] usb-storage: *** thread awakened.
[ 23.769073] usb-storage: Command READ_10 (10 bytes)
[ 23.769077] usb-storage: 28 00 00 00 00 00 00 00 08 00
[ 23.769092] usb-storage: Bulk Command S 0x43425355 T 0xd L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.769099] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.769219] usb-storage: Status code 0; transferred 31/31
[ 23.769224] usb-storage: -- transfer complete
[ 23.769228] usb-storage: Bulk command transfer result=0
[ 23.769234] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.771722] usb-storage: Status code 0; transferred 4096/4096
[ 23.771727] usb-storage: -- transfer complete
[ 23.771731] usb-storage: Bulk data transfer result 0x0
[ 23.771736] usb-storage: Attempting to get CSW...
[ 23.771741] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.771846] usb-storage: Status code 0; transferred 13/13
[ 23.771850] usb-storage: -- transfer complete
[ 23.771855] usb-storage: Bulk status result = 0
[ 23.771860] usb-storage: Bulk Status S 0x53425355 T 0xd R 0 Stat 0x0
[ 23.771866] usb-storage: scsi cmd done, result=0x0
[ 23.771872] usb-storage: *** thread sleeping.
[ 23.771894] sdb1 sdb2
[ 23.772249] sd 2:0:0:0: [sdb] Attached SCSI removable disk
[ 23.772524] usb-storage: queuecommand called
[ 23.773023] usb-storage: *** thread awakened.
[ 23.773031] usb-storage: Bad target number (1:0)
[ 23.773037] usb-storage: scsi cmd done, result=0x40000
[ 23.773045] usb-storage: *** thread sleeping.
[ 23.773368] usb-storage: queuecommand called
[ 23.773384] usb-storage: *** thread awakened.
[ 23.773388] usb-storage: Bad target number (2:0)
[ 23.773393] usb-storage: scsi cmd done, result=0x40000
[ 23.773400] usb-storage: *** thread sleeping.
[ 23.773465] usb-storage: queuecommand called
[ 23.773475] usb-storage: *** thread awakened.
[ 23.773480] usb-storage: Bad target number (3:0)
[ 23.773484] usb-storage: scsi cmd done, result=0x40000
[ 23.773490] usb-storage: *** thread sleeping.
[ 23.774805] usb-storage: queuecommand called
[ 23.774826] usb-storage: *** thread awakened.
[ 23.774831] usb-storage: Bad target number (4:0)
[ 23.774836] usb-storage: scsi cmd done, result=0x40000
[ 23.774846] usb-storage: *** thread sleeping.
[ 23.774914] usb-storage: queuecommand called
[ 23.774924] usb-storage: *** thread awakened.
[ 23.774929] usb-storage: Bad target number (5:0)
[ 23.774933] usb-storage: scsi cmd done, result=0x40000
[ 23.774939] usb-storage: *** thread sleeping.
[ 23.774994] usb-storage: queuecommand called
[ 23.775004] usb-storage: *** thread awakened.
[ 23.775008] usb-storage: Bad target number (6:0)
[ 23.775013] usb-storage: scsi cmd done, result=0x40000
[ 23.775019] usb-storage: *** thread sleeping.
[ 23.775076] usb-storage: queuecommand called
[ 23.775085] usb-storage: *** thread awakened.
[ 23.775090] usb-storage: Bad target number (7:0)
[ 23.775094] usb-storage: scsi cmd done, result=0x40000
[ 23.775100] usb-storage: *** thread sleeping.
[ 23.775125] usb-storage: device scan complete
[ 23.791332] usb-storage: queuecommand called
[ 23.791365] usb-storage: *** thread awakened.
[ 23.791374] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.791379] usb-storage: 00 00 00 00 00 00
[ 23.791392] usb-storage: Bulk Command S 0x43425355 T 0xe L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.791400] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.791488] usb-storage: Status code 0; transferred 31/31
[ 23.791494] usb-storage: -- transfer complete
[ 23.791498] usb-storage: Bulk command transfer result=0
[ 23.791506] usb-storage: Attempting to get CSW...
[ 23.791511] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.791597] usb-storage: Status code 0; transferred 13/13
[ 23.791601] usb-storage: -- transfer complete
[ 23.791606] usb-storage: Bulk status result = 0
[ 23.791611] usb-storage: Bulk Status S 0x53425355 T 0xe R 0 Stat 0x0
[ 23.791618] usb-storage: scsi cmd done, result=0x0
[ 23.791626] usb-storage: *** thread sleeping.
[ 23.793147] usb-storage: queuecommand called
[ 23.793170] usb-storage: *** thread awakened.
[ 23.793177] usb-storage: Command INQUIRY (6 bytes)
[ 23.793181] usb-storage: 12 00 00 00 fe 00
[ 23.793195] usb-storage: Bulk Command S 0x43425355 T 0xf L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.793203] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.793358] usb-storage: Status code 0; transferred 31/31
[ 23.793364] usb-storage: -- transfer complete
[ 23.793369] usb-storage: Bulk command transfer result=0
[ 23.793375] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.793475] usb-storage: Status code -121; transferred 36/254
[ 23.793480] usb-storage: -- short read transfer
[ 23.793486] usb-storage: Bulk data transfer result 0x1
[ 23.793490] usb-storage: Attempting to get CSW...
[ 23.793495] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.793732] usb-storage: Status code 0; transferred 13/13
[ 23.793738] usb-storage: -- transfer complete
[ 23.793743] usb-storage: Bulk status result = 0
[ 23.793751] usb-storage: Bulk Status S 0x53425355 T 0xf R 218 Stat 0x0
[ 23.793758] usb-storage: scsi cmd done, result=0x0
[ 23.793767] usb-storage: *** thread sleeping.
[ 23.793998] usb-storage: queuecommand called
[ 23.794017] usb-storage: *** thread awakened.
[ 23.794023] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.794027] usb-storage: 00 00 00 00 00 00
[ 23.794040] usb-storage: Bulk Command S 0x43425355 T 0x10 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.794047] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.794099] usb-storage: Status code 0; transferred 31/31
[ 23.794103] usb-storage: -- transfer complete
[ 23.794108] usb-storage: Bulk command transfer result=0
[ 23.794112] usb-storage: Attempting to get CSW...
[ 23.794117] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.794350] usb-storage: Status code 0; transferred 13/13
[ 23.794355] usb-storage: -- transfer complete
[ 23.794360] usb-storage: Bulk status result = 0
[ 23.794366] usb-storage: Bulk Status S 0x53425355 T 0x10 R 0 Stat 0x0
[ 23.794372] usb-storage: scsi cmd done, result=0x0
[ 23.794379] usb-storage: *** thread sleeping.
[ 23.794432] usb-storage: queuecommand called
[ 23.794445] usb-storage: *** thread awakened.
[ 23.794450] usb-storage: Command INQUIRY (6 bytes)
[ 23.794454] usb-storage: 12 01 00 00 fe 00
[ 23.794467] usb-storage: Bulk Command S 0x43425355 T 0x11 L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.794475] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.794599] usb-storage: Status code 0; transferred 31/31
[ 23.794607] usb-storage: -- transfer complete
[ 23.794611] usb-storage: Bulk command transfer result=0
[ 23.794618] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.794851] usb-storage: Status code -121; transferred 36/254
[ 23.794857] usb-storage: -- short read transfer
[ 23.794862] usb-storage: Bulk data transfer result 0x1
[ 23.794866] usb-storage: Attempting to get CSW...
[ 23.794871] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.795097] usb-storage: Status code 0; transferred 13/13
[ 23.795102] usb-storage: -- transfer complete
[ 23.795107] usb-storage: Bulk status result = 0
[ 23.795113] usb-storage: Bulk Status S 0x53425355 T 0x11 R 218 Stat 0x0
[ 23.795119] usb-storage: scsi cmd done, result=0x0
[ 23.795126] usb-storage: *** thread sleeping.
[ 23.896263] usb-storage: queuecommand called
[ 23.896296] usb-storage: *** thread awakened.
[ 23.896302] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.896307] usb-storage: 00 00 00 00 00 00
[ 23.896323] usb-storage: Bulk Command S 0x43425355 T 0x12 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.896331] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.896466] usb-storage: Status code 0; transferred 31/31
[ 23.896471] usb-storage: -- transfer complete
[ 23.896476] usb-storage: Bulk command transfer result=0
[ 23.896481] usb-storage: Attempting to get CSW...
[ 23.896486] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.896578] usb-storage: Status code 0; transferred 13/13
[ 23.896583] usb-storage: -- transfer complete
[ 23.896587] usb-storage: Bulk status result = 0
[ 23.896593] usb-storage: Bulk Status S 0x53425355 T 0x12 R 0 Stat 0x0
[ 23.896599] usb-storage: scsi cmd done, result=0x0
[ 23.896607] usb-storage: *** thread sleeping.
[ 23.898017] usb-storage: queuecommand called
[ 23.898493] usb-storage: *** thread awakened.
[ 23.898504] usb-storage: Command READ_10 (10 bytes)
[ 23.898509] usb-storage: 28 00 00 ee f3 80 00 00 08 00
[ 23.898526] usb-storage: Bulk Command S 0x43425355 T 0x13 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.898534] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.898805] usb-storage: Status code 0; transferred 31/31
[ 23.898811] usb-storage: -- transfer complete
[ 23.898821] usb-storage: Bulk command transfer result=0
[ 23.898828] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.899637] usb-storage: Status code 0; transferred 4096/4096
[ 23.899645] usb-storage: -- transfer complete
[ 23.899650] usb-storage: Bulk data transfer result 0x0
[ 23.899655] usb-storage: Attempting to get CSW...
[ 23.899661] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.899833] usb-storage: Status code 0; transferred 13/13
[ 23.899838] usb-storage: -- transfer complete
[ 23.899843] usb-storage: Bulk status result = 0
[ 23.899849] usb-storage: Bulk Status S 0x53425355 T 0x13 R 0 Stat 0x0
[ 23.899856] usb-storage: scsi cmd done, result=0x0
[ 23.899866] usb-storage: *** thread sleeping.
[ 23.900053] usb-storage: queuecommand called
[ 23.900072] usb-storage: *** thread awakened.
[ 23.900079] usb-storage: Command READ_10 (10 bytes)
[ 23.900083] usb-storage: 28 00 00 00 00 00 00 00 08 00
[ 23.900099] usb-storage: Bulk Command S 0x43425355 T 0x14 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.900106] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.900207] usb-storage: Status code 0; transferred 31/31
[ 23.900212] usb-storage: -- transfer complete
[ 23.900216] usb-storage: Bulk command transfer result=0
[ 23.900222] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.900827] usb-storage: Status code 0; transferred 4096/4096
[ 23.900831] usb-storage: -- transfer complete
[ 23.900836] usb-storage: Bulk data transfer result 0x0
[ 23.900840] usb-storage: Attempting to get CSW...
[ 23.900845] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.900951] usb-storage: Status code 0; transferred 13/13
[ 23.900955] usb-storage: -- transfer complete
[ 23.900959] usb-storage: Bulk status result = 0
[ 23.900965] usb-storage: Bulk Status S 0x53425355 T 0x14 R 0 Stat 0x0
[ 23.900974] usb-storage: scsi cmd done, result=0x0
[ 23.900980] usb-storage: *** thread sleeping.
[ 23.901078] usb-storage: queuecommand called
[ 23.901094] usb-storage: *** thread awakened.
[ 23.901099] usb-storage: Command READ_10 (10 bytes)
[ 23.901103] usb-storage: 28 00 00 00 00 08 00 00 20 00
[ 23.901119] usb-storage: Bulk Command S 0x43425355 T 0x15 L 16384 F 128 Trg 0 LUN 0 CL 10
[ 23.901126] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.901205] usb-storage: Status code 0; transferred 31/31
[ 23.901210] usb-storage: -- transfer complete
[ 23.901214] usb-storage: Bulk command transfer result=0
[ 23.901220] usb-storage: usb_stor_bulk_transfer_sglist: xfer 16384 bytes, 3 entries
[ 23.902329] usb-storage: Status code 0; transferred 16384/16384
[ 23.902333] usb-storage: -- transfer complete
[ 23.902338] usb-storage: Bulk data transfer result 0x0
[ 23.902342] usb-storage: Attempting to get CSW...
[ 23.902347] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.902450] usb-storage: Status code 0; transferred 13/13
[ 23.902454] usb-storage: -- transfer complete
[ 23.902458] usb-storage: Bulk status result = 0
[ 23.902464] usb-storage: Bulk Status S 0x53425355 T 0x15 R 0 Stat 0x0
[ 23.902470] usb-storage: scsi cmd done, result=0x0
[ 23.902476] usb-storage: *** thread sleeping.
[ 23.902548] usb-storage: queuecommand called
[ 23.902566] usb-storage: *** thread awakened.
[ 23.902571] usb-storage: Command READ_10 (10 bytes)
[ 23.902575] usb-storage: 28 00 00 ee f3 f8 00 00 08 00
[ 23.902591] usb-storage: Bulk Command S 0x43425355 T 0x16 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.902598] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.902704] usb-storage: Status code 0; transferred 31/31
[ 23.902709] usb-storage: -- transfer complete
[ 23.902713] usb-storage: Bulk command transfer result=0
[ 23.902720] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.903337] usb-storage: Status code 0; transferred 4096/4096
[ 23.903343] usb-storage: -- transfer complete
[ 23.903349] usb-storage: Bulk data transfer result 0x0
[ 23.903354] usb-storage: Attempting to get CSW...
[ 23.903359] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.903448] usb-storage: Status code 0; transferred 13/13
[ 23.903453] usb-storage: -- transfer complete
[ 23.903457] usb-storage: Bulk status result = 0
[ 23.903463] usb-storage: Bulk Status S 0x53425355 T 0x16 R 0 Stat 0x0
[ 23.903469] usb-storage: scsi cmd done, result=0x0
[ 23.903476] usb-storage: *** thread sleeping.
[ 23.903622] usb-storage: queuecommand called
[ 23.903638] usb-storage: *** thread awakened.
[ 23.903648] usb-storage: Command READ_10 (10 bytes)
[ 23.903652] usb-storage: 28 00 00 ee f3 c0 00 00 08 00
[ 23.903668] usb-storage: Bulk Command S 0x43425355 T 0x17 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.903674] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.903830] usb-storage: Status code 0; transferred 31/31
[ 23.903835] usb-storage: -- transfer complete
[ 23.903839] usb-storage: Bulk command transfer result=0
[ 23.903845] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.904200] usb-storage: Status code 0; transferred 4096/4096
[ 23.904204] usb-storage: -- transfer complete
[ 23.904209] usb-storage: Bulk data transfer result 0x0
[ 23.904213] usb-storage: Attempting to get CSW...
[ 23.904218] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.904323] usb-storage: Status code 0; transferred 13/13
[ 23.904327] usb-storage: -- transfer complete
[ 23.904331] usb-storage: Bulk status result = 0
[ 23.904337] usb-storage: Bulk Status S 0x53425355 T 0x17 R 0 Stat 0x0
[ 23.904343] usb-storage: scsi cmd done, result=0x0
[ 23.904349] usb-storage: *** thread sleeping.
[ 23.904402] usb-storage: queuecommand called
[ 23.904416] usb-storage: *** thread awakened.
[ 23.904421] usb-storage: Command READ_10 (10 bytes)
[ 23.904426] usb-storage: 28 00 00 ee f3 00 00 00 08 00
[ 23.904441] usb-storage: Bulk Command S 0x43425355 T 0x18 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.904448] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.904578] usb-storage: Status code 0; transferred 31/31
[ 23.904582] usb-storage: -- transfer complete
[ 23.904587] usb-storage: Bulk command transfer result=0
[ 23.904593] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.904950] usb-storage: Status code 0; transferred 4096/4096
[ 23.904955] usb-storage: -- transfer complete
[ 23.904959] usb-storage: Bulk data transfer result 0x0
[ 23.904964] usb-storage: Attempting to get CSW...
[ 23.904969] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.905074] usb-storage: Status code 0; transferred 13/13
[ 23.905079] usb-storage: -- transfer complete
[ 23.905083] usb-storage: Bulk status result = 0
[ 23.905089] usb-storage: Bulk Status S 0x53425355 T 0x18 R 0 Stat 0x0
[ 23.905097] usb-storage: scsi cmd done, result=0x0
[ 23.905103] usb-storage: *** thread sleeping.
[ 23.905166] usb-storage: queuecommand called
[ 23.905180] usb-storage: *** thread awakened.
[ 23.905185] usb-storage: Command READ_10 (10 bytes)
[ 23.905189] usb-storage: 28 00 00 ee f3 f0 00 00 08 00
[ 23.905204] usb-storage: Bulk Command S 0x43425355 T 0x19 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.905211] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.905330] usb-storage: Status code 0; transferred 31/31
[ 23.905335] usb-storage: -- transfer complete
[ 23.905339] usb-storage: Bulk command transfer result=0
[ 23.905346] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.905703] usb-storage: Status code 0; transferred 4096/4096
[ 23.905707] usb-storage: -- transfer complete
[ 23.905712] usb-storage: Bulk data transfer result 0x0
[ 23.905716] usb-storage: Attempting to get CSW...
[ 23.905721] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.905826] usb-storage: Status code 0; transferred 13/13
[ 23.905830] usb-storage: -- transfer complete
[ 23.905835] usb-storage: Bulk status result = 0
[ 23.905840] usb-storage: Bulk Status S 0x53425355 T 0x19 R 0 Stat 0x0
[ 23.905846] usb-storage: scsi cmd done, result=0x0
[ 23.905852] usb-storage: *** thread sleeping.
[ 23.905905] usb-storage: queuecommand called
[ 23.905918] usb-storage: *** thread awakened.
[ 23.905923] usb-storage: Command READ_10 (10 bytes)
[ 23.905927] usb-storage: 28 00 00 ee f2 70 00 00 08 00
[ 23.905943] usb-storage: Bulk Command S 0x43425355 T 0x1a L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.905949] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.906079] usb-storage: Status code 0; transferred 31/31
[ 23.906086] usb-storage: -- transfer complete
[ 23.906091] usb-storage: Bulk command transfer result=0
[ 23.906097] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.906450] usb-storage: Status code 0; transferred 4096/4096
[ 23.906454] usb-storage: -- transfer complete
[ 23.906459] usb-storage: Bulk data transfer result 0x0
[ 23.906463] usb-storage: Attempting to get CSW...
[ 23.906468] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.906572] usb-storage: Status code 0; transferred 13/13
[ 23.906577] usb-storage: -- transfer complete
[ 23.906581] usb-storage: Bulk status result = 0
[ 23.906587] usb-storage: Bulk Status S 0x53425355 T 0x1a R 0 Stat 0x0
[ 23.906593] usb-storage: scsi cmd done, result=0x0
[ 23.906598] usb-storage: *** thread sleeping.
[ 23.907125] usb-storage: queuecommand called
[ 23.907146] usb-storage: *** thread awakened.
[ 23.907152] usb-storage: Command READ_10 (10 bytes)
[ 23.907156] usb-storage: 28 00 00 00 00 28 00 00 40 00
[ 23.907173] usb-storage: Bulk Command S 0x43425355 T 0x1b L 32768 F 128 Trg 0 LUN 0 CL 10
[ 23.907180] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.907333] usb-storage: Status code 0; transferred 31/31
[ 23.907338] usb-storage: -- transfer complete
[ 23.907343] usb-storage: Bulk command transfer result=0
[ 23.907349] usb-storage: usb_stor_bulk_transfer_sglist: xfer 32768 bytes, 3 entries
[ 23.909454] usb-storage: Status code 0; transferred 32768/32768
[ 23.909459] usb-storage: -- transfer complete
[ 23.909464] usb-storage: Bulk data transfer result 0x0
[ 23.909468] usb-storage: Attempting to get CSW...
[ 23.909473] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.909572] usb-storage: Status code 0; transferred 13/13
[ 23.909576] usb-storage: -- transfer complete
[ 23.909580] usb-storage: Bulk status result = 0
[ 23.909586] usb-storage: Bulk Status S 0x53425355 T 0x1b R 0 Stat 0x0
[ 23.909593] usb-storage: scsi cmd done, result=0x0
[ 23.909600] usb-storage: *** thread sleeping.
[ 23.914186] usb-storage: queuecommand called
[ 23.914221] usb-storage: *** thread awakened.
[ 23.914227] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.914232] usb-storage: 00 00 00 00 00 00
[ 23.914246] usb-storage: Bulk Command S 0x43425355 T 0x1c L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.914253] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.914342] usb-storage: Status code 0; transferred 31/31
[ 23.914348] usb-storage: -- transfer complete
[ 23.914352] usb-storage: Bulk command transfer result=0
[ 23.914357] usb-storage: Attempting to get CSW...
[ 23.914362] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.914575] usb-storage: Status code 0; transferred 13/13
[ 23.914580] usb-storage: -- transfer complete
[ 23.914584] usb-storage: Bulk status result = 0
[ 23.914590] usb-storage: Bulk Status S 0x53425355 T 0x1c R 0 Stat 0x0
[ 23.914599] usb-storage: scsi cmd done, result=0x0
[ 23.914607] usb-storage: *** thread sleeping.
[ 23.914683] usb-storage: queuecommand called
[ 23.914696] usb-storage: *** thread awakened.
[ 23.914702] usb-storage: Command INQUIRY (6 bytes)
[ 23.914706] usb-storage: 12 00 00 00 fe 00
[ 23.914718] usb-storage: Bulk Command S 0x43425355 T 0x1d L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.914725] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.914827] usb-storage: Status code 0; transferred 31/31
[ 23.914832] usb-storage: -- transfer complete
[ 23.914836] usb-storage: Bulk command transfer result=0
[ 23.914842] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.915077] usb-storage: Status code -121; transferred 36/254
[ 23.915082] usb-storage: -- short read transfer
[ 23.915087] usb-storage: Bulk data transfer result 0x1
[ 23.915091] usb-storage: Attempting to get CSW...
[ 23.915096] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.915323] usb-storage: Status code 0; transferred 13/13
[ 23.915328] usb-storage: -- transfer complete
[ 23.915332] usb-storage: Bulk status result = 0
[ 23.915338] usb-storage: Bulk Status S 0x53425355 T 0x1d R 218 Stat 0x0
[ 23.915344] usb-storage: scsi cmd done, result=0x0
[ 23.915350] usb-storage: *** thread sleeping.
[ 23.915541] usb-storage: queuecommand called
[ 23.915561] usb-storage: *** thread awakened.
[ 23.915567] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.915571] usb-storage: 00 00 00 00 00 00
[ 23.915583] usb-storage: Bulk Command S 0x43425355 T 0x1e L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.915590] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.915705] usb-storage: Status code 0; transferred 31/31
[ 23.915710] usb-storage: -- transfer complete
[ 23.915714] usb-storage: Bulk command transfer result=0
[ 23.915719] usb-storage: Attempting to get CSW...
[ 23.915724] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.915946] usb-storage: Status code 0; transferred 13/13
[ 23.915951] usb-storage: -- transfer complete
[ 23.915955] usb-storage: Bulk status result = 0
[ 23.915961] usb-storage: Bulk Status S 0x53425355 T 0x1e R 0 Stat 0x0
[ 23.915967] usb-storage: scsi cmd done, result=0x0
[ 23.915973] usb-storage: *** thread sleeping.
[ 23.916013] usb-storage: queuecommand called
[ 23.916027] usb-storage: *** thread awakened.
[ 23.916032] usb-storage: Command INQUIRY (6 bytes)
[ 23.916036] usb-storage: 12 01 00 00 fe 00
[ 23.916048] usb-storage: Bulk Command S 0x43425355 T 0x1f L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.916055] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.916201] usb-storage: Status code 0; transferred 31/31
[ 23.916206] usb-storage: -- transfer complete
[ 23.916210] usb-storage: Bulk command transfer result=0
[ 23.916217] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.916452] usb-storage: Status code -121; transferred 36/254
[ 23.916457] usb-storage: -- short read transfer
[ 23.916462] usb-storage: Bulk data transfer result 0x1
[ 23.916466] usb-storage: Attempting to get CSW...
[ 23.916471] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.916696] usb-storage: Status code 0; transferred 13/13
[ 23.916701] usb-storage: -- transfer complete
[ 23.916705] usb-storage: Bulk status result = 0
[ 23.916712] usb-storage: Bulk Status S 0x53425355 T 0x1f R 218 Stat 0x0
[ 23.916717] usb-storage: scsi cmd done, result=0x0
[ 23.916723] usb-storage: *** thread sleeping.
[ 23.930643] usb-storage: queuecommand called
[ 23.930675] usb-storage: *** thread awakened.
[ 23.930681] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.930686] usb-storage: 00 00 00 00 00 00
[ 23.930702] usb-storage: Bulk Command S 0x43425355 T 0x20 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.930709] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.930838] usb-storage: Status code 0; transferred 31/31
[ 23.930843] usb-storage: -- transfer complete
[ 23.930848] usb-storage: Bulk command transfer result=0
[ 23.930853] usb-storage: Attempting to get CSW...
[ 23.930858] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.930953] usb-storage: Status code 0; transferred 13/13
[ 23.930958] usb-storage: -- transfer complete
[ 23.930963] usb-storage: Bulk status result = 0
[ 23.930969] usb-storage: Bulk Status S 0x53425355 T 0x20 R 0 Stat 0x0
[ 23.930975] usb-storage: scsi cmd done, result=0x0
[ 23.930983] usb-storage: *** thread sleeping.
[ 23.933452] usb-storage: queuecommand called
[ 23.933477] usb-storage: *** thread awakened.
[ 23.933484] usb-storage: Command READ_10 (10 bytes)
[ 23.933488] usb-storage: 28 00 00 d2 4d be 00 00 08 00
[ 23.933508] usb-storage: Bulk Command S 0x43425355 T 0x21 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.933516] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.933585] usb-storage: Status code 0; transferred 31/31
[ 23.933590] usb-storage: -- transfer complete
[ 23.933594] usb-storage: Bulk command transfer result=0
[ 23.933604] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.934345] usb-storage: Status code 0; transferred 4096/4096
[ 23.934352] usb-storage: -- transfer complete
[ 23.934358] usb-storage: Bulk data transfer result 0x0
[ 23.934362] usb-storage: Attempting to get CSW...
[ 23.934367] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.934446] usb-storage: Status code 0; transferred 13/13
[ 23.934451] usb-storage: -- transfer complete
[ 23.934455] usb-storage: Bulk status result = 0
[ 23.934461] usb-storage: Bulk Status S 0x53425355 T 0x21 R 0 Stat 0x0
[ 23.934469] usb-storage: scsi cmd done, result=0x0
[ 23.934478] usb-storage: *** thread sleeping.
[ 23.934644] usb-storage: queuecommand called
[ 23.934665] usb-storage: *** thread awakened.
[ 23.934671] usb-storage: Command READ_10 (10 bytes)
[ 23.934675] usb-storage: 28 00 00 00 00 3e 00 00 08 00
[ 23.934694] usb-storage: Bulk Command S 0x43425355 T 0x22 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.934701] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.934828] usb-storage: Status code 0; transferred 31/31
[ 23.934833] usb-storage: -- transfer complete
[ 23.934837] usb-storage: Bulk command transfer result=0
[ 23.934844] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.935467] usb-storage: Status code 0; transferred 4096/4096
[ 23.935473] usb-storage: -- transfer complete
[ 23.935478] usb-storage: Bulk data transfer result 0x0
[ 23.935483] usb-storage: Attempting to get CSW...
[ 23.935488] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.935577] usb-storage: Status code 0; transferred 13/13
[ 23.935586] usb-storage: -- transfer complete
[ 23.935590] usb-storage: Bulk status result = 0
[ 23.935596] usb-storage: Bulk Status S 0x53425355 T 0x22 R 0 Stat 0x0
[ 23.935603] usb-storage: scsi cmd done, result=0x0
[ 23.935610] usb-storage: *** thread sleeping.
[ 23.935643] usb-storage: queuecommand called
[ 23.935799] usb-storage: *** thread awakened.
[ 23.935808] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.935813] usb-storage: 00 00 00 00 00 00
[ 23.935825] usb-storage: Bulk Command S 0x43425355 T 0x23 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.935832] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.935959] usb-storage: Status code 0; transferred 31/31
[ 23.935964] usb-storage: -- transfer complete
[ 23.935968] usb-storage: Bulk command transfer result=0
[ 23.935973] usb-storage: Attempting to get CSW...
[ 23.935978] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.936196] usb-storage: Status code 0; transferred 13/13
[ 23.936200] usb-storage: -- transfer complete
[ 23.936204] usb-storage: Bulk status result = 0
[ 23.936210] usb-storage: Bulk Status S 0x53425355 T 0x23 R 0 Stat 0x0
[ 23.936216] usb-storage: scsi cmd done, result=0x0
[ 23.936223] usb-storage: *** thread sleeping.
[ 23.936242] usb-storage: queuecommand called
[ 23.936251] usb-storage: *** thread awakened.
[ 23.936256] usb-storage: Command READ_10 (10 bytes)
[ 23.936260] usb-storage: 28 00 00 00 00 46 00 00 20 00
[ 23.936278] usb-storage: Bulk Command S 0x43425355 T 0x24 L 16384 F 128 Trg 0 LUN 0 CL 10
[ 23.936284] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.936324] usb-storage: Status code 0; transferred 31/31
[ 23.936328] usb-storage: -- transfer complete
[ 23.936333] usb-storage: Bulk command transfer result=0
[ 23.936342] usb-storage: usb_stor_bulk_transfer_sglist: xfer 16384 bytes, 2 entries
[ 23.937573] usb-storage: Status code 0; transferred 16384/16384
[ 23.937579] usb-storage: -- transfer complete
[ 23.937584] usb-storage: Bulk data transfer result 0x0
[ 23.937588] usb-storage: Attempting to get CSW...
[ 23.937593] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.937693] usb-storage: Status code 0; transferred 13/13
[ 23.937697] usb-storage: -- transfer complete
[ 23.937702] usb-storage: Bulk status result = 0
[ 23.937707] usb-storage: Bulk Status S 0x53425355 T 0x24 R 0 Stat 0x0
[ 23.937713] usb-storage: scsi cmd done, result=0x0
[ 23.937719] usb-storage: *** thread sleeping.
[ 23.937748] usb-storage: queuecommand called
[ 23.937825] usb-storage: *** thread awakened.
[ 23.937833] usb-storage: Command INQUIRY (6 bytes)
[ 23.937837] usb-storage: 12 00 00 00 fe 00
[ 23.937849] usb-storage: Bulk Command S 0x43425355 T 0x25 L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.937856] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.937951] usb-storage: Status code 0; transferred 31/31
[ 23.937955] usb-storage: -- transfer complete
[ 23.937960] usb-storage: Bulk command transfer result=0
[ 23.937966] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.938198] usb-storage: Status code -121; transferred 36/254
[ 23.938203] usb-storage: -- short read transfer
[ 23.938207] usb-storage: Bulk data transfer result 0x1
[ 23.938212] usb-storage: Attempting to get CSW...
[ 23.938217] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.938443] usb-storage: Status code 0; transferred 13/13
[ 23.938448] usb-storage: -- transfer complete
[ 23.938452] usb-storage: Bulk status result = 0
[ 23.938458] usb-storage: Bulk Status S 0x53425355 T 0x25 R 218 Stat 0x0
[ 23.938464] usb-storage: scsi cmd done, result=0x0
[ 23.938470] usb-storage: *** thread sleeping.
[ 23.938489] usb-storage: queuecommand called
[ 23.938498] usb-storage: *** thread awakened.
[ 23.938503] usb-storage: Command READ_10 (10 bytes)
[ 23.938507] usb-storage: 28 00 00 d2 4e 46 00 00 02 00
[ 23.938522] usb-storage: Bulk Command S 0x43425355 T 0x26 L 1024 F 128 Trg 0 LUN 0 CL 10
[ 23.938529] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.938625] usb-storage: Status code 0; transferred 31/31
[ 23.938630] usb-storage: -- transfer complete
[ 23.938635] usb-storage: Bulk command transfer result=0
[ 23.938641] usb-storage: usb_stor_bulk_transfer_sglist: xfer 1024 bytes, 1 entries
[ 23.939081] usb-storage: Status code 0; transferred 1024/1024
[ 23.939087] usb-storage: -- transfer complete
[ 23.939092] usb-storage: Bulk data transfer result 0x0
[ 23.939096] usb-storage: Attempting to get CSW...
[ 23.939101] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.939194] usb-storage: Status code 0; transferred 13/13
[ 23.939199] usb-storage: -- transfer complete
[ 23.939203] usb-storage: Bulk status result = 0
[ 23.939209] usb-storage: Bulk Status S 0x53425355 T 0x26 R 0 Stat 0x0
[ 23.939215] usb-storage: scsi cmd done, result=0x0
[ 23.939222] usb-storage: *** thread sleeping.
[ 23.939248] usb-storage: queuecommand called
[ 23.939380] usb-storage: *** thread awakened.
[ 23.939388] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.939392] usb-storage: 00 00 00 00 00 00
[ 23.939404] usb-storage: Bulk Command S 0x43425355 T 0x27 L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.939411] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.939576] usb-storage: Status code 0; transferred 31/31
[ 23.939580] usb-storage: -- transfer complete
[ 23.939585] usb-storage: Bulk command transfer result=0
[ 23.939589] usb-storage: Attempting to get CSW...
[ 23.939594] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.939817] usb-storage: Status code 0; transferred 13/13
[ 23.939822] usb-storage: -- transfer complete
[ 23.939826] usb-storage: Bulk status result = 0
[ 23.939832] usb-storage: Bulk Status S 0x53425355 T 0x27 R 0 Stat 0x0
[ 23.939838] usb-storage: scsi cmd done, result=0x0
[ 23.939844] usb-storage: *** thread sleeping.
[ 23.939858] usb-storage: queuecommand called
[ 23.939866] usb-storage: *** thread awakened.
[ 23.939872] usb-storage: Command READ_10 (10 bytes)
[ 23.939876] usb-storage: 28 00 00 d2 4e 06 00 00 08 00
[ 23.939891] usb-storage: Bulk Command S 0x43425355 T 0x28 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.939898] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.939950] usb-storage: Status code 0; transferred 31/31
[ 23.939955] usb-storage: -- transfer complete
[ 23.939959] usb-storage: Bulk command transfer result=0
[ 23.939965] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.940446] usb-storage: Status code 0; transferred 4096/4096
[ 23.940451] usb-storage: -- transfer complete
[ 23.940455] usb-storage: Bulk data transfer result 0x0
[ 23.940460] usb-storage: Attempting to get CSW...
[ 23.940465] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.940569] usb-storage: Status code 0; transferred 13/13
[ 23.940574] usb-storage: -- transfer complete
[ 23.940578] usb-storage: Bulk status result = 0
[ 23.940584] usb-storage: Bulk Status S 0x53425355 T 0x28 R 0 Stat 0x0
[ 23.940590] usb-storage: scsi cmd done, result=0x0
[ 23.940597] usb-storage: *** thread sleeping.
[ 23.940616] usb-storage: queuecommand called
[ 23.940679] usb-storage: *** thread awakened.
[ 23.940686] usb-storage: Command INQUIRY (6 bytes)
[ 23.940690] usb-storage: 12 01 00 00 fe 00
[ 23.940702] usb-storage: Bulk Command S 0x43425355 T 0x29 L 254 F 128 Trg 0 LUN 0 CL 6
[ 23.940709] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.940827] usb-storage: Status code 0; transferred 31/31
[ 23.940832] usb-storage: -- transfer complete
[ 23.940836] usb-storage: Bulk command transfer result=0
[ 23.940842] usb-storage: usb_stor_bulk_transfer_sglist: xfer 254 bytes, 1 entries
[ 23.941073] usb-storage: Status code -121; transferred 36/254
[ 23.941078] usb-storage: -- short read transfer
[ 23.941083] usb-storage: Bulk data transfer result 0x1
[ 23.941087] usb-storage: Attempting to get CSW...
[ 23.941092] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.941318] usb-storage: Status code 0; transferred 13/13
[ 23.941322] usb-storage: -- transfer complete
[ 23.941326] usb-storage: Bulk status result = 0
[ 23.941332] usb-storage: Bulk Status S 0x53425355 T 0x29 R 218 Stat 0x0
[ 23.941338] usb-storage: scsi cmd done, result=0x0
[ 23.941344] usb-storage: *** thread sleeping.
[ 23.941362] usb-storage: queuecommand called
[ 23.941370] usb-storage: *** thread awakened.
[ 23.941375] usb-storage: Command READ_10 (10 bytes)
[ 23.941379] usb-storage: 28 00 00 d2 4d 46 00 00 08 00
[ 23.941395] usb-storage: Bulk Command S 0x43425355 T 0x2a L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.941401] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.941450] usb-storage: Status code 0; transferred 31/31
[ 23.941458] usb-storage: -- transfer complete
[ 23.941462] usb-storage: Bulk command transfer result=0
[ 23.941469] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.941963] usb-storage: Status code 0; transferred 4096/4096
[ 23.941969] usb-storage: -- transfer complete
[ 23.941974] usb-storage: Bulk data transfer result 0x0
[ 23.941979] usb-storage: Attempting to get CSW...
[ 23.941984] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.942070] usb-storage: Status code 0; transferred 13/13
[ 23.942075] usb-storage: -- transfer complete
[ 23.942079] usb-storage: Bulk status result = 0
[ 23.942085] usb-storage: Bulk Status S 0x53425355 T 0x2a R 0 Stat 0x0
[ 23.942091] usb-storage: scsi cmd done, result=0x0
[ 23.942098] usb-storage: *** thread sleeping.
[ 23.942217] usb-storage: queuecommand called
[ 23.942232] usb-storage: *** thread awakened.
[ 23.942238] usb-storage: Command READ_10 (10 bytes)
[ 23.942242] usb-storage: 28 00 00 d2 4e 36 00 00 08 00
[ 23.942258] usb-storage: Bulk Command S 0x43425355 T 0x2b L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.942265] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.942326] usb-storage: Status code 0; transferred 31/31
[ 23.942330] usb-storage: -- transfer complete
[ 23.942335] usb-storage: Bulk command transfer result=0
[ 23.942341] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.942840] usb-storage: Status code 0; transferred 4096/4096
[ 23.942847] usb-storage: -- transfer complete
[ 23.942852] usb-storage: Bulk data transfer result 0x0
[ 23.942857] usb-storage: Attempting to get CSW...
[ 23.942862] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.942948] usb-storage: Status code 0; transferred 13/13
[ 23.942953] usb-storage: -- transfer complete
[ 23.942957] usb-storage: Bulk status result = 0
[ 23.942963] usb-storage: Bulk Status S 0x53425355 T 0x2b R 0 Stat 0x0
[ 23.942973] usb-storage: scsi cmd done, result=0x0
[ 23.942981] usb-storage: *** thread sleeping.
[ 23.943094] usb-storage: queuecommand called
[ 23.943113] usb-storage: *** thread awakened.
[ 23.943119] usb-storage: Command READ_10 (10 bytes)
[ 23.943123] usb-storage: 28 00 00 d2 4c b6 00 00 08 00
[ 23.943141] usb-storage: Bulk Command S 0x43425355 T 0x2c L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.943148] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.943199] usb-storage: Status code 0; transferred 31/31
[ 23.943204] usb-storage: -- transfer complete
[ 23.943208] usb-storage: Bulk command transfer result=0
[ 23.943214] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.943718] usb-storage: Status code 0; transferred 4096/4096
[ 23.943725] usb-storage: -- transfer complete
[ 23.943732] usb-storage: Bulk data transfer result 0x0
[ 23.943736] usb-storage: Attempting to get CSW...
[ 23.943741] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.943820] usb-storage: Status code 0; transferred 13/13
[ 23.943825] usb-storage: -- transfer complete
[ 23.943830] usb-storage: Bulk status result = 0
[ 23.943836] usb-storage: Bulk Status S 0x53425355 T 0x2c R 0 Stat 0x0
[ 23.943843] usb-storage: scsi cmd done, result=0x0
[ 23.943850] usb-storage: *** thread sleeping.
[ 23.944526] usb-storage: queuecommand called
[ 23.944550] usb-storage: *** thread awakened.
[ 23.944557] usb-storage: Command READ_10 (10 bytes)
[ 23.944561] usb-storage: 28 00 00 00 00 66 00 00 40 00
[ 23.944578] usb-storage: Bulk Command S 0x43425355 T 0x2d L 32768 F 128 Trg 0 LUN 0 CL 10
[ 23.944585] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.944708] usb-storage: Status code 0; transferred 31/31
[ 23.944714] usb-storage: -- transfer complete
[ 23.944720] usb-storage: Bulk command transfer result=0
[ 23.944727] usb-storage: usb_stor_bulk_transfer_sglist: xfer 32768 bytes, 3 entries
[ 23.946707] usb-storage: Status code 0; transferred 32768/32768
[ 23.946712] usb-storage: -- transfer complete
[ 23.946717] usb-storage: Bulk data transfer result 0x0
[ 23.946722] usb-storage: Attempting to get CSW...
[ 23.946727] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.946818] usb-storage: Status code 0; transferred 13/13
[ 23.946823] usb-storage: -- transfer complete
[ 23.946827] usb-storage: Bulk status result = 0
[ 23.946833] usb-storage: Bulk Status S 0x53425355 T 0x2d R 0 Stat 0x0
[ 23.946840] usb-storage: scsi cmd done, result=0x0
[ 23.946847] usb-storage: *** thread sleeping.
[ 23.946905] usb-storage: queuecommand called
[ 23.946943] usb-storage: *** thread awakened.
[ 23.946948] usb-storage: Command TEST_UNIT_READY (6 bytes)
[ 23.946953] usb-storage: 00 00 00 00 00 00
[ 23.946967] usb-storage: Bulk Command S 0x43425355 T 0x2e L 0 F 0 Trg 0 LUN 0 CL 6
[ 23.946974] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.947076] usb-storage: Status code 0; transferred 31/31
[ 23.947080] usb-storage: -- transfer complete
[ 23.947085] usb-storage: Bulk command transfer result=0
[ 23.947089] usb-storage: Attempting to get CSW...
[ 23.947094] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.947317] usb-storage: Status code 0; transferred 13/13
[ 23.947322] usb-storage: -- transfer complete
[ 23.947326] usb-storage: Bulk status result = 0
[ 23.947332] usb-storage: Bulk Status S 0x53425355 T 0x2e R 0 Stat 0x0
[ 23.947337] usb-storage: scsi cmd done, result=0x0
[ 23.947343] usb-storage: *** thread sleeping.
[ 23.950389] usb-storage: queuecommand called
[ 23.950411] usb-storage: *** thread awakened.
[ 23.950417] usb-storage: Command READ_10 (10 bytes)
[ 23.950422] usb-storage: 28 00 00 ee cf c8 00 00 08 00
[ 23.950439] usb-storage: Bulk Command S 0x43425355 T 0x2f L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.950447] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.950583] usb-storage: Status code 0; transferred 31/31
[ 23.950588] usb-storage: -- transfer complete
[ 23.950593] usb-storage: Bulk command transfer result=0
[ 23.950599] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.951199] usb-storage: Status code 0; transferred 4096/4096
[ 23.951203] usb-storage: -- transfer complete
[ 23.951208] usb-storage: Bulk data transfer result 0x0
[ 23.951212] usb-storage: Attempting to get CSW...
[ 23.951217] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.951319] usb-storage: Status code 0; transferred 13/13
[ 23.951323] usb-storage: -- transfer complete
[ 23.951328] usb-storage: Bulk status result = 0
[ 23.951333] usb-storage: Bulk Status S 0x53425355 T 0x2f R 0 Stat 0x0
[ 23.951340] usb-storage: scsi cmd done, result=0x0
[ 23.951348] usb-storage: *** thread sleeping.
[ 23.951463] usb-storage: queuecommand called
[ 23.951480] usb-storage: *** thread awakened.
[ 23.951486] usb-storage: Command READ_10 (10 bytes)
[ 23.951490] usb-storage: 28 00 00 d2 4e 48 00 00 08 00
[ 23.951505] usb-storage: Bulk Command S 0x43425355 T 0x30 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.951512] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.951575] usb-storage: Status code 0; transferred 31/31
[ 23.951579] usb-storage: -- transfer complete
[ 23.951584] usb-storage: Bulk command transfer result=0
[ 23.951590] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.952069] usb-storage: Status code 0; transferred 4096/4096
[ 23.952074] usb-storage: -- transfer complete
[ 23.952078] usb-storage: Bulk data transfer result 0x0
[ 23.952082] usb-storage: Attempting to get CSW...
[ 23.952087] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.952192] usb-storage: Status code 0; transferred 13/13
[ 23.952196] usb-storage: -- transfer complete
[ 23.952201] usb-storage: Bulk status result = 0
[ 23.952206] usb-storage: Bulk Status S 0x53425355 T 0x30 R 0 Stat 0x0
[ 23.952212] usb-storage: scsi cmd done, result=0x0
[ 23.952218] usb-storage: *** thread sleeping.
[ 23.952319] usb-storage: queuecommand called
[ 23.952336] usb-storage: *** thread awakened.
[ 23.952341] usb-storage: Command READ_10 (10 bytes)
[ 23.952345] usb-storage: 28 00 00 d2 4e 50 00 00 20 00
[ 23.952361] usb-storage: Bulk Command S 0x43425355 T 0x31 L 16384 F 128 Trg 0 LUN 0 CL 10
[ 23.952368] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.952447] usb-storage: Status code 0; transferred 31/31
[ 23.952452] usb-storage: -- transfer complete
[ 23.952456] usb-storage: Bulk command transfer result=0
[ 23.952462] usb-storage: usb_stor_bulk_transfer_sglist: xfer 16384 bytes, 1 entries
[ 23.953443] usb-storage: Status code 0; transferred 16384/16384
[ 23.953448] usb-storage: -- transfer complete
[ 23.953452] usb-storage: Bulk data transfer result 0x0
[ 23.953457] usb-storage: Attempting to get CSW...
[ 23.953462] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.953567] usb-storage: Status code 0; transferred 13/13
[ 23.953571] usb-storage: -- transfer complete
[ 23.953576] usb-storage: Bulk status result = 0
[ 23.953581] usb-storage: Bulk Status S 0x53425355 T 0x31 R 0 Stat 0x0
[ 23.953587] usb-storage: scsi cmd done, result=0x0
[ 23.953596] usb-storage: *** thread sleeping.
[ 23.953680] usb-storage: queuecommand called
[ 23.953699] usb-storage: *** thread awakened.
[ 23.953704] usb-storage: Command READ_10 (10 bytes)
[ 23.953708] usb-storage: 28 00 00 ee d0 58 00 00 04 00
[ 23.953723] usb-storage: Bulk Command S 0x43425355 T 0x32 L 2048 F 128 Trg 0 LUN 0 CL 10
[ 23.953730] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.953823] usb-storage: Status code 0; transferred 31/31
[ 23.953827] usb-storage: -- transfer complete
[ 23.953832] usb-storage: Bulk command transfer result=0
[ 23.953838] usb-storage: usb_stor_bulk_transfer_sglist: xfer 2048 bytes, 1 entries
[ 23.954193] usb-storage: Status code 0; transferred 2048/2048
[ 23.954198] usb-storage: -- transfer complete
[ 23.954202] usb-storage: Bulk data transfer result 0x0
[ 23.954207] usb-storage: Attempting to get CSW...
[ 23.954212] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.954318] usb-storage: Status code 0; transferred 13/13
[ 23.954323] usb-storage: -- transfer complete
[ 23.954327] usb-storage: Bulk status result = 0
[ 23.954333] usb-storage: Bulk Status S 0x53425355 T 0x32 R 0 Stat 0x0
[ 23.954339] usb-storage: scsi cmd done, result=0x0
[ 23.954345] usb-storage: *** thread sleeping.
[ 23.954461] usb-storage: queuecommand called
[ 23.954477] usb-storage: *** thread awakened.
[ 23.954482] usb-storage: Command READ_10 (10 bytes)
[ 23.954486] usb-storage: 28 00 00 ee d0 18 00 00 08 00
[ 23.954501] usb-storage: Bulk Command S 0x43425355 T 0x33 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.954508] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.954572] usb-storage: Status code 0; transferred 31/31
[ 23.954576] usb-storage: -- transfer complete
[ 23.954581] usb-storage: Bulk command transfer result=0
[ 23.954587] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.955066] usb-storage: Status code 0; transferred 4096/4096
[ 23.955071] usb-storage: -- transfer complete
[ 23.955075] usb-storage: Bulk data transfer result 0x0
[ 23.955079] usb-storage: Attempting to get CSW...
[ 23.955084] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.955191] usb-storage: Status code 0; transferred 13/13
[ 23.955195] usb-storage: -- transfer complete
[ 23.955200] usb-storage: Bulk status result = 0
[ 23.955205] usb-storage: Bulk Status S 0x53425355 T 0x33 R 0 Stat 0x0
[ 23.955211] usb-storage: scsi cmd done, result=0x0
[ 23.955217] usb-storage: *** thread sleeping.
[ 23.955278] usb-storage: queuecommand called
[ 23.955293] usb-storage: *** thread awakened.
[ 23.955298] usb-storage: Command READ_10 (10 bytes)
[ 23.955302] usb-storage: 28 00 00 ee cf 58 00 00 08 00
[ 23.955318] usb-storage: Bulk Command S 0x43425355 T 0x34 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.955324] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.955448] usb-storage: Status code 0; transferred 31/31
[ 23.955453] usb-storage: -- transfer complete
[ 23.955457] usb-storage: Bulk command transfer result=0
[ 23.955463] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.955817] usb-storage: Status code 0; transferred 4096/4096
[ 23.955821] usb-storage: -- transfer complete
[ 23.955826] usb-storage: Bulk data transfer result 0x0
[ 23.955830] usb-storage: Attempting to get CSW...
[ 23.955835] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.955942] usb-storage: Status code 0; transferred 13/13
[ 23.955947] usb-storage: -- transfer complete
[ 23.955951] usb-storage: Bulk status result = 0
[ 23.955957] usb-storage: Bulk Status S 0x53425355 T 0x34 R 0 Stat 0x0
[ 23.955963] usb-storage: scsi cmd done, result=0x0
[ 23.955968] usb-storage: *** thread sleeping.
[ 23.956032] usb-storage: queuecommand called
[ 23.956047] usb-storage: *** thread awakened.
[ 23.956052] usb-storage: Command READ_10 (10 bytes)
[ 23.956056] usb-storage: 28 00 00 ee d0 48 00 00 08 00
[ 23.956073] usb-storage: Bulk Command S 0x43425355 T 0x35 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.956079] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.956195] usb-storage: Status code 0; transferred 31/31
[ 23.956200] usb-storage: -- transfer complete
[ 23.956204] usb-storage: Bulk command transfer result=0
[ 23.956210] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.956566] usb-storage: Status code 0; transferred 4096/4096
[ 23.956571] usb-storage: -- transfer complete
[ 23.956575] usb-storage: Bulk data transfer result 0x0
[ 23.956580] usb-storage: Attempting to get CSW...
[ 23.956585] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.956690] usb-storage: Status code 0; transferred 13/13
[ 23.956695] usb-storage: -- transfer complete
[ 23.956699] usb-storage: Bulk status result = 0
[ 23.956705] usb-storage: Bulk Status S 0x53425355 T 0x35 R 0 Stat 0x0
[ 23.956711] usb-storage: scsi cmd done, result=0x0
[ 23.956716] usb-storage: *** thread sleeping.
[ 23.956771] usb-storage: queuecommand called
[ 23.956785] usb-storage: *** thread awakened.
[ 23.956790] usb-storage: Command READ_10 (10 bytes)
[ 23.956794] usb-storage: 28 00 00 ee ce c8 00 00 08 00
[ 23.956809] usb-storage: Bulk Command S 0x43425355 T 0x36 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.956816] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.956945] usb-storage: Status code 0; transferred 31/31
[ 23.956950] usb-storage: -- transfer complete
[ 23.956954] usb-storage: Bulk command transfer result=0
[ 23.956960] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.957315] usb-storage: Status code 0; transferred 4096/4096
[ 23.957320] usb-storage: -- transfer complete
[ 23.957324] usb-storage: Bulk data transfer result 0x0
[ 23.957329] usb-storage: Attempting to get CSW...
[ 23.957334] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.957440] usb-storage: Status code 0; transferred 13/13
[ 23.957444] usb-storage: -- transfer complete
[ 23.957448] usb-storage: Bulk status result = 0
[ 23.957456] usb-storage: Bulk Status S 0x53425355 T 0x36 R 0 Stat 0x0
[ 23.957462] usb-storage: scsi cmd done, result=0x0
[ 23.957468] usb-storage: *** thread sleeping.
[ 23.957529] usb-storage: queuecommand called
[ 23.957544] usb-storage: *** thread awakened.
[ 23.957549] usb-storage: Command READ_10 (10 bytes)
[ 23.957553] usb-storage: 28 00 00 ee d0 50 00 00 08 00
[ 23.957569] usb-storage: Bulk Command S 0x43425355 T 0x37 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.957575] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.957699] usb-storage: Status code 0; transferred 31/31
[ 23.957704] usb-storage: -- transfer complete
[ 23.957708] usb-storage: Bulk command transfer result=0
[ 23.957714] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.958067] usb-storage: Status code 0; transferred 4096/4096
[ 23.958071] usb-storage: -- transfer complete
[ 23.958076] usb-storage: Bulk data transfer result 0x0
[ 23.958080] usb-storage: Attempting to get CSW...
[ 23.958085] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.958190] usb-storage: Status code 0; transferred 13/13
[ 23.958195] usb-storage: -- transfer complete
[ 23.958199] usb-storage: Bulk status result = 0
[ 23.958205] usb-storage: Bulk Status S 0x53425355 T 0x37 R 0 Stat 0x0
[ 23.958211] usb-storage: scsi cmd done, result=0x0
[ 23.958216] usb-storage: *** thread sleeping.
[ 23.958543] usb-storage: queuecommand called
[ 23.958563] usb-storage: *** thread awakened.
[ 23.958611] usb-storage: Command READ_10 (10 bytes)
[ 23.958616] usb-storage: 28 00 00 d2 4e 70 00 00 c0 00
[ 23.958632] usb-storage: Bulk Command S 0x43425355 T 0x38 L 98304 F 128 Trg 0 LUN 0 CL 10
[ 23.958638] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.958696] usb-storage: Status code 0; transferred 31/31
[ 23.958700] usb-storage: -- transfer complete
[ 23.958705] usb-storage: Bulk command transfer result=0
[ 23.958711] usb-storage: usb_stor_bulk_transfer_sglist: xfer 98304 bytes, 4 entries
[ 23.963825] usb-storage: Status code 0; transferred 98304/98304
[ 23.963829] usb-storage: -- transfer complete
[ 23.963834] usb-storage: Bulk data transfer result 0x0
[ 23.963838] usb-storage: Attempting to get CSW...
[ 23.963843] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.963941] usb-storage: Status code 0; transferred 13/13
[ 23.963945] usb-storage: -- transfer complete
[ 23.963950] usb-storage: Bulk status result = 0
[ 23.963956] usb-storage: Bulk Status S 0x53425355 T 0x38 R 0 Stat 0x0
[ 23.963962] usb-storage: scsi cmd done, result=0x0
[ 23.963968] usb-storage: *** thread sleeping.
[ 23.964532] usb-storage: queuecommand called
[ 23.964557] usb-storage: *** thread awakened.
[ 23.964563] usb-storage: Command READ_10 (10 bytes)
[ 23.964567] usb-storage: 28 00 00 d2 4f 30 00 00 f0 00
[ 23.964585] usb-storage: Bulk Command S 0x43425355 T 0x39 L 122880 F 128 Trg 0 LUN 0 CL 10
[ 23.964593] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.964698] usb-storage: Status code 0; transferred 31/31
[ 23.964703] usb-storage: -- transfer complete
[ 23.964707] usb-storage: Bulk command transfer result=0
[ 23.964715] usb-storage: usb_stor_bulk_transfer_sglist: xfer 122880 bytes, 2 entries
[ 23.971069] usb-storage: Status code 0; transferred 122880/122880
[ 23.971074] usb-storage: -- transfer complete
[ 23.971079] usb-storage: Bulk data transfer result 0x0
[ 23.971083] usb-storage: Attempting to get CSW...
[ 23.971088] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.971188] usb-storage: Status code 0; transferred 13/13
[ 23.971193] usb-storage: -- transfer complete
[ 23.971197] usb-storage: Bulk status result = 0
[ 23.971203] usb-storage: Bulk Status S 0x53425355 T 0x39 R 0 Stat 0x0
[ 23.971209] usb-storage: scsi cmd done, result=0x0
[ 23.971216] usb-storage: *** thread sleeping.
[ 23.971283] usb-storage: queuecommand called
[ 23.971296] usb-storage: *** thread awakened.
[ 23.971301] usb-storage: Command READ_10 (10 bytes)
[ 23.971305] usb-storage: 28 00 00 d2 50 20 00 00 10 00
[ 23.971320] usb-storage: Bulk Command S 0x43425355 T 0x3a L 8192 F 128 Trg 0 LUN 0 CL 10
[ 23.971327] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.971443] usb-storage: Status code 0; transferred 31/31
[ 23.971448] usb-storage: -- transfer complete
[ 23.971452] usb-storage: Bulk command transfer result=0
[ 23.971458] usb-storage: usb_stor_bulk_transfer_sglist: xfer 8192 bytes, 1 entries
[ 23.972065] usb-storage: Status code 0; transferred 8192/8192
[ 23.972070] usb-storage: -- transfer complete
[ 23.972074] usb-storage: Bulk data transfer result 0x0
[ 23.972078] usb-storage: Attempting to get CSW...
[ 23.972083] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.972189] usb-storage: Status code 0; transferred 13/13
[ 23.972194] usb-storage: -- transfer complete
[ 23.972198] usb-storage: Bulk status result = 0
[ 23.972204] usb-storage: Bulk Status S 0x53425355 T 0x3a R 0 Stat 0x0
[ 23.972209] usb-storage: scsi cmd done, result=0x0
[ 23.972215] usb-storage: *** thread sleeping.
[ 23.972230] usb-storage: queuecommand called
[ 23.972238] usb-storage: *** thread awakened.
[ 23.972243] usb-storage: Command READ_10 (10 bytes)
[ 23.972247] usb-storage: 28 00 00 d2 50 48 00 00 08 00
[ 23.972263] usb-storage: Bulk Command S 0x43425355 T 0x3b L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.972270] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.972317] usb-storage: Status code 0; transferred 31/31
[ 23.972322] usb-storage: -- transfer complete
[ 23.972326] usb-storage: Bulk command transfer result=0
[ 23.972332] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.972814] usb-storage: Status code 0; transferred 4096/4096
[ 23.972819] usb-storage: -- transfer complete
[ 23.972823] usb-storage: Bulk data transfer result 0x0
[ 23.972828] usb-storage: Attempting to get CSW...
[ 23.972833] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.972938] usb-storage: Status code 0; transferred 13/13
[ 23.972943] usb-storage: -- transfer complete
[ 23.972947] usb-storage: Bulk status result = 0
[ 23.972953] usb-storage: Bulk Status S 0x53425355 T 0x3b R 0 Stat 0x0
[ 23.972958] usb-storage: scsi cmd done, result=0x0
[ 23.972964] usb-storage: *** thread sleeping.
[ 24.464229] fuse init (API version 7.9)
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 1:18 ` Sergey Dolgov
@ 2008-04-01 1:58 ` Alan Stern
2008-04-01 7:38 ` Oliver Neukum
0 siblings, 1 reply; 18+ messages in thread
From: Alan Stern @ 2008-04-01 1:58 UTC (permalink / raw)
To: Sergey Dolgov; +Cc: linux-kernel, linux-usb
On Tue, 1 Apr 2008, Sergey Dolgov wrote:
> On Mon, Mar 31, 2008 at 02:32:12AM +0400, Sergey Dolgov wrote:
> > On Sun, Mar 30, 2008 at 02:59:49PM -0400, Alan Stern wrote:
> > > On Sun, 30 Mar 2008, Sergey Dolgov wrote:
> > >
> > > Can you build both 2.6.24.4 and 2.6.25-rc7 with
> > > CONFIG_USB_STORAGE_DEBUG enabled, and post the dmesg logs from both
> > > kernels showing what happens when the SDHC card is probed during boot?
> > > Comparing the two logs should indicate where the crucial difference
> > > lies.
> >
> > The dmesg output for 2.6.25-rc7 with USB storage debugging enabled is
> > attached. I hope to produce the same for 2.6.24.4 on Monday.
> >
>
> Here goes...
The difference is interesting. Here's the version that works:
[ 23.902571] usb-storage: Command READ_10 (10 bytes)
[ 23.902575] usb-storage: 28 00 00 ee f3 f8 00 00 08 00
[ 23.902591] usb-storage: Bulk Command S 0x43425355 T 0x16 L 4096 F 128 Trg 0 LUN 0 CL 10
[ 23.902598] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 23.902704] usb-storage: Status code 0; transferred 31/31
[ 23.902709] usb-storage: -- transfer complete
[ 23.902713] usb-storage: Bulk command transfer result=0
[ 23.902720] usb-storage: usb_stor_bulk_transfer_sglist: xfer 4096 bytes, 1 entries
[ 23.903337] usb-storage: Status code 0; transferred 4096/4096
[ 23.903343] usb-storage: -- transfer complete
[ 23.903349] usb-storage: Bulk data transfer result 0x0
[ 23.903354] usb-storage: Attempting to get CSW...
[ 23.903359] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 23.903448] usb-storage: Status code 0; transferred 13/13
[ 23.903453] usb-storage: -- transfer complete
[ 23.903457] usb-storage: Bulk status result = 0
[ 23.903463] usb-storage: Bulk Status S 0x53425355 T 0x16 R 0 Stat 0x0
[ 23.903469] usb-storage: scsi cmd done, result=0x0
And here's the version that fails:
[ 10.760357] usb-storage: Command READ_10 (10 bytes)
[ 10.760361] usb-storage: 28 00 00 ee f3 f8 00 00 07 00
[ 10.760376] usb-storage: Bulk Command S 0x43425355 T 0x16 L 3584 F 128 Trg 0 LUN 0 CL 10
[ 10.760384] usb-storage: usb_stor_bulk_transfer_buf: xfer 31 bytes
[ 10.760466] usb-storage: Status code 0; transferred 31/31
[ 10.760471] usb-storage: -- transfer complete
[ 10.760475] usb-storage: Bulk command transfer result=0
[ 10.760482] usb-storage: usb_stor_bulk_transfer_sglist: xfer 3584 bytes, 1 entries
[ 10.761089] usb-storage: Status code 0; transferred 3584/3584
[ 10.761094] usb-storage: -- transfer complete
[ 10.761099] usb-storage: Bulk data transfer result 0x0
[ 10.761104] usb-storage: Attempting to get CSW...
[ 10.761109] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.761214] usb-storage: Status code -32; transferred 0/13
[ 10.761220] usb-storage: clearing endpoint halt for pipe 0xc0010280
[ 10.761231] usb-storage: usb_stor_control_msg: rq=01 rqtype=02 value=0000 index=82 len=0
[ 10.761337] usb-storage: usb_stor_clear_halt: result = 0
[ 10.761342] usb-storage: Attempting to get CSW (2nd try)...
[ 10.761348] usb-storage: usb_stor_bulk_transfer_buf: xfer 13 bytes
[ 10.761461] usb-storage: Status code 0; transferred 13/13
[ 10.761466] usb-storage: -- transfer complete
[ 10.761470] usb-storage: Bulk status result = 0
[ 10.761477] usb-storage: Bulk Status S 0x53425355 T 0x16 R 0 Stat 0x1
[ 10.761483] usb-storage: -- transport indicates command failure
The difference is that the first reads 8 sectors starting 8 sectors
from the end of the device, whereas the second reads only 7 sectors
starting from the same place. There's no reason this should fail; the
device reports sense key = 4, ASC = 0x11, ASCQ = 0, which means
Hardware error, Unrecoverable Read Error. Of course that is nonsense.
Nevertheless, it's clear that the problem has nothing to do with the
USB stack. The real source of the problem lies in the device itself,
for reporting a bogus error when in fact nothing went wrong. That may
also explain why you don't always see the problem -- sometimes the
device works the way it ought to.
It's being triggered by a change in some other part of the system. I
don't know who is responsible for those reads at the end of the device.
It could be the partition detection code (EFI GUID does that sort of
thing), or it could even be a userspace program (part of udev perhaps;
I think /lib/udev/vol_id reads strange parts of a disk).
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 1:58 ` Alan Stern
@ 2008-04-01 7:38 ` Oliver Neukum
2008-04-01 14:28 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Oliver Neukum @ 2008-04-01 7:38 UTC (permalink / raw)
To: Alan Stern; +Cc: Sergey Dolgov, linux-kernel, linux-usb
Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
> Nevertheless, it's clear that the problem has nothing to do with the
> USB stack. The real source of the problem lies in the device itself,
> for reporting a bogus error when in fact nothing went wrong. That may
> also explain why you don't always see the problem -- sometimes the
> device works the way it ought to.
Reminds me of the devices that can read the last sector but only if it is read
by itself. Do you reckon this device may have the "opposite" quirk?
Regards
Oliver
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 7:38 ` Oliver Neukum
@ 2008-04-01 14:28 ` Alan Stern
2008-04-01 14:34 ` Matthew Dharm
0 siblings, 1 reply; 18+ messages in thread
From: Alan Stern @ 2008-04-01 14:28 UTC (permalink / raw)
To: Oliver Neukum; +Cc: Sergey Dolgov, linux-kernel, linux-usb
On Tue, 1 Apr 2008, Oliver Neukum wrote:
> Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
> > Nevertheless, it's clear that the problem has nothing to do with the
> > USB stack. The real source of the problem lies in the device itself,
> > for reporting a bogus error when in fact nothing went wrong. That may
> > also explain why you don't always see the problem -- sometimes the
> > device works the way it ought to.
>
> Reminds me of the devices that can read the last sector but only if it is read
> by itself. Do you reckon this device may have the "opposite" quirk?
Could be something like that.
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 14:28 ` Alan Stern
@ 2008-04-01 14:34 ` Matthew Dharm
2008-04-01 14:42 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Matthew Dharm @ 2008-04-01 14:34 UTC (permalink / raw)
To: Alan Stern; +Cc: Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
[-- Attachment #1: Type: text/plain, Size: 1053 bytes --]
On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
> On Tue, 1 Apr 2008, Oliver Neukum wrote:
>
> > Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
> > > Nevertheless, it's clear that the problem has nothing to do with the
> > > USB stack. The real source of the problem lies in the device itself,
> > > for reporting a bogus error when in fact nothing went wrong. That may
> > > also explain why you don't always see the problem -- sometimes the
> > > device works the way it ought to.
> >
> > Reminds me of the devices that can read the last sector but only if it is read
> > by itself. Do you reckon this device may have the "opposite" quirk?
>
> Could be something like that.
Didn't I see some SCSI patches go by to implement exactly this change?
That is, only read the last sector by itself?
Matt
--
Matthew Dharm Home: mdharm-usb@one-eyed-alien.net
Maintainer, Linux USB Mass Storage Driver
We can customize our colonels.
-- Tux
User Friendly, 12/1/1998
[-- Attachment #2: Type: application/pgp-signature, Size: 189 bytes --]
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 14:34 ` Matthew Dharm
@ 2008-04-01 14:42 ` Alan Stern
2008-04-01 15:26 ` Boaz Harrosh
2008-04-01 15:53 ` Matthew Dharm
0 siblings, 2 replies; 18+ messages in thread
From: Alan Stern @ 2008-04-01 14:42 UTC (permalink / raw)
To: Matthew Dharm; +Cc: Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
On Tue, 1 Apr 2008, Matthew Dharm wrote:
> On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
> > On Tue, 1 Apr 2008, Oliver Neukum wrote:
> >
> > > Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
> > > > Nevertheless, it's clear that the problem has nothing to do with the
> > > > USB stack. The real source of the problem lies in the device itself,
> > > > for reporting a bogus error when in fact nothing went wrong. That may
> > > > also explain why you don't always see the problem -- sometimes the
> > > > device works the way it ought to.
> > >
> > > Reminds me of the devices that can read the last sector but only if it is read
> > > by itself. Do you reckon this device may have the "opposite" quirk?
> >
> > Could be something like that.
>
> Didn't I see some SCSI patches go by to implement exactly this change?
> That is, only read the last sector by itself?
You are getting the two problems mixed up. The older problem, which
the SCSI patche addressed, was that the device would fail when
accessing the last sector unless the transfer was 1 sector long.
This problem is different. When performing an 8-sector read that
includes the last sector, the device succeeds. When performing a
7-sector read starting from the same place (so not including the last
sector), the device fails.
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 14:42 ` Alan Stern
@ 2008-04-01 15:26 ` Boaz Harrosh
2008-04-01 15:53 ` Matthew Dharm
1 sibling, 0 replies; 18+ messages in thread
From: Boaz Harrosh @ 2008-04-01 15:26 UTC (permalink / raw)
To: Alan Stern
Cc: Matthew Dharm, Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
Alan Stern wrote:
> On Tue, 1 Apr 2008, Matthew Dharm wrote:
>
>> On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
>>> On Tue, 1 Apr 2008, Oliver Neukum wrote:
>>>
>>>> Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
>>>>> Nevertheless, it's clear that the problem has nothing to do with the
>>>>> USB stack. The real source of the problem lies in the device itself,
>>>>> for reporting a bogus error when in fact nothing went wrong. That may
>>>>> also explain why you don't always see the problem -- sometimes the
>>>>> device works the way it ought to.
>>>> Reminds me of the devices that can read the last sector but only if it is read
>>>> by itself. Do you reckon this device may have the "opposite" quirk?
>>> Could be something like that.
>> Didn't I see some SCSI patches go by to implement exactly this change?
>> That is, only read the last sector by itself?
>
> You are getting the two problems mixed up. The older problem, which
> the SCSI patche addressed, was that the device would fail when
> accessing the last sector unless the transfer was 1 sector long.
>
> This problem is different. When performing an 8-sector read that
> includes the last sector, the device succeeds. When performing a
> 7-sector read starting from the same place (so not including the last
> sector), the device fails.
>
> Alan Stern
>
It is a different problem but it explains why it used to work in previous
kernels. 8-sector been one page.
So it is related. Looks like another black list here. Is there a sysfs
way to disable the last-sector-thing for a usb device?
Boaz
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 14:42 ` Alan Stern
2008-04-01 15:26 ` Boaz Harrosh
@ 2008-04-01 15:53 ` Matthew Dharm
2008-04-01 16:31 ` Boaz Harrosh
2008-04-01 16:48 ` Sergey Dolgov
1 sibling, 2 replies; 18+ messages in thread
From: Matthew Dharm @ 2008-04-01 15:53 UTC (permalink / raw)
To: Alan Stern; +Cc: Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
[-- Attachment #1: Type: text/plain, Size: 2881 bytes --]
On Tue, Apr 01, 2008 at 10:42:51AM -0400, Alan Stern wrote:
> On Tue, 1 Apr 2008, Matthew Dharm wrote:
>
> > On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
> > > On Tue, 1 Apr 2008, Oliver Neukum wrote:
> > >
> > > > Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
> > > > > Nevertheless, it's clear that the problem has nothing to do with the
> > > > > USB stack. The real source of the problem lies in the device itself,
> > > > > for reporting a bogus error when in fact nothing went wrong. That may
> > > > > also explain why you don't always see the problem -- sometimes the
> > > > > device works the way it ought to.
> > > >
> > > > Reminds me of the devices that can read the last sector but only if it is read
> > > > by itself. Do you reckon this device may have the "opposite" quirk?
> > >
> > > Could be something like that.
> >
> > Didn't I see some SCSI patches go by to implement exactly this change?
> > That is, only read the last sector by itself?
>
> You are getting the two problems mixed up. The older problem, which
> the SCSI patche addressed, was that the device would fail when
> accessing the last sector unless the transfer was 1 sector long.
>
> This problem is different. When performing an 8-sector read that
> includes the last sector, the device succeeds. When performing a
> 7-sector read starting from the same place (so not including the last
> sector), the device fails.
I thought the patch I saw unconditionally re-wrote any access that included
the last sector into two accesses -- everything but the last sector, and
the last sector.
In other words, the patch attempted to avoid problems on devices that
couldn't access the last sector unless the transfer was 1 sector long by
ONLY accessing the last sector in a single transfer.
If I'm remembering correctly, that would explain the behavior change which
lead to the exposure of the bad behavior of this new device. This new
device worked with the old code, but not with the new code.
Basically, by avoiding a common error condition in device firmware, we've
found a device that has exactly the opposite bug.
Presuming someone can find the patch in the archive, reverting it would
produce a good test case; it should restore this device to a working state.
Maybe we need some auto-detect logic here; try the new way, if it fails,
revert to the old behavior. That's probably the safe order, as a lot of
the devices with the more 'classic' bug just die completely, whereas this
one appears to be recoverable.
Matt
--
Matthew Dharm Home: mdharm-usb@one-eyed-alien.net
Maintainer, Linux USB Mass Storage Driver
Sir, for the hundreth time, we do NOT carry 600-round boxes of belt-fed
suction darts!
-- Salesperson to Greg
User Friendly, 12/30/1997
[-- Attachment #2: Type: application/pgp-signature, Size: 189 bytes --]
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 15:53 ` Matthew Dharm
@ 2008-04-01 16:31 ` Boaz Harrosh
2008-04-01 20:24 ` Hans de Goede
2008-04-01 16:48 ` Sergey Dolgov
1 sibling, 1 reply; 18+ messages in thread
From: Boaz Harrosh @ 2008-04-01 16:31 UTC (permalink / raw)
To: Alan Stern, Oliver Neukum, Sergey Dolgov, linux-kernel,
linux-usb, Hans de Goede
On Tue, Apr 01 2008 at 18:53 +0300, Matthew Dharm <mdharm-kernel@one-eyed-alien.net> wrote:
> On Tue, Apr 01, 2008 at 10:42:51AM -0400, Alan Stern wrote:
>> On Tue, 1 Apr 2008, Matthew Dharm wrote:
>>
>>> On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
>>>> On Tue, 1 Apr 2008, Oliver Neukum wrote:
>>>>
>>>>> Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
>>>>>> Nevertheless, it's clear that the problem has nothing to do with the
>>>>>> USB stack. The real source of the problem lies in the device itself,
>>>>>> for reporting a bogus error when in fact nothing went wrong. That may
>>>>>> also explain why you don't always see the problem -- sometimes the
>>>>>> device works the way it ought to.
>>>>> Reminds me of the devices that can read the last sector but only if it is read
>>>>> by itself. Do you reckon this device may have the "opposite" quirk?
>>>> Could be something like that.
>>> Didn't I see some SCSI patches go by to implement exactly this change?
>>> That is, only read the last sector by itself?
>> You are getting the two problems mixed up. The older problem, which
>> the SCSI patche addressed, was that the device would fail when
>> accessing the last sector unless the transfer was 1 sector long.
>>
>> This problem is different. When performing an 8-sector read that
>> includes the last sector, the device succeeds. When performing a
>> 7-sector read starting from the same place (so not including the last
>> sector), the device fails.
>
> I thought the patch I saw unconditionally re-wrote any access that included
> the last sector into two accesses -- everything but the last sector, and
> the last sector.
>
> In other words, the patch attempted to avoid problems on devices that
> couldn't access the last sector unless the transfer was 1 sector long by
> ONLY accessing the last sector in a single transfer.
>
> If I'm remembering correctly, that would explain the behavior change which
> lead to the exposure of the bad behavior of this new device. This new
> device worked with the old code, but not with the new code.
>
> Basically, by avoiding a common error condition in device firmware, we've
> found a device that has exactly the opposite bug.
>
> Presuming someone can find the patch in the archive, reverting it would
> produce a good test case; it should restore this device to a working state.
> Maybe we need some auto-detect logic here; try the new way, if it fails,
> revert to the old behavior. That's probably the safe order, as a lot of
> the devices with the more 'classic' bug just die completely, whereas this
> one appears to be recoverable.
>
> Matt
>
The old way was not necessarily correct for this type of device bug. Only
that it had a very high chance of not appearing.
When discussing the last bug, it was said to enable it by default for USB
instead of using blacklists. It looks like this bug, or the other, needs a
blacklist.
But to me it looks like this is a 4k thing. I think Windows will always
use 4k for FAT, though never triggering either of the bugs.
The one submitting the last sector patch was, I think, Hans de Goede (CCed)
Hans ?
If I read last 8 sectors (4k) on a device that exhibits the "last sector bug"
Does it work? (Is 8 a magic number here)
Boaz
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 15:53 ` Matthew Dharm
2008-04-01 16:31 ` Boaz Harrosh
@ 2008-04-01 16:48 ` Sergey Dolgov
1 sibling, 0 replies; 18+ messages in thread
From: Sergey Dolgov @ 2008-04-01 16:48 UTC (permalink / raw)
To: Matthew Dharm; +Cc: Alan Stern, Oliver Neukum, linux-kernel, linux-usb
[-- Attachment #1: Type: TEXT/PLAIN, Size: 3072 bytes --]
On Tue, 1 Apr 2008, Matthew Dharm wrote:
> On Tue, Apr 01, 2008 at 10:42:51AM -0400, Alan Stern wrote:
>> On Tue, 1 Apr 2008, Matthew Dharm wrote:
>>
>>> On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
>>>> On Tue, 1 Apr 2008, Oliver Neukum wrote:
>>>>
>>>>> Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
>>>>>> Nevertheless, it's clear that the problem has nothing to do with the
>>>>>> USB stack. The real source of the problem lies in the device itself,
>>>>>> for reporting a bogus error when in fact nothing went wrong. That may
>>>>>> also explain why you don't always see the problem -- sometimes the
>>>>>> device works the way it ought to.
>>>>>
>>>>> Reminds me of the devices that can read the last sector but only if it is read
>>>>> by itself. Do you reckon this device may have the "opposite" quirk?
>>>>
>>>> Could be something like that.
>>>
>>> Didn't I see some SCSI patches go by to implement exactly this change?
>>> That is, only read the last sector by itself?
>>
>> You are getting the two problems mixed up. The older problem, which
>> the SCSI patche addressed, was that the device would fail when
>> accessing the last sector unless the transfer was 1 sector long.
>>
>> This problem is different. When performing an 8-sector read that
>> includes the last sector, the device succeeds. When performing a
>> 7-sector read starting from the same place (so not including the last
>> sector), the device fails.
>
> I thought the patch I saw unconditionally re-wrote any access that included
> the last sector into two accesses -- everything but the last sector, and
> the last sector.
>
> In other words, the patch attempted to avoid problems on devices that
> couldn't access the last sector unless the transfer was 1 sector long by
> ONLY accessing the last sector in a single transfer.
>
> If I'm remembering correctly, that would explain the behavior change which
> lead to the exposure of the bad behavior of this new device. This new
> device worked with the old code, but not with the new code.
>
> Basically, by avoiding a common error condition in device firmware, we've
> found a device that has exactly the opposite bug.
>
> Presuming someone can find the patch in the archive, reverting it would
> produce a good test case; it should restore this device to a working state.
> Maybe we need some auto-detect logic here; try the new way, if it fails,
> revert to the old behavior. That's probably the safe order, as a lot of
> the devices with the more 'classic' bug just die completely, whereas this
> one appears to be recoverable.
>
First of all, thank you guys for your help!
I have reverted commit 23c3e290fb9ce38cabc2822b47583fc8702411bf ([SCSI]
usbstorage: use last_sector_bug flag universally) and my card reader seems
to be working properly.
I'll need to give it some more testing to be 100 % shure though (so far
I've just booted once).
As for what should be done to handle both kinds of hardware peculiarities,
I'm not the one to advise, but looks like sometheng needs to be done.
--
Sergey
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 16:31 ` Boaz Harrosh
@ 2008-04-01 20:24 ` Hans de Goede
2008-04-01 21:01 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Hans de Goede @ 2008-04-01 20:24 UTC (permalink / raw)
To: Boaz Harrosh
Cc: Alan Stern, Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
Boaz Harrosh wrote:
> On Tue, Apr 01 2008 at 18:53 +0300, Matthew Dharm <mdharm-kernel@one-eyed-alien.net> wrote:
>> On Tue, Apr 01, 2008 at 10:42:51AM -0400, Alan Stern wrote:
>>> On Tue, 1 Apr 2008, Matthew Dharm wrote:
>>>
>>>> On Tue, Apr 01, 2008 at 10:28:52AM -0400, Alan Stern wrote:
>>>>> On Tue, 1 Apr 2008, Oliver Neukum wrote:
>>>>>
>>>>>> Am Dienstag, 1. April 2008 03:58:31 schrieb Alan Stern:
>>>>>>> Nevertheless, it's clear that the problem has nothing to do with the
>>>>>>> USB stack. The real source of the problem lies in the device itself,
>>>>>>> for reporting a bogus error when in fact nothing went wrong. That may
>>>>>>> also explain why you don't always see the problem -- sometimes the
>>>>>>> device works the way it ought to.
>>>>>> Reminds me of the devices that can read the last sector but only if it is read
>>>>>> by itself. Do you reckon this device may have the "opposite" quirk?
>>>>> Could be something like that.
>>>> Didn't I see some SCSI patches go by to implement exactly this change?
>>>> That is, only read the last sector by itself?
>>> You are getting the two problems mixed up. The older problem, which
>>> the SCSI patche addressed, was that the device would fail when
>>> accessing the last sector unless the transfer was 1 sector long.
>>>
>>> This problem is different. When performing an 8-sector read that
>>> includes the last sector, the device succeeds. When performing a
>>> 7-sector read starting from the same place (so not including the last
>>> sector), the device fails.
>> I thought the patch I saw unconditionally re-wrote any access that included
>> the last sector into two accesses -- everything but the last sector, and
>> the last sector.
>>
>> In other words, the patch attempted to avoid problems on devices that
>> couldn't access the last sector unless the transfer was 1 sector long by
>> ONLY accessing the last sector in a single transfer.
>>
>> If I'm remembering correctly, that would explain the behavior change which
>> lead to the exposure of the bad behavior of this new device. This new
>> device worked with the old code, but not with the new code.
>>
>> Basically, by avoiding a common error condition in device firmware, we've
>> found a device that has exactly the opposite bug.
>>
>> Presuming someone can find the patch in the archive, reverting it would
>> produce a good test case; it should restore this device to a working state.
>> Maybe we need some auto-detect logic here; try the new way, if it fails,
>> revert to the old behavior. That's probably the safe order, as a lot of
>> the devices with the more 'classic' bug just die completely, whereas this
>> one appears to be recoverable.
>>
Reverting the patch is easy, edit drivers/usb/storage/scsiglue.c and remove the
following line:
" sdev->last_sector_bug = 1;"
Which should be close to line 193 (it is 193 in my source tree, but thats a bit
stale).
>
> The old way was not necessarily correct for this type of device bug. Only
> that it had a very high chance of not appearing.
>
> When discussing the last bug, it was said to enable it by default for USB
> instead of using blacklists. It looks like this bug, or the other, needs a
> blacklist.
>
If the splitting of the request is the cause, yes then it looks like that.
> But to me it looks like this is a 4k thing. I think Windows will always
> use 4k for FAT, though never triggering either of the bugs.
>
I'm pretty sure the last sector must only be read by itself bug (for lack of a
better name) is present under windows too, but won't be triggered as windows
normally doesn't access the last sector, where as various pieces of Linux
routinely probe the end of the disk, for detection of exotic partition types/
disklabes.etc.
> The one submitting the last sector patch was, I think, Hans de Goede (CCed)
> Hans ?
Correct I wrote the split up requests which touch the last sector changes to
the scsi disk handling, and a seperate patch to always set the flag which
enables the splitting for usb disks.
> If I read last 8 sectors (4k) on a device that exhibits the "last sector bug"
> Does it work? (Is 8 a magic number here)
>
I just tried and I'm afraid not, an 8 sector read which includes at the last
sector completely kills the device, no other transfers to / from the device
will work until the sdcard is removed and reinserted (the troublesome device is
a card reader build into a multi function printer, one gets what one pays for).
Regards,
Hans
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 20:24 ` Hans de Goede
@ 2008-04-01 21:01 ` Alan Stern
2008-04-02 7:01 ` Hans de Goede
0 siblings, 1 reply; 18+ messages in thread
From: Alan Stern @ 2008-04-01 21:01 UTC (permalink / raw)
To: Hans de Goede
Cc: Boaz Harrosh, Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
On Tue, 1 Apr 2008, Hans de Goede wrote:
> Reverting the patch is easy, edit drivers/usb/storage/scsiglue.c and remove the
> following line:
> " sdev->last_sector_bug = 1;"
>
> Which should be close to line 193 (it is 193 in my source tree, but thats a bit
> stale).
>
> >
> > The old way was not necessarily correct for this type of device bug. Only
> > that it had a very high chance of not appearing.
> >
> > When discussing the last bug, it was said to enable it by default for USB
> > instead of using blacklists. It looks like this bug, or the other, needs a
> > blacklist.
> >
>
> If the splitting of the request is the cause, yes then it looks like that.
>
> > But to me it looks like this is a 4k thing. I think Windows will always
> > use 4k for FAT, though never triggering either of the bugs.
> >
>
> I'm pretty sure the last sector must only be read by itself bug (for lack of a
> better name) is present under windows too, but won't be triggered as windows
> normally doesn't access the last sector, where as various pieces of Linux
> routinely probe the end of the disk, for detection of exotic partition types/
> disklabes.etc.
>
> > The one submitting the last sector patch was, I think, Hans de Goede (CCed)
> > Hans ?
>
> Correct I wrote the split up requests which touch the last sector changes to
> the scsi disk handling, and a seperate patch to always set the flag which
> enables the splitting for usb disks.
>
> > If I read last 8 sectors (4k) on a device that exhibits the "last sector bug"
> > Does it work? (Is 8 a magic number here)
> >
>
> I just tried and I'm afraid not, an 8 sector read which includes at the last
> sector completely kills the device, no other transfers to / from the device
> will work until the sdcard is removed and reinserted (the troublesome device is
> a card reader build into a multi function printer, one gets what one pays for).
It sounds like the last_sector_bug setting should be conditional on a
blacklist entry. As far as I know it affects only a small proportion
of devices; most are fine with multi-sector reads at the end.
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-01 21:01 ` Alan Stern
@ 2008-04-02 7:01 ` Hans de Goede
2008-04-02 14:15 ` Alan Stern
0 siblings, 1 reply; 18+ messages in thread
From: Hans de Goede @ 2008-04-02 7:01 UTC (permalink / raw)
To: Alan Stern
Cc: Boaz Harrosh, Oliver Neukum, Sergey Dolgov, linux-kernel, linux-usb
Alan Stern wrote:
> On Tue, 1 Apr 2008, Hans de Goede wrote:
>
>> Reverting the patch is easy, edit drivers/usb/storage/scsiglue.c and remove the
>> following line:
>> " sdev->last_sector_bug = 1;"
>>
>> Which should be close to line 193 (it is 193 in my source tree, but thats a bit
>> stale).
>>
>>> The old way was not necessarily correct for this type of device bug. Only
>>> that it had a very high chance of not appearing.
>>>
>>> When discussing the last bug, it was said to enable it by default for USB
>>> instead of using blacklists. It looks like this bug, or the other, needs a
>>> blacklist.
>>>
>> If the splitting of the request is the cause, yes then it looks like that.
>>
>>> But to me it looks like this is a 4k thing. I think Windows will always
>>> use 4k for FAT, though never triggering either of the bugs.
>>>
>> I'm pretty sure the last sector must only be read by itself bug (for lack of a
>> better name) is present under windows too, but won't be triggered as windows
>> normally doesn't access the last sector, where as various pieces of Linux
>> routinely probe the end of the disk, for detection of exotic partition types/
>> disklabes.etc.
>>
>>> The one submitting the last sector patch was, I think, Hans de Goede (CCed)
>>> Hans ?
>> Correct I wrote the split up requests which touch the last sector changes to
>> the scsi disk handling, and a seperate patch to always set the flag which
>> enables the splitting for usb disks.
>>
>>> If I read last 8 sectors (4k) on a device that exhibits the "last sector bug"
>>> Does it work? (Is 8 a magic number here)
>>>
>> I just tried and I'm afraid not, an 8 sector read which includes at the last
>> sector completely kills the device, no other transfers to / from the device
>> will work until the sdcard is removed and reinserted (the troublesome device is
>> a card reader build into a multi function printer, one gets what one pays for).
>
> It sounds like the last_sector_bug setting should be conditional on a
> blacklist entry. As far as I know it affects only a small proportion
> of devices; most are fine with multi-sector reads at the end.
>
Maybe we should first determine that the regression is _really_ caused by this?
When testing yesterday I did a printk of any (unmodified) reads which would
touch the last sector and quite a few where not 8 sector reads, so if this
devices goes barf on any last sector including read of a different size then 8,
it will have troubles without the work around too.
First we need to determine what _exactly_ causes this device to become unhappy
(which should be trivial to test through dd), if I understand things sofar, the
device doesn't like if a read is done which stops one sector short of the last
sector. Such a read being done could happen without my split requests code
too, so making that conditional then wouldn't do any good, it would only make
the bug (much) less likely to get triggered, but it could still happen en
probably be reproduced by a trivial dd command.
Regards,
Hans
^ permalink raw reply [flat|nested] 18+ messages in thread
* Re: usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-02 7:01 ` Hans de Goede
@ 2008-04-02 14:15 ` Alan Stern
0 siblings, 0 replies; 18+ messages in thread
From: Alan Stern @ 2008-04-02 14:15 UTC (permalink / raw)
To: Sergey Dolgov, Hans de Goede
Cc: Boaz Harrosh, Oliver Neukum, Kernel development list, USB list
On Wed, 2 Apr 2008, Hans de Goede wrote:
> Maybe we should first determine that the regression is _really_
> caused by this?
>
> When testing yesterday I did a printk of any (unmodified) reads which would
> touch the last sector and quite a few where not 8 sector reads, so if this
> devices goes barf on any last sector including read of a different size then 8,
> it will have troubles without the work around too.
>
> First we need to determine what _exactly_ causes this device to become unhappy
> (which should be trivial to test through dd), if I understand things sofar, the
> device doesn't like if a read is done which stops one sector short of the last
> sector. Such a read being done could happen without my split requests code
> too, so making that conditional then wouldn't do any good, it would only make
> the bug (much) less likely to get triggered, but it could still happen en
> probably be reproduced by a trivial dd command.
That's a good point. Sergey, by using the "skip=" option in dd you
should be able to test lots of possible combinations. Verify that if
you start 8 sectors from the end, then reading 8 sectors works and
reading 7 sectors fails. Then see what other combinations fail; for
example, how far back before the end do you have to start before
reading 7 sectors will work? Or what happens if you start 2 sectors
before the end and read 1 or 2 sectors? Or if you start 7 sectors
before the end and read 6 or 7?
Alan Stern
^ permalink raw reply [flat|nested] 18+ messages in thread
* usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
2008-04-03 22:49 2.6.25-rc8-git2: Reported regressions from 2.6.24 Rafael J. Wysocki
@ 2008-04-03 23:22 ` Rafael J. Wysocki
0 siblings, 0 replies; 18+ messages in thread
From: Rafael J. Wysocki @ 2008-04-03 23:22 UTC (permalink / raw)
To: Linux Kernel Mailing List; +Cc: Sergey Dolgov
The following report is on the current list of known regressions
from 2.6.24. Please verify if the issue is still present in the
mainline.
Bug-Entry : http://bugzilla.kernel.org/show_bug.cgi?id=10365
Subject : usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7
Submitter : Sergey Dolgov <solkaa@gmail.com>
Date : 2008-03-30 11:49 (5 days old)
References : http://lkml.org/lkml/2008/3/30/11
^ permalink raw reply [flat|nested] 18+ messages in thread
end of thread, other threads:[~2008-04-04 0:12 UTC | newest]
Thread overview: 18+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2008-03-30 7:49 usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7 Sergey Dolgov
2008-03-30 18:59 ` Alan Stern
2008-03-30 22:32 ` Sergey Dolgov
2008-04-01 1:18 ` Sergey Dolgov
2008-04-01 1:58 ` Alan Stern
2008-04-01 7:38 ` Oliver Neukum
2008-04-01 14:28 ` Alan Stern
2008-04-01 14:34 ` Matthew Dharm
2008-04-01 14:42 ` Alan Stern
2008-04-01 15:26 ` Boaz Harrosh
2008-04-01 15:53 ` Matthew Dharm
2008-04-01 16:31 ` Boaz Harrosh
2008-04-01 20:24 ` Hans de Goede
2008-04-01 21:01 ` Alan Stern
2008-04-02 7:01 ` Hans de Goede
2008-04-02 14:15 ` Alan Stern
2008-04-01 16:48 ` Sergey Dolgov
2008-04-03 22:49 2.6.25-rc8-git2: Reported regressions from 2.6.24 Rafael J. Wysocki
2008-04-03 23:22 ` usb-storage, error reading the last 8 sectors, regression in 2.6.25-rc7 Rafael J. Wysocki
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).