From owner-freebsd-bugs@FreeBSD.ORG Sun Aug 8 09:30:27 2004 Return-Path: Delivered-To: freebsd-bugs@hub.freebsd.org Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 2A22716A4CE for ; Sun, 8 Aug 2004 09:30:27 +0000 (GMT) Received: from freefall.freebsd.org (freefall.freebsd.org [216.136.204.21]) by mx1.FreeBSD.org (Postfix) with ESMTP id 0361943D39 for ; Sun, 8 Aug 2004 09:30:27 +0000 (GMT) (envelope-from gnats@FreeBSD.org) Received: from freefall.freebsd.org (gnats@localhost [127.0.0.1]) by freefall.freebsd.org (8.12.11/8.12.11) with ESMTP id i789UQQP030098 for ; Sun, 8 Aug 2004 09:30:26 GMT (envelope-from gnats@freefall.freebsd.org) Received: (from gnats@localhost) by freefall.freebsd.org (8.12.11/8.12.11/Submit) id i789UQjB030097; Sun, 8 Aug 2004 09:30:26 GMT (envelope-from gnats) Resent-Date: Sun, 8 Aug 2004 09:30:26 GMT Resent-Message-Id: <200408080930.i789UQjB030097@freefall.freebsd.org> Resent-From: FreeBSD-gnats-submit@FreeBSD.org (GNATS Filer) Resent-To: freebsd-bugs@FreeBSD.org Resent-Reply-To: FreeBSD-gnats-submit@FreeBSD.org, "Bernd StrauÃß" Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125]) by hub.freebsd.org (Postfix) with ESMTP id 2D1DC16A4CF for ; Sun, 8 Aug 2004 09:20:24 +0000 (GMT) Received: from mailbus.gefoekom.org (mailbus.gefoekom.org [194.145.150.25]) by mx1.FreeBSD.org (Postfix) with ESMTP id A3F2C43D2F for ; Sun, 8 Aug 2004 09:20:22 +0000 (GMT) (envelope-from no_bs@web.de) Received: from mailbus.gefoekom.org (localhost.localdomain [127.0.0.1]) by mailbus.gefoekom.org (Postfix) with ESMTP id 91D38512A3 for ; Sun, 8 Aug 2004 11:22:10 +0200 (CEST) Received: (from uucp@localhost) by mailbus.gefoekom.org (8.12.10/8.12.10/Submit) id i789MAOj018326 for FreeBSD-gnats-submit@freebsd.org; Sun, 8 Aug 2004 11:22:10 +0200 Received: from igate.buzz.mayn.de (igate.buzz.mayn.de [192.168.1.2]) by bserv.buzz.mayn.de (8.12.11/8.12.10) with ESMTP id i789HF8f011894 for ; Sun, 8 Aug 2004 11:17:15 +0200 (CEST) (envelope-from no_bs@web.de) Message-Id: <1091956636.0@igate.buzz.mayn.de> Date: Sun, 8 Aug 2004 11:17:16 +0200 From: "Bernd StrauÃß" To: "FreeBSD gnats submit" X-Send-Pr-Version: gtk-send-pr 0.3.3 Subject: kern/70158: QUIRK: Frontier Labs NEX IA+ Digital Audio Player with USB CF card reader/writer X-BeenThere: freebsd-bugs@freebsd.org X-Mailman-Version: 2.1.1 Precedence: list List-Id: Bug reports List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sun, 08 Aug 2004 09:30:27 -0000 >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: 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: 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: 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: