piscsi icon indicating copy to clipboard operation
piscsi copied to clipboard

[ASR-10] Can't mount sample CDROM

Open lukexi opened this issue 1 year ago • 6 comments

Info

  • Which version of Pi are you using: 3B+
  • Which github revision of software: f0c36f
  • Which board version: 2.4a
  • Which computer is the RaSCSI connected to: Ensoniq ASR-10

Describe the issue

Attempting to mount a SCSI CD-ROM (an Ensoniq Sample CD ISO, via Command>Directory>Change Storage Device on the ASR) fails with this error

Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.566] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.566] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=3
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.566] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() Command Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[0]=$03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[1]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[2]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[3]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[4]=$0E
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Command() CDB[5]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Execute() Execution phase command $03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = PrimaryDevice; DWORD = unsigned int] Executing RequestSense ($03)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] std::vector<unsigned char> PrimaryDevice::HandleRequestSense() Status $00, Sense Key $00, ASC $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::DataIn() Going into Data-in Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Send() Sending handhake with offset 0, length 14
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Send() Move to next phase datain (6)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::Status() Status Phase $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Send() Move to next phase status (8)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::MsgIn() Message In phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.567] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] void ScsiController::Send() Move to next phase msgin (9)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::BusFree() Bus free phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=3
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() Command Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[0]=$12
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[1]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[2]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[3]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[4]=$24
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::Command() CDB[5]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] void ScsiController::Execute() Execution phase command $12
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $12
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = PrimaryDevice; DWORD = unsigned int] Executing Inquiry ($12)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual void ScsiController::DataIn() Going into Data-in Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.568] [trace] void ScsiController::Send() Sending handhake with offset 0, length 36
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] void ScsiController::Send() Move to next phase datain (6)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual void ScsiController::Status() Status Phase $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] void ScsiController::Send() Move to next phase status (8)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual void ScsiController::MsgIn() Message In phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] void ScsiController::Send() Move to next phase msgin (9)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.569] [trace] virtual void ScsiController::BusFree() Bus free phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=3
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() Command Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[0]=$03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[1]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[2]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[3]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[4]=$0E
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Command() CDB[5]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] void ScsiController::Execute() Execution phase command $03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $03
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = PrimaryDevice; DWORD = unsigned int] Executing RequestSense ($03)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] std::vector<unsigned char> PrimaryDevice::HandleRequestSense() Status $00, Sense Key $00, ASC $53
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::DataIn() Going into Data-in Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] void ScsiController::Send() Sending handhake with offset 0, length 14
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] void ScsiController::Send() Move to next phase datain (6)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual void ScsiController::Status() Status Phase $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.570] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] void ScsiController::Send() Move to next phase status (8)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::MsgIn() Message In phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] void ScsiController::Send() Move to next phase msgin (9)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::BusFree() Bus free phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=3
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::Command() Command Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.571] [trace] virtual void ScsiController::Command() CDB[0]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() CDB[1]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() CDB[2]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() CDB[3]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() CDB[4]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() CDB[5]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void ScsiController::Execute() Execution phase command $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = PrimaryDevice; DWORD = unsigned int] Executing TestUnitReady ($00)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void PrimaryDevice::CheckReady() Device is ready
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Status() Status Phase $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void ScsiController::Send() Move to next phase status (8)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::MsgIn() Message In phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] void ScsiController::Send() Move to next phase msgin (9)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::BusFree() Bus free phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=3
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.572] [trace] virtual void ScsiController::Command() Command Phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[0]=$15
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[1]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[2]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[3]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[4]=$0C
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Command() CDB[5]=$00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] void ScsiController::Execute() Execution phase command $15
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $15
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = ModePageDevice; DWORD = unsigned int] Executing ModeSelect6 ($15)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::DataOut() Data out phase
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] void ScsiController::Receive()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] void ScsiController::Receive() Length is 12 bytes
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is unknown
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] void ScsiController::Receive()
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] void ScsiController::Receive() ctrl.phase: 7 (dataout)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [debug] Error status: Sense Key $05, ASC $20, ASCQ $00
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Error(scsi_defs::sense_key, scsi_defs::asc, scsi_defs::status) Error (to status phase)
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::Status() Status Phase $02
Sep 10 22:26:39 seascape-seastone RASCSI[5527]: [2022-09-10 22:26:39.573] [trace] virtual void ScsiController::BusFree() Bus free phase

lukexi avatar Sep 10 '22 21:09 lukexi

Attempting to rename the .iso to .hds as suggested in the Wiki (https://github.com/akuker/RaSCSI/wiki/RaSCSI-for-Hardware-Samplers#compatibility) works! But is it worth keeping this open to debug why it won't work as a CD-ROM image?

lukexi avatar Sep 10 '22 21:09 lukexi

Ah, I spoke too soon. It "works" in that I can at least browse the top level directories, but attempting to enter one on the ASR results in:

[2022-09-10 22:33:22.674] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.674] [trace] virtual void ScsiController::Selection() Selection Phase Target ID=1
[2022-09-10 22:33:22.674] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.674] [trace] virtual void ScsiController::Command() Command Phase
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[0]=$00
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[1]=$00
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[2]=$00
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[3]=$00
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[4]=$00
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Command() CDB[5]=$00
[2022-09-10 22:33:22.675] [trace] void ScsiController::Execute() Execution phase command $00
[2022-09-10 22:33:22.675] [debug] ++++ CMD ++++ void ScsiController::Execute() Executing command $00
[2022-09-10 22:33:22.675] [debug] bool Dispatcher<T>::Dispatch(T*, DWORD) [with T = PrimaryDevice; DWORD = unsigned int] Executing TestUnitReady ($00)
[2022-09-10 22:33:22.675] [trace] void PrimaryDevice::CheckReady() Device is ready
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::Status() Status Phase $00
[2022-09-10 22:33:22.675] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.675] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
[2022-09-10 22:33:22.675] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.675] [trace] void ScsiController::Send() Move to next phase status (8)
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::MsgIn() Message In phase
[2022-09-10 22:33:22.675] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
[2022-09-10 22:33:22.675] [trace] void ScsiController::Send() Sending handhake with offset 0, length 1
[2022-09-10 22:33:22.675] [trace] virtual BUS::phase_t ScsiController::Process(int) Initiator ID is 3
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::MsgIn() Transitioning to Send()
[2022-09-10 22:33:22.675] [trace] void ScsiController::Send() Move to next phase msgin (9)
[2022-09-10 22:33:22.675] [trace] virtual void ScsiController::BusFree() Bus free phase

lukexi avatar Sep 10 '22 21:09 lukexi

(And a "File Operation Error" message on the ASR)

lukexi avatar Sep 10 '22 21:09 lukexi

@chickeneps I've seen you say the ASR is working in the RaSCSI Discord, do you have a description of what worked for you? I haven't had any luck with either CD-ROMs or formatting disks...

lukexi avatar Sep 10 '22 22:09 lukexi

I attach like this: rasctl -i 4 -c attach -t hd -f /home/pi/images/myimage.hda

myimage.hda is 2GB large, nothing more, but it should work on anything less.

I plug the RaSCSI via M/M DB25 adapter and termination is on, on the RaSCSI. I've used Pi Zero 1.1, 1.3, 2, and Pi 3. All test thoroughly. My test is 1) do a format from the ASR-10, save the OS, and write the default directories. Then I power cycle everything and see if the ASR-10 boots off the RaSCSI. Then, I COMMAND STORAGE DEVICE to a valid Ensoniq image and load large files (like 4000 blocks) and save them to the newly formatted image.

Otherwise, nothing special.

chickeneps avatar Sep 10 '22 23:09 chickeneps

@lukexi Did you get this to work with the last piece of advice?

rdmark avatar Sep 22 '22 15:09 rdmark

@lukexi Can you please provide feedback, based on the current develop branch? Your first log shows that the MODE SELECT command reported an error. (You second log does not show any error condition that was logged.) The MODE SELECT implementation was updated recently. If there is still an issue, please provide an updated rascsi log, but only if the log clearly reports an error. A log without an error message on the rascsi side is unlikely to help with resolving your problem.

uweseimet avatar Nov 03 '22 20:11 uweseimet