Zamrzani USB disku

[S Dansa]

Dan Lukes wrote:

> Genialni rada zadna. Pro zacatek bych zjistil co se deje na USB zarizeni 
> v okoli pauzy. To znamena pouzit usbdump pro zachyceni komunikace a 
> nasledne posledni wireshark pro analyzu zachycenych dat.

Hmm, ale to asi budu muset (v duchu znameho prislovi) pozadat
o poradne nakopnuti :-) Ani jedno neumim pouzivat, takze z Wiresharku
(podle me) nelezlo nic rozumneho... (zkousel jsem verzi 2.0.0 z portu
i 2.0.1 od zdroje)

Pokud data ziskana pomoci:

#usbdump -i usbus4 -s 0 -w /tmp/wd_pkt

prozenu tymz programem v rezimu cteni dat (-r /tmp...),
ziskam toto (dump ma cca 140 MB, nechal jsem "tar" projet cely
src strom na USB disku, pri chodu to 5x "zamrzlo"):

14:36:18.536784 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:36:18.538535 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=65536,IVAL=0,ERR=0
14:36:18.538777 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
14:36:18.538812 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
14:36:18.538900 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:36:18.538906 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:36:18.539844 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=32768,IVAL=0,ERR=0
14:36:18.539869 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:36:18.540035 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
14:36:18.540220 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
14:36:18.540283 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:36:18.540290 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
--- > zde "zamrzlo"

14:37:22.062273 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
--- > zde "rozmrzlo"

14:37:22.062286 usbus4.2 SUBM-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=8,IVAL=0
14:37:22.062347 usbus4.2 DONE-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
---> "CTRL" se vyskytuje jen po ERR=TIMEOUT, totez plati pro EP=00000000

14:37:22.062352 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:37:22.062468 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
14:37:22.062504 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
14:37:22.062588 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:37:22.062617 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32768,IVAL=0
14:37:22.063844 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:37:22.063849 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:37:22.063971 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
14:37:22.064003 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
14:37:22.064095 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:37:22.064113 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32768,IVAL=0
14:37:22.065222 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
14:37:22.065226 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
14:37:22.065342 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0

Pokud ubsdumpu pridam na ukecanosti (-vvv), ziskam:

14:36:18.539869 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
 frame[0] READ 13 bytes
 flags 0x2 <SHORT_XFER_OK|0>
 status 0xeb023 <OPEN|TRANSFERRING|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:36:18.540035 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
 frame[0] READ 13 bytes
 0000  55 53 42 53 D9 59 00 00  00 00 00 00 00 -- -- --  |USBS.Y.......   |
 flags 0x2 <SHORT_XFER_OK|0>
 status 0xcb021 <OPEN|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:36:18.540220 usbus4.2 SUBM-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=32,IVAL=0
 frame[0] WRITE 31 bytes
 0000  55 53 42 43 DA 59 00 00  00 50 00 00 80 00 0A 28  |USBC.Y...P.....(|
 0010  00 84 2D A6 40 00 00 28  00 00 00 00 00 00 00 --  |..-. at ..(....... |
 flags 0 <0>
 status 0xca023 <OPEN|TRANSFERRING|STARTED|BDMA_ENABLE|BDMA_SETUP|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:36:18.540283 usbus4.2 DONE-BULK-EP=00000002,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
 frame[0] WRITE 31 bytes
 flags 0 <0>
 status 0xea021 <OPEN|STARTED|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:36:18.540290 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
 frame[0] READ 20480 bytes
 flags 0x32 <SHORT_XFER_OK|PROXY_BUFFER|EXT_BUFFER|0>
 status 0xeb023 <OPEN|TRANSFERRING|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
--- > zde "zamrzlo"


14:37:22.062273 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
 flags 0x32 <SHORT_XFER_OK|PROXY_BUFFER|EXT_BUFFER|0>
 status 0x8b025 <OPEN|DID_DMA_DELAY|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|DOING_CALLBACK|0>
--- > zde "rozmrzlo"


14:37:22.062286 usbus4.2 SUBM-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=8,IVAL=0
 frame[0] WRITE 8 bytes
 0000  02 01 00 00 81 00 00 00  -- -- -- -- -- -- -- --  |........        |
 flags 0 <0>
 status 0xea1a3 <OPEN|TRANSFERRING|STARTED|CONTROL_XFR|CONTROL_HDR|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:37:22.062347 usbus4.2 DONE-CTRL-EP=00000000,SPD=HIGH,NFR=1,SLEN=0,IVAL=0,ERR=0
 frame[0] WRITE 8 bytes
 flags 0 <0>
 status 0xca1a1 <OPEN|STARTED|CONTROL_XFR|CONTROL_HDR|BDMA_ENABLE|BDMA_SETUP|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:37:22.062352 usbus4.2 SUBM-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=0,IVAL=0
 frame[0] READ 13 bytes
 flags 0x2 <SHORT_XFER_OK|0>
 status 0xcb023 <OPEN|TRANSFERRING|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CAN_CANCEL_IMMED|DOING_CALLBACK|0>
14:37:22.062468 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=1,SLEN=16,IVAL=0,ERR=0
 frame[0] READ 13 bytes
 0000  55 53 42 53 DA 59 00 00  00 00 00 00 00 -- -- --  |USBS.Y.......   |
 flags 0x2 <SHORT_XFER_OK|0>
 status 0xeb021 <OPEN|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|CAN_CANCEL_IMMED|DOING_CALLBACK|0>

2x (z 5 zamrznuti) se vyskytuje TIMEOUT s odlisnym "statusem"

14:39:31.486265 usbus4.2 DONE-BULK-EP=00000081,SPD=HIGH,NFR=0,SLEN=0,IVAL=0,ERR=TIMEOUT
 flags 0x32 <SHORT_XFER_OK|PROXY_BUFFER|EXT_BUFFER|0>
 status 0xab025 <OPEN|DID_DMA_DELAY|STARTED|SHORT_XFER_OK|BDMA_ENABLE|BDMA_SETUP|CURR_DMA_SET|DOING_CALLBACK|0

Vyse uvedene na me, neznaleho, pusobi dojmem, ze problem
je na strane disku. Zkusim si nekde pujcit jiny...

Diky za nasmerovani

Standa