nrf52840 usb_msc demo windos10 Home Edition USB disk will be lost in about 20 minutes

[Mars_xu]

I used usb_msc with nRF5SDK160098a08e2 sdk to connect the usb of pca10056 development board to win10 home version and the disk could not be recognized after about 20 minutes;

1. Current test conclusion:

 1) Appears only in win10 home edition, not in win10 professional edition;
 2) Use the Debug mode, the optimization level is set to None, the disk is displayed for 20 minutes after mounting, and the disk is not lost. When entering the secondary folder to write the file, the file cannot be written, and finally the disk is lost;

2. Test procedures

nRF5SDK160098a08e2-new-2.rar

3. Problem phenomenon
1) When the USB is connected to the computer

2) The disk is lost in about 20 minutes

4. Test method
1) Burn the compiled program
2) USB connection to win10 home version computer
2) Create TEST1/TEST2/test.txt

   
3) Write the current time in the test.txt file every 10 minutes;
4) After a few times you will find that the file cannot be written;
5) The disk has been lost;

5. The compiled hex file is convenient for you to quickly reproduce the problem;

 2425.usbd_msc_pca10056.hex

[ketiljo]

Can it be that the  USB port power is turned off after a while? There shouldn't be any difference in how Windows handles a USB drive across Windows versions. Check in Device Manager: 

[Mars_xu]

1. Test conclusion

1) I turn off the power saving option of USB hub power tube of win10 home version, and the test will still appear;

2. Other information:

1) The windows 10 home version is connected to the MCU of other four manufacturers without disk loss;

2) It can be determined that there is a difference between win10 home edition and win10 professional edition. Previously, we used MCU from other manufacturers to encounter disk loss in win10 home edition, which was finally solved by upgrading SDK;

3. Personal suggestions:

1) You find a win10 home computer, which is very easy to reproduce;

[Mars_xu]

Hi Edvin,

  We have already started preparations for alternatives, I hope you can characterize the problem as soon as possible, thank you!

[Edvin]

Hello,

This is the response I received from the USB driver team:

---------------------------

Considering that this issue is only reproducible on two versions of Windows Home, it will not be trivial to set the environment up.

But we could start from trying to debug it on clients’ setup – could you ask him to enable logging (specifically ones in USB MSC class), preferably using RTT as the amount could be overwhelming. It is possible that Windows sends an MSC command that is unsupported, which would result in this log:

NRF_LOG_DEBUG("CMD: UNSUPPORTED");

Even better if they could print the value of p_msc_ctx->cbw.cdb[0] in that log.

If the client has a USB analyzer, bus activity logs would be greatly appreciated too.

---------------------------

Can you please try to enable the logging on the USB MSC class?

Do you have access to a USB analyzer? If so, can you please try to capture a USB trace?

Best regards,

Edvin

[Mars_xu]

Hi Edvin:

1. First, we open the log of the USB part and continue the test;

2. There is no USB logic analysis. How to use USB hound to monitor events;

[Edvin]

Hello,

I am not familiar with USB hound. Is it this one?

As mentioned, I have not tried it. Are you able to monitor the traffic both ways from the nRF to the computer using that FW?

BR,

Edvin

[Mars_xu]

Hi Edvin:

1. Normal log:

2. The log when the exception occurs, the command changes;

3. When I check, log printing stays here;

4. When the file is operated again, the subsequent parts are printed one after another

5. log attachment

  

Fullscreen 2352.log.txt Download

[00:00:00.113,830] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.113,830] <debug> usbd_msc: Ep proc status: 0

[00:00:00.113,830] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.049,865] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.049,865] <debug> usbd_msc: cbw_wait_start

[00:00:00.049,865] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.049,865] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.049,865] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.049,865] <debug> usbd_msc: Ep proc status: 0

[00:00:00.049,926] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.110,900] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.110,900] <debug> usbd_msc: cbw_wait_start

[00:00:00.110,961] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.110,961] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.110,961] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.110,961] <debug> usbd_msc: Ep proc status: 0

[00:00:00.110,961] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.046,997] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.046,997] <debug> usbd_msc: cbw_wait_start

[00:00:00.046,997] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.046,997] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.046,997] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.046,997] <debug> usbd_msc: Ep proc status: 0

[00:00:00.046,997] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.108,032] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.108,032] <debug> usbd_msc: cbw_wait_start

[00:00:00.108,032] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.108,032] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.108,032] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.108,032] <debug> usbd_msc: Ep proc status: 0

[00:00:00.108,093] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,067] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,067] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,128] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,128] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.044,128] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.044,128] <debug> usbd_msc: Ep proc status: 0

[00:00:00.044,128] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.105,163] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.105,163] <debug> usbd_msc: cbw_wait_start

[00:00:00.105,163] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.105,163] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.105,163] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.105,163] <debug> usbd_msc: Ep proc status: 0

[00:00:00.105,163] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.041,198] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.041,198] <debug> usbd_msc: cbw_wait_start

[00:00:00.041,198] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.041,198] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.041,198] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.041,198] <debug> usbd_msc: Ep proc status: 0

[00:00:00.041,259] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.102,233] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.102,233] <debug> usbd_msc: cbw_wait_start

[00:00:00.102,294] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.102,294] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.102,294] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.102,294] <debug> usbd_msc: Ep proc status: 0

[00:00:00.102,294] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.038,330] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.038,330] <debug> usbd_msc: cbw_wait_start

[00:00:00.038,330] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.038,330] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.038,330] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.038,330] <debug> usbd_msc: Ep proc status: 0

[00:00:00.038,330] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.099,365] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.099,365] <debug> usbd_msc: cbw_wait_start

[00:00:00.099,365] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.099,365] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.099,365] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.099,365] <debug> usbd_msc: Ep proc status: 0

[00:00:00.099,426] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.035,400] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.035,400] <debug> usbd_msc: cbw_wait_start

[00:00:00.035,461] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.035,461] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.035,461] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.035,461] <debug> usbd_msc: Ep proc status: 0

[00:00:00.035,461] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.096,496] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.096,496] <debug> usbd_msc: cbw_wait_start

[00:00:00.096,496] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.096,496] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.096,496] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.096,496] <debug> usbd_msc: Ep proc status: 0

[00:00:00.096,496] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.032,531] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.032,531] <debug> usbd_msc: cbw_wait_start

[00:00:00.032,531] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.032,531] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.032,531] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.032,531] <debug> usbd_msc: Ep proc status: 0

[00:00:00.032,531] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.093,566] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.093,566] <debug> usbd_msc: cbw_wait_start

[00:00:00.093,627] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.093,627] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.093,627] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.093,627] <debug> usbd_msc: Ep proc status: 0

[00:00:00.093,627] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.029,663] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.029,663] <debug> usbd_msc: cbw_wait_start

[00:00:00.029,663] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.029,663] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.029,663] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.029,663] <debug> usbd_msc: Ep proc status: 0

[00:00:00.029,663] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.090,698] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.090,698] <debug> usbd_msc: cbw_wait_start

[00:00:00.090,698] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.090,698] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.090,698] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.090,698] <debug> usbd_msc: Ep proc status: 0

[00:00:00.090,698] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.026,733] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.026,733] <debug> usbd_msc: cbw_wait_start

[00:00:00.026,794] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.026,794] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.026,794] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.026,794] <debug> usbd_msc: Ep proc status: 0

[00:00:00.026,794] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.087,829] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.087,829] <debug> usbd_msc: cbw_wait_start

[00:00:00.087,829] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.087,829] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.087,829] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.087,829] <debug> usbd_msc: Ep proc status: 0

[00:00:00.087,829] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.023,864] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.023,864] <debug> usbd_msc: cbw_wait_start

[00:00:00.023,864] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.023,864] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.023,864] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.023,864] <debug> usbd_msc: Ep proc status: 0

[00:00:00.023,925] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.084,899] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.084,899] <debug> usbd_msc: cbw_wait_start

[00:00:00.084,899] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.084,899] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.084,899] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.084,899] <debug> usbd_msc: Ep proc status: 0

[00:00:00.084,960] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.020,996] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.020,996] <debug> usbd_msc: cbw_wait_start

[00:00:00.020,996] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.020,996] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.020,996] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.020,996] <debug> usbd_msc: Ep proc status: 0

[00:00:00.020,996] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.082,031] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.082,031] <debug> usbd_msc: cbw_wait_start

[00:00:00.082,031] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.082,031] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.082,031] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.082,031] <debug> usbd_msc: Ep proc status: 0

[00:00:00.082,031] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.018,066] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.018,066] <debug> usbd_msc: cbw_wait_start

[00:00:00.018,066] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.018,066] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.018,066] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.018,066] <debug> usbd_msc: Ep proc status: 0

[00:00:00.018,127] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.079,162] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.079,162] <debug> usbd_msc: cbw_wait_start

[00:00:00.079,162] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.079,162] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.079,162] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.079,162] <debug> usbd_msc: Ep proc status: 0

[00:00:00.079,162] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.015,197] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.015,197] <debug> usbd_msc: cbw_wait_start

[00:00:00.015,197] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.015,197] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.015,197] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.015,197] <debug> usbd_msc: Ep proc status: 0

[00:00:00.015,197] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.076,232] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.076,232] <debug> usbd_msc: cbw_wait_start

[00:00:00.076,232] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.076,232] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.076,232] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.076,232] <debug> usbd_msc: Ep proc status: 0

[00:00:00.076,293] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.012,329] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.012,329] <debug> usbd_msc: cbw_wait_start

[00:00:00.012,329] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.012,329] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.012,329] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.012,329] <debug> usbd_msc: Ep proc status: 0

[00:00:00.012,329] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.073,364] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.073,364] <debug> usbd_msc: cbw_wait_start

[00:00:00.073,364] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.073,364] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.073,364] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.073,364] <debug> usbd_msc: Ep proc status: 0

[00:00:00.073,364] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.009,460] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.009,460] <debug> usbd_msc: cbw_wait_start

[00:00:00.009,460] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.009,460] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.009,460] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.009,460] <debug> usbd_msc: Ep proc status: 0

[00:00:00.009,460] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.070,495] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.070,495] <debug> usbd_msc: cbw_wait_start

[00:00:00.070,495] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.070,495] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.070,495] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.070,495] <debug> usbd_msc: Ep proc status: 0

[00:00:00.070,495] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.006,530] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.006,530] <debug> usbd_msc: cbw_wait_start

[00:00:00.006,530] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.006,530] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.006,530] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.006,530] <debug> usbd_msc: Ep proc status: 0

[00:00:00.006,530] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.067,565] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.067,565] <debug> usbd_msc: cbw_wait_start

[00:00:00.067,565] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.067,565] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.067,565] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.067,565] <debug> usbd_msc: Ep proc status: 0

[00:00:00.067,626] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.003,662] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.003,662] <debug> usbd_msc: cbw_wait_start

[00:00:00.003,662] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.003,662] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.003,662] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.003,662] <debug> usbd_msc: Ep proc status: 0

[00:00:00.003,662] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.064,697] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.064,697] <debug> usbd_msc: cbw_wait_start

[00:00:00.064,697] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.064,697] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.064,697] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.064,697] <debug> usbd_msc: Ep proc status: 0

[00:00:00.064,697] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.000,732] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.000,732] <debug> usbd_msc: cbw_wait_start

[00:00:00.000,732] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.000,732] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.000,732] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.000,732] <debug> usbd_msc: Ep proc status: 0

[00:00:00.000,793] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.061,828] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.061,828] <debug> usbd_msc: cbw_wait_start

[00:00:00.061,828] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.061,828] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.061,828] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.061,828] <debug> usbd_msc: Ep proc status: 0

[00:00:00.061,828] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.122,863] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.122,863] <debug> usbd_msc: cbw_wait_start

[00:00:00.122,863] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.122,863] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.122,863] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.122,863] <debug> usbd_msc: Ep proc status: 0

[00:00:00.122,863] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.058,898] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.058,898] <debug> usbd_msc: cbw_wait_start

[00:00:00.058,898] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.058,898] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.058,898] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.058,898] <debug> usbd_msc: Ep proc status: 0

[00:00:00.058,959] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.119,995] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.119,995] <debug> usbd_msc: cbw_wait_start

[00:00:00.119,995] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.119,995] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.119,995] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.119,995] <debug> usbd_msc: Ep proc status: 0

[00:00:00.119,995] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.056,030] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.056,030] <debug> usbd_msc: cbw_wait_start

[00:00:00.056,030] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.056,030] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.056,030] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.056,030] <debug> usbd_msc: Ep proc status: 0

[00:00:00.056,030] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.117,065] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.117,065] <debug> usbd_msc: cbw_wait_start

[00:00:00.117,065] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.117,065] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.117,065] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.117,065] <debug> usbd_msc: Ep proc status: 0

[00:00:00.117,126] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.053,161] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.053,161] <debug> usbd_msc: cbw_wait_start

[00:00:00.053,161] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.053,161] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.053,161] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.053,161] <debug> usbd_msc: Ep proc status: 0

[00:00:00.053,161] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.114,196] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.114,196] <debug> usbd_msc: cbw_wait_start

[00:00:00.114,196] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.114,196] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.114,196] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.114,196] <debug> usbd_msc: Ep proc status: 0

[00:00:00.114,196] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.050,231] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.050,231] <debug> usbd_msc: cbw_wait_start

[00:00:00.050,231] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.050,231] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.050,231] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.050,231] <debug> usbd_msc: Ep proc status: 0

[00:00:00.050,292] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.111,328] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.111,328] <debug> usbd_msc: cbw_wait_start

[00:00:00.111,328] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.111,328] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.111,328] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.111,328] <debug> usbd_msc: Ep proc status: 0

[00:00:00.111,328] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.047,363] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.047,363] <debug> usbd_msc: cbw_wait_start

[00:00:00.047,363] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.047,363] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.047,363] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.047,363] <debug> usbd_msc: Ep proc status: 0

[00:00:00.047,363] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.108,398] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.108,398] <debug> usbd_msc: cbw_wait_start

[00:00:00.108,398] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.108,398] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.108,398] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.108,398] <debug> usbd_msc: Ep proc status: 0

[00:00:00.108,459] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,433] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,433] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,494] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,494] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.044,494] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.044,494] <debug> usbd_msc: Ep proc status: 0

[00:00:00.044,494] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.105,529] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.105,529] <debug> usbd_msc: cbw_wait_start

[00:00:00.105,529] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.105,529] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.105,529] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.105,529] <debug> usbd_msc: Ep proc status: 0

[00:00:00.105,529] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.041,564] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.041,564] <debug> usbd_msc: cbw_wait_start

[00:00:00.041,564] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.041,564] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.041,564] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.041,564] <debug> usbd_msc: Ep proc status: 0

[00:00:00.041,625] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.102,661] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.102,661] <debug> usbd_msc: cbw_wait_start

[00:00:00.102,661] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.102,661] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.102,661] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.102,661] <debug> usbd_msc: Ep proc status: 0

[00:00:00.102,661] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.038,696] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.038,696] <debug> usbd_msc: cbw_wait_start

[00:00:00.038,696] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.038,696] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.038,696] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.038,696] <debug> usbd_msc: Ep proc status: 0

[00:00:00.038,696] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.099,731] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.099,731] <debug> usbd_msc: cbw_wait_start

[00:00:00.099,731] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.099,731] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.099,731] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.099,731] <debug> usbd_msc: Ep proc status: 0

[00:00:00.099,792] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.035,766] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.035,766] <debug> usbd_msc: cbw_wait_start

[00:00:00.035,766] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.035,766] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.035,766] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.035,766] <debug> usbd_msc: Ep proc status: 0

[00:00:00.035,827] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.096,862] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.096,862] <debug> usbd_msc: cbw_wait_start

[00:00:00.096,862] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.096,862] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.096,862] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.096,862] <debug> usbd_msc: Ep proc status: 0

[00:00:00.096,862] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.032,897] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.032,897] <debug> usbd_msc: cbw_wait_start

[00:00:00.032,897] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.032,897] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.032,897] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.032,897] <debug> usbd_msc: Ep proc status: 0

[00:00:00.032,958] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.093,933] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.093,933] <debug> usbd_msc: cbw_wait_start

[00:00:00.093,933] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.093,933] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.093,933] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.093,933] <debug> usbd_msc: Ep proc status: 0

[00:00:00.093,994] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.030,029] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.030,029] <debug> usbd_msc: cbw_wait_start

[00:00:00.030,029] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.030,029] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.030,029] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.030,029] <debug> usbd_msc: Ep proc status: 0

[00:00:00.030,029] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.091,064] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.091,064] <debug> usbd_msc: cbw_wait_start

[00:00:00.091,064] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.091,064] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.091,064] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.091,064] <debug> usbd_msc: Ep proc status: 0

[00:00:00.091,125] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.096,069] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.096,069] <debug> usbd_msc: cbw_wait_start

[00:00:00.096,069] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.096,069] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.096,069] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.096,069] <debug> usbd_msc: Ep proc status: 0

[00:00:00.096,130] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.096,130] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.096,130] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.116,760] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.116,760] <debug> usbd_msc: cbw_wait_start

[00:00:00.116,760] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.116,760] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.116,760] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.116,760] <debug> usbd_msc: Ep proc status: 0

[00:00:00.116,760] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.116,760] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.116,760] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.023,315] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.023,315] <debug> usbd_msc: cbw_wait_start

[00:00:00.023,315] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.023,315] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.023,315] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.023,315] <debug> usbd_msc: Ep proc status: 0

[00:00:00.023,315] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.023,315] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.027,099] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.027,099] <debug> usbd_msc: cbw_wait_start

[00:00:00.027,099] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.027,099] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.027,099] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.027,099] <debug> usbd_msc: Ep proc status: 0

[00:00:00.027,160] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,067] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,067] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,067] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,067] <debug> usbd_msc: CMD: INQUIRY

[00:00:00.044,067] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 36

[00:00:00.044,067] <debug> usbd_msc: Ep proc status: 0

[00:00:00.044,128] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.044,128] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.044,128] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,128] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,128] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,128] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,128] <debug> usbd_msc: CMD: UNSUPPORTED

[00:00:00.044,128] <debug> usbd_msc: p_msc_ctx->cbw.cdb[0]=133

[00:00:00.044,128] <debug> usbd_msc:  55 53 42 43 C0 36 95 F9|USBC.6..

[00:00:00.044,128] <debug> usbd_msc:  00 02 00 00 80 00 10 85|........

......

..... 

[00:00:00.044,128] <debug> usbd_msc: Ep proc status: 0

[00:00:00.044,189] <debug> app_usbd_core: SETUP: t: 0x02 r: 0x01

[00:00:00.044,189] <debug> usbd_msc: csw_wait_start: 1

[00:00:00.044,189] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,189] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,189] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,250] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,250] <debug> usbd_msc: CMD: REQUESTSENSE

[00:00:00.049,682] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.055,725] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.055,725] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.055,786] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.098,327] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.104,370] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.104,370] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.104,492] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.051,269] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.057,312] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.057,312] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.057,373] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.033,508] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.039,550] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.039,550] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.039,611] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.111,450] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.117,431] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.117,492] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.117,553] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.093,688] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.099,670] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.099,731] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.099,792] <debug> usbd_msc: state: 0, ep out event, status: 1

[Edvin]

Hello sir,

Message from the driver team:

-----------------

Yes, it looks like an unsupported command with opcode 133 (0x85) is received. That command is ATA PASS-THROUGH(16), which is an extension not supported by the device. Can the customer check if adding the following code in app_usbd_msc.c changes the host's behaviour:

- Add function above state_cbw():

static ret_code_t cmd_atapassthrough(app_usbd_class_inst_t const * p_inst, app_usbd_msc_t const * p_msc, app_usbd_msc_ctx_t * p_msc_ctx)
{
    NRF_LOG_DEBUG("CMD: ATA PASS-THROUGH");
    return csw_wait_start(p_inst, APP_USBD_MSC_CSW_STATUS_PASS);
}

- In switch-case inside state_sbw(), just before default, add case:

case 0x85:
    ret = cmd_atapassthrough(p_inst, p_msc, p_msc_ctx);
    break;

-----------------

Can you please test the suggested workaround, and see how it behaves? Check if the log prints the "CMD: ATA PASS-THROUGH" message, and if the switch-case handling solves the issue.

Best regards,

Edvin

[Mars_xu]

Hi Edvin:

The USB test has been re-run according to your suggestion, and the disk will still be lost;
The log is as follows;

Fullscreen log0618.txt Download

[00:00:00.064,514] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.064,514] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.064,514] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.064,514] <debug> usbd_msc: Ep proc status: 0

[00:00:00.064,514] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.000,549] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.000,549] <debug> usbd_msc: cbw_wait_start

[00:00:00.000,549] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.000,549] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.000,549] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.000,549] <debug> usbd_msc: Ep proc status: 0

[00:00:00.000,549] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.061,584] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.061,584] <debug> usbd_msc: cbw_wait_start

[00:00:00.061,584] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.061,584] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.061,584] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.061,584] <debug> usbd_msc: Ep proc status: 0

[00:00:00.061,645] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.122,680] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.122,680] <debug> usbd_msc: cbw_wait_start

[00:00:00.122,680] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.122,680] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.122,680] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.122,680] <debug> usbd_msc: Ep proc status: 0

[00:00:00.122,680] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.058,715] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.058,715] <debug> usbd_msc: cbw_wait_start

[00:00:00.058,715] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.058,715] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.058,715] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.058,715] <debug> usbd_msc: Ep proc status: 0

[00:00:00.058,715] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.119,750] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.119,750] <debug> usbd_msc: cbw_wait_start

[00:00:00.119,750] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.119,750] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.119,750] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.119,750] <debug> usbd_msc: Ep proc status: 0

[00:00:00.119,812] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.055,847] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.055,847] <debug> usbd_msc: cbw_wait_start

[00:00:00.055,847] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.055,847] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.055,847] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.055,847] <debug> usbd_msc: Ep proc status: 0

[00:00:00.055,847] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.116,882] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.116,882] <debug> usbd_msc: cbw_wait_start

[00:00:00.116,882] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.116,882] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.116,882] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.116,882] <debug> usbd_msc: Ep proc status: 0

[00:00:00.116,882] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.052,917] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.052,917] <debug> usbd_msc: cbw_wait_start

[00:00:00.052,917] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.052,917] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.052,917] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.052,917] <debug> usbd_msc: Ep proc status: 0

[00:00:00.052,978] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.114,013] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.114,013] <debug> usbd_msc: cbw_wait_start

[00:00:00.114,013] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.114,013] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.114,013] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.114,013] <debug> usbd_msc: Ep proc status: 0

[00:00:00.114,013] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.050,048] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.050,048] <debug> usbd_msc: cbw_wait_start

[00:00:00.050,048] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.050,048] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.050,048] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.050,048] <debug> usbd_msc: Ep proc status: 0

[00:00:00.050,048] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.111,083] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.111,083] <debug> usbd_msc: cbw_wait_start

[00:00:00.111,083] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.111,083] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.111,083] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.111,083] <debug> usbd_msc: Ep proc status: 0

[00:00:00.111,145] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.047,180] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.047,180] <debug> usbd_msc: cbw_wait_start

[00:00:00.047,180] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.047,180] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.047,180] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.047,180] <debug> usbd_msc: Ep proc status: 0

[00:00:00.047,180] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.108,215] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.108,215] <debug> usbd_msc: cbw_wait_start

[00:00:00.108,215] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.108,215] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.108,215] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.108,215] <debug> usbd_msc: Ep proc status: 0

[00:00:00.108,215] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.044,250] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.044,250] <debug> usbd_msc: cbw_wait_start

[00:00:00.044,250] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.044,250] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.044,250] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.044,250] <debug> usbd_msc: Ep proc status: 0

[00:00:00.044,311] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.105,346] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.105,346] <debug> usbd_msc: cbw_wait_start

[00:00:00.105,346] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.105,346] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.105,346] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.105,346] <debug> usbd_msc: Ep proc status: 0

[00:00:00.105,346] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.041,381] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.041,381] <debug> usbd_msc: cbw_wait_start

[00:00:00.041,381] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.041,381] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.041,381] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.041,381] <debug> usbd_msc: Ep proc status: 0

[00:00:00.041,381] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.102,416] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.102,416] <debug> usbd_msc: cbw_wait_start

[00:00:00.102,416] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.102,416] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.102,416] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.102,416] <debug> usbd_msc: Ep proc status: 0

[00:00:00.102,478] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.038,513] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.038,513] <debug> usbd_msc: cbw_wait_start

[00:00:00.038,513] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.038,513] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.038,513] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.038,513] <debug> usbd_msc: Ep proc status: 0

[00:00:00.038,513] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.099,548] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.099,548] <debug> usbd_msc: cbw_wait_start

[00:00:00.099,548] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.099,548] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.099,548] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.099,548] <debug> usbd_msc: Ep proc status: 0

[00:00:00.099,548] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.035,583] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.035,583] <debug> usbd_msc: cbw_wait_start

[00:00:00.035,583] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.035,583] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.035,583] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.035,583] <debug> usbd_msc: Ep proc status: 0

[00:00:00.035,644] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.096,679] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.096,679] <debug> usbd_msc: cbw_wait_start

[00:00:00.096,679] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.096,679] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.096,679] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.096,679] <debug> usbd_msc: Ep proc status: 0

[00:00:00.096,679] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.032,714] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.032,714] <debug> usbd_msc: cbw_wait_start

[00:00:00.032,714] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.032,714] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.032,714] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.032,714] <debug> usbd_msc: Ep proc status: 0

[00:00:00.032,714] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.093,750] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.093,750] <debug> usbd_msc: cbw_wait_start

[00:00:00.093,750] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.093,750] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.093,750] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.093,750] <debug> usbd_msc: Ep proc status: 0

[00:00:00.093,811] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.029,846] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.029,846] <debug> usbd_msc: cbw_wait_start

[00:00:00.029,846] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.029,846] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.029,846] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.029,846] <debug> usbd_msc: Ep proc status: 0

[00:00:00.029,846] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.090,881] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.090,881] <debug> usbd_msc: cbw_wait_start

[00:00:00.090,881] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.090,881] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.090,881] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.090,881] <debug> usbd_msc: Ep proc status: 0

[00:00:00.090,881] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.026,916] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.026,916] <debug> usbd_msc: cbw_wait_start

[00:00:00.026,916] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.026,916] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.026,916] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.026,916] <debug> usbd_msc: Ep proc status: 0

[00:00:00.026,977] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.088,012] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.088,012] <debug> usbd_msc: cbw_wait_start

[00:00:00.088,012] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.088,012] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.088,012] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.088,012] <debug> usbd_msc: Ep proc status: 0

[00:00:00.088,012] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.024,047] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.024,047] <debug> usbd_msc: cbw_wait_start

[00:00:00.024,047] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.024,047] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.024,047] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.024,047] <debug> usbd_msc: Ep proc status: 0

[00:00:00.024,047] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.085,083] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.085,083] <debug> usbd_msc: cbw_wait_start

[00:00:00.085,083] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.085,083] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.085,083] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.085,083] <debug> usbd_msc: Ep proc status: 0

[00:00:00.085,144] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.021,118] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.021,118] <debug> usbd_msc: cbw_wait_start

[00:00:00.021,179] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.021,179] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.021,179] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.021,179] <debug> usbd_msc: Ep proc status: 0

[00:00:00.021,179] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.082,214] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.082,214] <debug> usbd_msc: cbw_wait_start

[00:00:00.082,214] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.082,214] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.082,214] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.082,214] <debug> usbd_msc: Ep proc status: 0

[00:00:00.082,214] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.018,249] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.018,249] <debug> usbd_msc: cbw_wait_start

[00:00:00.018,249] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.018,249] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.018,249] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.018,249] <debug> usbd_msc: Ep proc status: 0

[00:00:00.018,310] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.079,284] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.079,284] <debug> usbd_msc: cbw_wait_start

[00:00:00.079,345] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.079,345] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.079,345] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.079,345] <debug> usbd_msc: Ep proc status: 0

[00:00:00.079,345] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.015,380] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.015,380] <debug> usbd_msc: cbw_wait_start

[00:00:00.015,380] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.015,380] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.015,380] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.015,380] <debug> usbd_msc: Ep proc status: 0

[00:00:00.015,380] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.076,416] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.076,416] <debug> usbd_msc: cbw_wait_start

[00:00:00.076,416] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.076,416] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.076,416] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.076,416] <debug> usbd_msc: Ep proc status: 0

[00:00:00.076,477] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.012,451] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.012,451] <debug> usbd_msc: cbw_wait_start

[00:00:00.012,512] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.012,512] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.012,512] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.012,512] <debug> usbd_msc: Ep proc status: 0

[00:00:00.012,512] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.073,547] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.073,547] <debug> usbd_msc: cbw_wait_start

[00:00:00.073,547] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.073,547] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.073,547] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.073,547] <debug> usbd_msc: Ep proc status: 0

[00:00:00.073,547] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.009,582] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.009,582] <debug> usbd_msc: cbw_wait_start

[00:00:00.009,582] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.009,582] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.009,582] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.009,582] <debug> usbd_msc: Ep proc status: 0

[00:00:00.009,643] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.070,617] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.070,617] <debug> usbd_msc: cbw_wait_start

[00:00:00.070,617] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.070,617] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.070,617] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.070,617] <debug> usbd_msc: Ep proc status: 0

[00:00:00.070,678] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.006,713] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.006,713] <debug> usbd_msc: cbw_wait_start

[00:00:00.006,713] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.006,713] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.006,713] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.006,713] <debug> usbd_msc: Ep proc status: 0

[00:00:00.006,713] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.067,749] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.067,749] <debug> usbd_msc: cbw_wait_start

[00:00:00.067,749] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.067,749] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.067,749] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.067,749] <debug> usbd_msc: Ep proc status: 0

[00:00:00.067,749] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.003,784] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.003,784] <debug> usbd_msc: cbw_wait_start

[00:00:00.003,845] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.003,845] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.003,845] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.003,845] <debug> usbd_msc: Ep proc status: 0

[00:00:00.003,845] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.064,880] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.064,880] <debug> usbd_msc: cbw_wait_start

[00:00:00.064,880] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.064,880] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.064,880] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.064,880] <debug> usbd_msc: Ep proc status: 0

[00:00:00.064,880] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.000,915] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.000,915] <debug> usbd_msc: cbw_wait_start

[00:00:00.000,915] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.000,915] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.000,915] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.000,915] <debug> usbd_msc: Ep proc status: 0

[00:00:00.000,915] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.061,950] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.061,950] <debug> usbd_msc: cbw_wait_start

[00:00:00.061,950] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.061,950] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.061,950] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.061,950] <debug> usbd_msc: Ep proc status: 0

[00:00:00.062,011] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.123,046] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.123,046] <debug> usbd_msc: cbw_wait_start

[00:00:00.123,046] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.123,046] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.123,046] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.123,046] <debug> usbd_msc: Ep proc status: 0

[00:00:00.123,046] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.059,082] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.059,082] <debug> usbd_msc: cbw_wait_start

[00:00:00.059,082] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.059,082] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.059,082] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.059,082] <debug> usbd_msc: Ep proc status: 0

[00:00:00.059,082] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.120,117] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.120,117] <debug> usbd_msc: cbw_wait_start

[00:00:00.120,117] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.120,117] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.120,117] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.120,117] <debug> usbd_msc: Ep proc status: 0

[00:00:00.120,178] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.056,213] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.056,213] <debug> usbd_msc: cbw_wait_start

[00:00:00.056,213] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.056,213] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.056,213] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.056,213] <debug> usbd_msc: Ep proc status: 0

[00:00:00.056,213] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.117,248] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.117,248] <debug> usbd_msc: cbw_wait_start

[00:00:00.117,248] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.117,248] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.117,248] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.117,248] <debug> usbd_msc: Ep proc status: 0

[00:00:00.117,248] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.053,283] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.053,283] <debug> usbd_msc: cbw_wait_start

[00:00:00.053,283] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.053,283] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.053,283] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.053,283] <debug> usbd_msc: Ep proc status: 0

[00:00:00.053,344] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.114,379] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.114,379] <debug> usbd_msc: cbw_wait_start

[00:00:00.114,379] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.114,379] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.114,379] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.114,379] <debug> usbd_msc: Ep proc status: 0

[00:00:00.114,379] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.050,415] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.050,415] <debug> usbd_msc: cbw_wait_start

[00:00:00.050,415] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.050,415] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.050,415] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.050,415] <debug> usbd_msc: Ep proc status: 0

[00:00:00.050,415] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.111,450] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.111,450] <debug> usbd_msc: cbw_wait_start

[00:00:00.111,450] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.111,450] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.111,450] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.111,450] <debug> usbd_msc: Ep proc status: 0

[00:00:00.111,511] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.041,442] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.041,442] <debug> usbd_msc: cbw_wait_start

[00:00:00.041,442] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.041,442] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.041,442] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.041,442] <debug> usbd_msc: Ep proc status: 0

[00:00:00.041,442] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.041,442] <debug> usbd_msc: csw_wait_start: 0

us: 0

[00:00:00.047,546] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.047,546] <debug> usbd_msc: cbw_wait_start

[00:00:00.047,546] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.047,546] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.047,546] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.047,546] <debug> usbd_msc: Ep proc status: 0

[00:00:00.047,546] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.062,072] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.062,072] <debug> usbd_msc: cbw_wait_start

[00:00:00.062,072] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.062,072] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.062,072] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.062,072] <debug> usbd_msc: Ep proc status: 0

[00:00:00.062,072] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.062,072] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.062,133] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.093,566] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.093,566] <debug> usbd_msc: cbw_wait_start

[00:00:00.093,566] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.093,566] <debug> usbd_msc: CMD: READCAPACITY10

[00:00:00.093,566] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 8

[00:00:00.093,566] <debug> usbd_msc: Ep proc status: 0

[00:00:00.093,627] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.093,627] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.093,627] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.108,581] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.108,581] <debug> usbd_msc: cbw_wait_start

[00:00:00.108,581] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.108,581] <debug> usbd_msc: CMD: TESTUNITREADY

[00:00:00.108,581] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.108,581] <debug> usbd_msc: Ep proc status: 0

[00:00:00.108,581] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.114,440] <debug> usbd_msc: state: 6, ep out event, status: 1

[00:00:00.114,440] <debug> usbd_msc: cbw_wait_start

[00:00:00.114,440] <debug> usbd_msc: state: 2, ep out event, status: 0

[00:00:00.114,440] <debug> usbd_msc: CMD: INQUIRY

[00:00:00.114,440] <debug> usbd_msc: transfer_in_start: p_buff: 0x20031E98, size: 36

[00:00:00.114,440] <debug> usbd_msc: Ep proc status: 0

[00:00:00.114,440] <debug> usbd_msc: state: 3, ep in event, status: 0

[00:00:00.114,440] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.114,501] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.114,501] <debug> usbd_msc: state: 6, ep out event, status: 1

tus: 0

[00:00:00.114,501] <debug> usbd_msc: CMD: ATA PASS-THROUGH

[00:00:00.114,501] <debug> usbd_msc: csw_wait_start: 0

[00:00:00.114,501] <debug> usbd_msc: Ep proc status: 0

[00:00:00.114,501] <debug> usbd_msc: state: 6, ep in event, status: 0

[00:00:00.031,982] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.038,024] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.038,024] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.038,085] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.109,985] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.115,966] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.116,027] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.116,088] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.033,630] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.039,611] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.039,672] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.039,733] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.111,572] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.117,614] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.117,614] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.117,675] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.093,811] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.099,853] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.099,853] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.099,914] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.046,813] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.052,856] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.052,917] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.052,978] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.029,113] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.035,095] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.035,156] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.035,217] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.107,055] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.113,159] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.113,159] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.018,310] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.090,148] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.096,191] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.096,191] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.096,313] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.043,151] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.049,194] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.049,194] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.049,255] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.025,390] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.031,433] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.031,433] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.031,494] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.007,629] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.013,671] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.013,671] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.013,732] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.085,632] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.091,613] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.091,674] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.091,735] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.067,871] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.073,852] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.073,913] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.074,035] <debug> usbd_msc: state: 0, ep out event, status: 1

[00:00:00.050,170] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.056,152] <debug> app_usbd_core: SETUP: t: 0x80 r: 0x06

[00:00:00.056,213] <debug> app_usbd_core: SETUP: t: 0x00 r: 0x09

[00:00:00.056,274] <debug> usbd_msc: state: 0, ep out event, status: 1

app_usbd_msc.c  file is as follows;

app_usbd_msc-1.c

[Edvin]

Hello,

I noticed that the timestamp from your log isn't chronological? Do you know the reason for that? Is the nRF resetting when the log timer resets? If so, have you checked why it resets? By the way, are the timestamps from the logging module or your terminal?

One example of this is between line 9 and 11. Is this a reset, or just the app_timer/nrf_log acting funny?

Have you tried to print something in the log on startup, and see if that occurs when the log reset the timer?

If you have a reset, can you check the reset register on restart?

[Edvin]

Hello,

I see that our R&D team is discussing whether or not they can spend resources (physical and time) to research this issue by installing the Windows version on a computer. 

In the meantime, they still struggled to understand the timestamp on the logs. Was the ATA PASS the last command issued from the USB host, or was there something after that? I am sorry if this is really obvious for you. It was not to us, unfortunately. 

From their last internal message:

"My suspicion is that there is another ATA-related command issued from Windows which we consider a fail. My candidate is the "ATA SENSE". On Google I found that some Linux versions check for SMART values every 10 seconds and this is my suspicion in this case. Maybe this Windows version does this check in a similar fashion.

Are there any other commands that are not handled? I can't see it from your logs, but I am not sure if there are any resets in the log or not.

BR,

Edvin