kern/70158: QUIRK: Frontier Labs NEX IA+ Digital Audio Player with USB CF card reader/writer

Bernd StrauÃß no_bs at web.de
Sun Aug 8 02:30:27 PDT 2004


>Number:         70158
>Category:       kern
>Synopsis:       QUIRK: Frontier Labs NEX IA+ Digital Audio Player with USB CF card reader/writer
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    freebsd-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          change-request
>Submitter-Id:   current-users
>Arrival-Date:   Sun Aug 08 09:30:26 GMT 2004
>Closed-Date:
>Last-Modified:
>Originator:     Bernd Straußß
>Release:        FreeBSD 5.2-CURRENT i386
>Organization:
>Environment:


System: FreeBSD 5.2-CURRENT #48: Sun Aug  8 10:12:12 CEST 2004

#camcontrol inquiry da0
pass1: <FL NexIA+ Digital 0102> Removable Direct Access SCSI-0 device
pass1: Serial Number \
pass1: 1.000MB/s transfers

This is a mp3 player which works with a removable compact flash card as
storage device. When connected to a PC via a USB cable it doubles as
a compact flash card reader/writer.

Manufacturer: Frontier Labs (http://www.frontierlabs.com),
Vendor-ID: 0x0451 (same as TI in usbdevs)
Model: Nex IA+ (product-Id 0x5409)
Transport type: USB/umass0-device, SCSI/BBB

#usbdevs -v
Controller /dev/usb0:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000), VIA(0x0000), rev 1.00
 port 1 powered
 port 2 addr 2: full speed, self powered, config 1, NEX IA+ Digital Audio Player(0x5409), Frontier Labs(0x0451), rev 0.01
Controller /dev/usb1:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000), VIA(0x0000), rev 1.00
 port 1 powered
 port 2 powered
Controller /dev/usb2:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000), VIA(0x0000), rev 1.00
 port 1 powered
 port 2 powered
Controller /dev/usb3:
addr 1: full speed, self powered, config 1, UHCI root hub(0x0000), VIA(0x0000), rev 1.00
 port 1 powered
 port 2 powered


>Description:


With a stock kernel, the Player doesn't work after plugging it in.
No /dev/da0* devices show up, the player itself hangs. Upon
removal of the cable link , the computer crashes most of the
time.

After adding the SCSI-DA-Quirk the Player works. The compact
flash card shows up as /dev/da0s1 and can be mounted and
read/written to. After disconnecting, the computer and the
player continue to work.

The problem seems to be that the player doesn't like the
SYNCHRONIZE CACHE command which therefore must not be
issued.

Output of /var/log/messages with a stock kernel and
debugging enabled:

Aug  8 09:49:50 *** kernel: umass0: Frontier Labs NEX IA+ Digital Audio Player, rev 1.10/0.01, addr 2
Aug  8 09:49:50 *** kernel: umass0: SCSI over Bulk-Only; quirks = 0x0000
Aug  8 09:49:50 *** kernel: umass0: Get Max Lun not supported (STALLED)
Aug  8 09:49:50 *** kernel: umass0:4:-1:-1:XPT_PATH_INQ:.
Aug  8 09:49:50 *** kernel: umass0:4:0:-1: Attached to scbus4
Aug  8 09:49:50 *** kernel: umass0: Attach finished
Aug  8 09:49:51 *** kernel: scbus4: scanning for umass0:4:0:-1
Aug  8 09:49:51 *** kernel: umass0:4:-1:-1:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 0 0 0 24 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 1: cmd = 6b (0x120000002400), data = 36b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc2319284, buflen=36
Aug  8 09:49:51 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 09:49:51 *** kernel: umass0: 0x 30313032
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 1: sig = 0x53425355 (valid), tag = 1, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 0 0 0 60 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/96b data/18b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 2: cmd = 6b (0x120000006000), data = 96b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc2319284, buflen=96
Aug  8 09:49:51 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 09:49:51 *** kernel: umass0: 0x 30313032323030332d31322d32340000 ...
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 2: sig = 0x53425355 (valid), tag = 2, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/255b data/18b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 3: cmd = 6b (0x12018000ff00), data = 255b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc2419800, buflen=255
Aug  8 09:49:51 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 09:49:51 *** kernel: umass0: 0x 30313032323030332d31322d32340000 ...
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 3: sig = 0x53425355 (valid), tag = 3, res = 159, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SET_TRAN_SETTINGS:.
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x00, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 4: cmd = 6b (0x000000000000), data = 0b, dir = out
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: no data phase
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 4: sig = 0x53425355 (valid), tag = 4, res = 159, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 5: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 09:49:51 *** kernel: xpt0: Rescan succeeded
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc1a6c440, buflen=8
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 5: sig = 0x53425355 (valid), tag = 5, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: da0 at umass-sim0 bus 0 target 0 lun 0
Aug  8 09:49:51 *** kernel: da0: <FL NexIA+ Digital 0102> Removable Direct Access SCSI-0 device 
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 09:49:51 *** kernel: da0: 1.000MB/s transfers
Aug  8 09:49:51 *** kernel: da0: 488MB (999873 512 byte sectors: 64H 32S/T 488C)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 6: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20fb480, buflen=8
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 6: sig = 0x53425355 (valid), tag = 6, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 7: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: no data phase
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 7: sig = 0x53425355 (valid), tag = 7, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 0 0 0 1 0 0 1 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 8: cmd = 10b (0x280000000001...), data = 512b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x 26120220000000000000000008440602 buffer=0xc2318000, buflen=512
Aug  8 09:49:51 *** kernel: umass0: 0x 4e4f204e414d45000000000000000000
Aug  8 09:49:51 *** kernel: umass0: 0x 313032346d2a34000000000000000000 ...
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 8: sig = 0x53425355 (valid), tag = 8, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 0 0 0 0 0 0 1 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 9: cmd = 10b (0x280000000000...), data = 512b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc21fd300, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: 0x deab0000000000000000000000000000 buffer=0xc2319000, buflen=512
Aug  8 09:49:51 *** kernel: umass0: 0x 00000000000000000000000000000000
Aug  8 09:49:51 *** kernel: umass0: 0x 00000000000000000000000000000000 ...
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 9: sig = 0x53425355 (valid), tag = 9, res = 0, status = 0x00 (good)
Aug  8 09:49:51 *** kernel: cam_debug: xpt_release_ccb
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 09:49:51 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: cam_debug: calling periph start
Aug  8 09:49:51 *** kernel: (da0:umass-sim0:0:0:0): SYNCHRONIZE CACHE. CDB: 35 0 0 0 0 0 0 0 0 0 
Aug  8 09:49:51 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 09:49:51 *** kernel: cam_debug: Inserting onto queue
Aug  8 09:49:51 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 09:49:51 *** kernel: cam_debug: running device 0xc2319200
Aug  8 09:49:51 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x35, flags: 0xc0, 10b cmd/0b data/32b sense
Aug  8 09:49:51 *** kernel: umass0: CBW 10: cmd = 10b (0x350000000000...), data = 0b, dir = out
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: no data phase
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc21fd000, NORMAL_COMPLETION
Aug  8 09:49:51 *** kernel: umass0: CSW 10: sig = 0x53425355 (valid), tag = 10, res = 0, status = 0x01 (failed)
Aug  8 09:49:51 *** kernel: umass0: Command Failed, res = 0
Aug  8 09:49:51 *** kernel: umass0: Fetching 32b sense data
Aug  8 09:49:51 *** kernel: umass0: CBW 11: cmd = 6b (0x030000002000), data = 32b, dir = in
Aug  8 09:49:51 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, STALLED
Aug  8 09:49:51 *** kernel: umass0: failed to send CBW
Aug  8 09:49:51 *** kernel: umass0: Bulk Reset



>How-To-Repeat:





>Fix:


Add this to the umass-quirks section in /sys/cam/scsi/scsi_da.c:


        {
                /*
                 * Frontier Labs NEX IA+ Digital Audio Player, rev 1.10/0.01
                 * PR: kern/???
                 */
                {T_DIRECT, SIP_MEDIA_REMOVABLE, "FL" , "NexIA+*", "*"},
                /*quirks*/ DA_Q_NO_SYNC_CACHE
        },


Output of /var/log/messages with a modified kernel:

Aug  8 10:27:43 *** kernel: umass0: Frontier Labs NEX IA+ Digital Audio Player, rev 1.10/0.01, addr 2
Aug  8 10:27:43 *** kernel: umass0: SCSI over Bulk-Only; quirks = 0x0000
Aug  8 10:27:43 *** kernel: umass0: Get Max Lun not supported (STALLED)
Aug  8 10:27:43 *** kernel: umass0:4:-1:-1:XPT_PATH_INQ:.
Aug  8 10:27:43 *** kernel: umass0:4:0:-1: Attached to scbus4
Aug  8 10:27:43 *** kernel: umass0: Attach finished
Aug  8 10:27:44 *** kernel: scbus4: scanning for umass0:4:0:-1
Aug  8 10:27:44 *** kernel: umass0:4:-1:-1:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 0 0 0 24 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/36b data/18b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 1: cmd = 6b (0x120000002400), data = 36b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc20c8884, buflen=36
Aug  8 10:27:44 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 10:27:44 *** kernel: umass0: 0x 30313032
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 1: sig = 0x53425355 (valid), tag = 1, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 0 0 0 60 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/96b data/18b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 2: cmd = 6b (0x120000006000), data = 96b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc20c8884, buflen=96
Aug  8 10:27:44 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 10:27:44 *** kernel: umass0: 0x 30313032323030332d31322d32340000 ...
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 2: sig = 0x53425355 (valid), tag = 2, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (probe0:umass-sim0:0:0:0): INQUIRY. CDB: 12 1 80 0 ff 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x12, flags: 0x40, 6b cmd/255b data/18b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 3: cmd = 6b (0x12018000ff00), data = 255b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 008000025c000000464c202020202020 buffer=0xc20a9e00, buflen=255
Aug  8 10:27:44 *** kernel: umass0: 0x 4e657849412b204469676974616c2020
Aug  8 10:27:44 *** kernel: umass0: 0x 30313032323030332d31322d32340000 ...
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 3: sig = 0x53425355 (valid), tag = 3, res = 159, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SET_TRAN_SETTINGS:.
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (probe0:umass-sim0:0:0:0): TEST UNIT READY. CDB: 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x00, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 4: cmd = 6b (0x000000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 4: sig = 0x53425355 (valid), tag = 4, res = 159, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 5: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: xpt0: Rescan succeeded
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff450, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 5: sig = 0x53425355 (valid), tag = 5, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: da0 at umass-sim0 bus 0 target 0 lun 0
Aug  8 10:27:44 *** kernel: da0: <FL NexIA+ Digital 0102> Removable Direct Access SCSI-0 device 
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_GET_TRAN_SETTINGS:.
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_PATH_INQ:.
Aug  8 10:27:44 *** kernel: da0: 1.000MB/s transfers
Aug  8 10:27:44 *** kernel: da0: 488MB (999873 512 byte sectors: 64H 32S/T 488C)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 6: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff2c0, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 6: sig = 0x53425355 (valid), tag = 6, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 7: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 7: sig = 0x53425355 (valid), tag = 7, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 0 0 0 1 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 8: cmd = 10b (0x280000000001...), data = 512b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 26120220000000000000000008440602 buffer=0xc22ede00, buflen=512
Aug  8 10:27:44 *** kernel: umass0: 0x 4e4f204e414d45000000000000000000
Aug  8 10:27:44 *** kernel: umass0: 0x 313032346d2a34000000000000000000 ...
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 8: sig = 0x53425355 (valid), tag = 8, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 0 0 0 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 9: cmd = 10b (0x280000000000...), data = 512b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x deab0000000000000000000000000000 buffer=0xc22edc00, buflen=512
Aug  8 10:27:44 *** kernel: umass0: 0x 00000000000000000000000000000000
Aug  8 10:27:44 *** kernel: umass0: 0x 00000000000000000000000000000000 ...
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 9: sig = 0x53425355 (valid), tag = 9, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 10: cmd = 6b (0x1e0000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 10: sig = 0x53425355 (valid), tag = 10, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 11: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff870, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 11: sig = 0x53425355 (valid), tag = 11, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 12: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 12: sig = 0x53425355 (valid), tag = 12, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ(10). CDB: 28 0 0 0 0 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x28, flags: 0x40, 10b cmd/512b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 13: cmd = 10b (0x280000000000...), data = 512b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x deab0000000000000000000000000000 buffer=0xc22edc00, buflen=512
Aug  8 10:27:44 *** kernel: umass0: 0x 00000000000000000000000000000000
Aug  8 10:27:44 *** kernel: umass0: 0x 00000000000000000000000000000000 ...
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 13: sig = 0x53425355 (valid), tag = 13, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 14: cmd = 6b (0x1e0000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 14: sig = 0x53425355 (valid), tag = 14, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 15: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff6b0, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 15: sig = 0x53425355 (valid), tag = 15, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 16: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 16: sig = 0x53425355 (valid), tag = 16, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 17: cmd = 6b (0x1e0000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 17: sig = 0x53425355 (valid), tag = 17, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 18: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff800, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 18: sig = 0x53425355 (valid), tag = 18, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 19: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 19: sig = 0x53425355 (valid), tag = 19, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 20: cmd = 6b (0x1e0000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 20: sig = 0x53425355 (valid), tag = 20, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): READ CAPACITY. CDB: 25 0 0 0 0 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x25, flags: 0x40, 10b cmd/8b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 21: cmd = 10b (0x250000000000...), data = 8b, dir = in
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 3 (BBB Data), xfer=0xc20aab00, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: 0x 000f41c000000200 buffer=0xc20ff8b0, buflen=8
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 21: sig = 0x53425355 (valid), tag = 21, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 1 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 22: cmd = 6b (0x1e0000000100), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 22: sig = 0x53425355 (valid), tag = 22, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_allocq
Aug  8 10:27:44 *** kernel: cam_debug:    qfrozen_cnt == 0x0, entries == 1, openings == 1, active == 0
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: cam_debug: calling periph start
Aug  8 10:27:44 *** kernel: (da0:umass-sim0:0:0:0): PREVENT ALLOW MEDIUM REMOVAL. CDB: 1e 0 0 0 0 0 
Aug  8 10:27:44 *** kernel: cam_debug: xpt_schedule_dev
Aug  8 10:27:44 *** kernel: cam_debug: Inserting onto queue
Aug  8 10:27:44 *** kernel: cam_debug: xpt_run_dev_sendq
Aug  8 10:27:44 *** kernel: cam_debug: running device 0xc20c8800
Aug  8 10:27:44 *** kernel: umass0:4:0:0:XPT_SCSI_IO: cmd: 0x1e, flags: 0xc0, 6b cmd/0b data/32b sense
Aug  8 10:27:44 *** kernel: umass0: CBW 23: cmd = 6b (0x1e0000000000), data = 0b, dir = out
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 2 (BBB CBW), xfer=0xc1a4e200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: no data phase
Aug  8 10:27:44 *** kernel: umass0: Handling BBB state 5 (BBB CSW, 1st attempt), xfer=0xc1dc1200, NORMAL_COMPLETION
Aug  8 10:27:44 *** kernel: umass0: CSW 23: sig = 0x53425355 (valid), tag = 23, res = 0, status = 0x00 (good)
Aug  8 10:27:44 *** kernel: cam_debug: xpt_release_ccb



>Release-Note:
>Audit-Trail:
>Unformatted:


More information about the freebsd-bugs mailing list