search

PiSCSI / piscsi

PiSCSI allows a Raspberry Pi to function as emulated SCSI devices (hard disk, CD-ROM, and others) for vintage SCSI-based computers and devices. This is a fork of the RaSCSI project by GIMONS.
https://piscsi.org
BSD 3-Clause "New" or "Revised" License
537 stars 82 forks source link

Listing SCSI devices (or booting) doesn't work on a DEC VAXstation 4000/60 #1404

Closed jbglaw closed 10 months ago

jbglaw commented 10 months ago

Info

Listing the SCSI devices worked fine on a VAXstation 4000/96, but doesn't work on this 4000/60. All other devices are detached, an external terminator is placed. (Exact same setup as previously used on the /96.)

ID 7 is reserved (by default), ID 6 is manually preserved (that's what the SCSI controller on that system actually uses.) ID 1 has a HDD image attached (working with the /96), ID 5 emulates a CD-ROM drive (with a NetBSD VAX Install ISO attached.)

When issueing a show dev command, this log is generated with -L trace when the piscsi process starts:

Dec 22 21:29:21 piscsi PISCSI[477]: SCSI Target Emulator PiSCSI (Backend Service)
Dec 22 21:29:21 piscsi PISCSI[477]: Version 23.11.01  (Dec 22 2023 21:13:57)
Dec 22 21:29:21 piscsi PISCSI[477]: Powered by XM6 TypeG Technology / Copyright (C) 2016-2020 GIMONS
Dec 22 21:29:21 piscsi PISCSI[477]: Copyright (C) 2020-2023 Contributors to the PiSCSI project
Dec 22 21:29:21 piscsi PISCSI[477]: Connection type: FULLSPEC
Dec 22 21:29:22 piscsi PISCSI[477]: [2023-12-22 21:29:22.009] [info] Set log level to 'trace'
Dec 22 21:29:22 piscsi PISCSI[477]: [2023-12-22 21:29:22.010] [info] Detected Raspberry Pi 2/3
Dec 22 21:29:22 piscsi PISCSI[477]: [2023-12-22 21:29:22.040] [info] Reserved ID(s) set to 7
Dec 22 21:29:22 piscsi PISCSI[477]: [2023-12-22 21:29:22.043] [info] No devices currently attached.
Dec 22 21:29:22 piscsi PISCSI[477]: No devices currently attached.
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.137] [trace] Received DETACH_ALL command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.137] [info] Detached all devices
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.139] [trace] Received RESERVE_IDS command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.139] [info] Reserved ID(s) set to 6
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.142] [trace] Received DEVICES_INFO command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.144] [trace] Received DEVICE_TYPES_INFO command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.150] [trace] Received ATTACH command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.150] [info] Validating: operation=ATTACH, command params='locale=en', 'token=???', device=1:0, type=SCHD, device params='file=/home/pi/images/DEC_RZ28M-KA46-VS4000m60.hds', vendor='DEC', product='RZ28M    (C) DEC', revision='0568', block size=512
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.151] [info] Executing: operation=ATTACH, command params='locale=en', 'token=???', device=1:0, type=SCHD, device params='file=/home/pi/images/DEC_RZ28M-KA46-VS4000m60.hds', vendor='DEC', product='RZ28M    (C) DEC', revision='0568', block size=512
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.152] [info] Attached SCHD 1:0
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.153] [warning] Can't write protobuf message data
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.154] [trace] Received DEVICES_INFO command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.156] [trace] Received DEVICE_TYPES_INFO command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.160] [trace] Received ATTACH command
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.160] [info] Validating: operation=ATTACH, command params='locale=en', 'token=???', device=5:0, type=SCCD, device params='file=/home/pi/images/NetBSD-10.99.10-vax.iso', vendor='DEC', product='RRD42    (C) DEC', revision='4.5d', block size=512
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.165] [info] Executing: operation=ATTACH, command params='locale=en', 'token=???', device=5:0, type=SCCD, device params='file=/home/pi/images/NetBSD-10.99.10-vax.iso', vendor='DEC', product='RRD42    (C) DEC', revision='4.5d', block size=512
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.165] [info] Attached read-only SCCD 5:0
Dec 22 21:29:36 piscsi PISCSI[477]: [2023-12-22 21:29:36.166] [warning] Can't write protobuf message data

Upon entering the show dev command, the firmware recognizes that there is "something", but it fails to identify:

>>> sh dev                                                                   

  VMS/VMB      ADDR      DEVTYPE    NUMBYTES     RM/FX    WP    DEVNAM      REV
  -------      ----      -------    --------     -----    --    ------      ---
  ESA0         08-00-2B-2E-8A-FE
               A/1/0
               A/1/1
               A/1/2
               A/1/3
               A/1/4
               A/1/5
               A/1/6
               A/1/7
               A/5/0
               A/5/1
               A/5/2
               A/5/3
               A/5/4
               A/5/5
               A/5/6
               A/5/7
 ..HostID..    A/6       INITR

(Notice that ID 1 and ID 5 are showing up, but there's nothing useable detected.)

piscsi's log during firmware's bus scanning:

Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.635] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.635] [trace] (ID 1) - Selection phase
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.635] [trace] (ID 1) - Selection completed
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.635] [trace] (ID 1) - Command phase
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.647] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.647] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.647] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:20 piscsi PISCSI[477]: [2023-12-22 21:34:20.647] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.647] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.647] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.647] [trace] (ID 1) - Selection phase
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.647] [trace] (ID 1) - Selection completed
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.647] [trace] (ID 1) - Command phase
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.658] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.658] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.659] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:23 piscsi PISCSI[477]: [2023-12-22 21:34:23.659] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.659] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.659] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.659] [trace] (ID 1) - Selection phase
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.659] [trace] (ID 1) - Selection completed
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.659] [trace] (ID 1) - Command phase
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.670] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.670] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.670] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:26 piscsi PISCSI[477]: [2023-12-22 21:34:26.670] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:29 piscsi PISCSI[477]: [2023-12-22 21:34:29.670] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.670] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.670] [trace] (ID 1) - Selection phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.670] [trace] (ID 1) - Selection completed
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.670] [trace] (ID 1) - Command phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.682] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.682] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.682] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:29.682] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.682] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.682] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.682] [trace] (ID 1) - Selection phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.682] [trace] (ID 1) - Selection completed
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.682] [trace] (ID 1) - Command phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.694] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.694] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.694] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:32.694] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.694] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.694] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.694] [trace] (ID 1) - Selection phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.694] [trace] (ID 1) - Selection completed
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.694] [trace] (ID 1) - Command phase
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.706] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.706] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.706] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:38 piscsi PISCSI[477]: [2023-12-22 21:34:35.706] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.381] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.381] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.381] [trace] (ID 1) - Selection phase
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.381] [trace] (ID 1) - Selection completed
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.381] [trace] (ID 1) - Command phase
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.392] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.392] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.392] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:39 piscsi PISCSI[477]: [2023-12-22 21:34:39.392] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.392] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.392] [trace] (ID 1) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.392] [trace] (ID 1) - Selection phase
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.392] [trace] (ID 1) - Selection completed
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.392] [trace] (ID 1) - Command phase
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.404] [trace] (ID 1) - Received unknown command: $0
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.404] [debug] (ID 1) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.404] [trace] (ID 1) - Status phase, status is $02
Dec 22 21:34:42 piscsi PISCSI[477]: [2023-12-22 21:34:42.404] [trace] (ID 1) - Sending data, offset: 0, length: 1
Dec 22 21:34:45 piscsi PISCSI[477]: [2023-12-22 21:34:45.404] [trace] (ID 1) - Bus Free phase
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.167] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.167] [trace] (ID 5) - Selection phase
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.167] [trace] (ID 5) - Selection completed
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.167] [trace] (ID 5) - Command phase
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.179] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.179] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.179] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:34:46 piscsi PISCSI[477]: [2023-12-22 21:34:46.179] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:34:49 piscsi PISCSI[477]: [2023-12-22 21:34:49.179] [trace] (ID 5) - Bus Free phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.179] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.179] [trace] (ID 5) - Selection phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.179] [trace] (ID 5) - Selection completed
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.179] [trace] (ID 5) - Command phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.191] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.191] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.191] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:49.191] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.191] [trace] (ID 5) - Bus Free phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.191] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.191] [trace] (ID 5) - Selection phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.191] [trace] (ID 5) - Selection completed
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.191] [trace] (ID 5) - Command phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.202] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.202] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.202] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:52.202] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.202] [trace] (ID 5) - Bus Free phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.203] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.203] [trace] (ID 5) - Selection phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.203] [trace] (ID 5) - Selection completed
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.203] [trace] (ID 5) - Command phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.214] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.214] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.214] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:55.214] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.381] [trace] (ID 5) - Bus Free phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.381] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.381] [trace] (ID 5) - Selection phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.381] [trace] (ID 5) - Selection completed
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.381] [trace] (ID 5) - Command phase
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.392] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.392] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.392] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:34:58 piscsi PISCSI[477]: [2023-12-22 21:34:58.392] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.392] [trace] (ID 5) - Bus Free phase
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.392] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.392] [trace] (ID 5) - Selection phase
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.392] [trace] (ID 5) - Selection completed
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.392] [trace] (ID 5) - Command phase
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.404] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.404] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.404] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:35:01 piscsi PISCSI[477]: [2023-12-22 21:35:01.404] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:35:04 piscsi PISCSI[477]: [2023-12-22 21:35:04.404] [trace] (ID 5) - Bus Free phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.404] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.404] [trace] (ID 5) - Selection phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.404] [trace] (ID 5) - Selection completed
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.404] [trace] (ID 5) - Command phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.415] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.415] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.415] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:04.415] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.415] [trace] (ID 5) - Bus Free phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.415] [trace] (ID 5) - ++++ Starting processing for initiator ID 6
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.415] [trace] (ID 5) - Selection phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.415] [trace] (ID 5) - Selection completed
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.416] [trace] (ID 5) - Command phase
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.427] [trace] (ID 5) - Received unknown command: $0
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.427] [debug] (ID 5) - Error status: Sense Key $05, ASC $20
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.427] [trace] (ID 5) - Status phase, status is $02
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:07.427] [trace] (ID 5) - Sending data, offset: 0, length: 1
Dec 22 21:35:10 piscsi PISCSI[477]: [2023-12-22 21:35:10.427] [trace] (ID 5) - Bus Free phase

So I think that cables and termination are correct. But does Received unknown command: $0 ring a bell?

jbglaw commented 10 months ago

After swapping cables and terminators, my conclusion is that PiSCSI is working fine. What's been broken is one of the internal SCSI cable's plugs.

Using a different one let the system boot up properly.