[Hu Gang <hugang@so...>]

On Thu, 30 Aug 2012 18:11:35 +0500
berk <berk131@...> wrote:

> Hello,
> 
> I have a LSI Ultra320 Wide SCSI(SPI DB68
> connector) card and a Adaptec aic7880(SPI DB68 connector) controller, I
> want to make LSI Ultra320 as target, Adaptec aic7880 as initiator on
> another i386 PC. I have tried
> to use mpt_scst for target, but I failed, these are my operating steps:

make sure you must using 1030T for target side, LSI 1030 seem has some 
target bug, so can not work well in target mode.

also you can using aic7880 as target mode too.

> 
> 1.lsiutil gives -
> Current active firmware version is 01032300 (1.03.35)
> Firmware image's version is MPTFW-01.03.35.00-IT
> LSI Logic
> x86 BIOS image's version is MPTBIOS-5.05.15 (2003.12.04)
> 
> 2.SCST from svn cat /proc/scsi_tgt/version
> 3.0.0-pre1-procfs
> EXTRACHECKS
> DEBUG
> 
> 3.modprobe scst mpt_scst scst_vdisk
> 
> 4.echo "all" >/proc/scsi_tgt/trace_level
> 
> 5.Adding handler scstadmin -adddev DISK00 -handler vdisk -path
> /home/pojos/vdisk0
> cat /proc/scsi_tgt/vdisk/vdisk
> Name Size(MB) Block size Options File name T10 device id
> DISK00 1 512 /home/pojos/vdisk0 404d70ea-DISK00
> 
> 6.Assigning to Default group by scstadmin -assigndev DISK00 -group Default
> -lun 0
> cat /proc/scsi_tgt/groups/Default/devices
> Device (host:ch:id:lun or name) LUN Options
> DISK00 0
> 
> 7.Enabling target mode by echo "target:enable" > /proc/scsi_tgt/mpt_scst/0
> cat /proc/scsi_tgt/mpt_scst/0
> ProductID :0x0202 (LSI53C1030 B2)
> Target Enable :True
> Target ID :1
> Capabilities :0xa07f0807
> PhysicalInterface:0xfe000002
> Configuration :0x20001
> OnBusTimerValue :0x0
> TargetConfig :0x1
> IDConfig :0x0
> PortFlags :0x0
> PortSettings :0x205
> Device 00: 0xa07f0807, 0x0
> 
> 8.After loading aic7xxx module on initiator side, i have see scanning scsi
> bus for tagets,and resets on target machine,
> but no any targets was found
> 
> 
> 9.traces

can you send us the log as attached file.

> this kernel trace on target
> Aug 30 22:00:55 localhost kernel: [ 2600.193621] ioc0 Ext Bus Reset on port
> 0
> Aug 30 22:01:10 localhost kernel: [ 2615.221035] [0]: ENTRY
> scst_register_session
> Aug 30 22:01:10 localhost kernel: [ 2615.221040] [0]: ENTRY
> scst_alloc_session
> Aug 30 22:01:10 localhost kernel: [ 2615.221049] [0]: EXIT
> scst_alloc_session
> Aug 30 22:01:10 localhost kernel: [ 2615.221055] [0]:
> scst_sess_get:658:Incrementing sess f681e000 refcnt (new value 1)
> Aug 30 22:01:10 localhost kernel: [ 2615.221059] [0]:
> scst_sess_get:658:Incrementing sess f681e000 refcnt (new value 2)
> Aug 30 22:01:10 localhost kernel: [ 2615.221064] [0]:
> scst_register_session:6583:Adding sess f681e000 to scst_sess_init_list
> Aug 30 22:01:10 localhost kernel: [ 2615.221070] [0]: EXIT
> scst_register_session
> Aug 30 22:01:10 localhost kernel: [ 2615.221082] [2419]:
> scst_global_mgmt_thread:6748:Removing sess f681e000 from scst_sess_init_list
> Aug 30 22:01:10 localhost kernel: [ 2615.221085] [2419]: ENTRY
> scst_init_session
> Aug 30 22:01:10 localhost kernel: [ 2615.221088] [2419]: ENTRY
> __scst_find_acg
> Aug 30 22:01:10 localhost kernel: [ 2615.221090] [2419]: ENTRY
> scst_find_acg_by_name_wild
> Aug 30 22:01:10 localhost kernel: [ 2615.221093] [2419]: EXIT
> scst_find_acg_by_name_wild: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.221096] [2419]: ENTRY
> scst_find_acg_by_name
> Aug 30 22:01:10 localhost kernel: [ 2615.221099] [2419]: EXIT
> scst_find_acg_by_name: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.221101] [2419]: EXIT
> __scst_find_acg: 0xf7082c00
> Aug 30 22:01:10 localhost kernel: [ 2615.221106] [2419]: scst:
> scst_init_session:6430:Using security group "Default" for initiator ""
> (target mpt_scst)
> Aug 30 22:01:10 localhost kernel: [ 2615.221110] [2419]:
> scst_init_session:6434:Adding sess f681e000 to tgt->sess_list
> Aug 30 22:01:10 localhost kernel: [ 2615.221114] [2419]: ENTRY
> scst_sess_alloc_tgt_devs
> Aug 30 22:01:10 localhost kernel: [ 2615.221116] [2419]: ENTRY
> scst_alloc_add_tgt_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.221123] [2419]:
> scst_sgv_pool_use_norm_clust:98:Use clustering
> Aug 30 22:01:10 localhost kernel: [ 2615.221127] [2419]:
> scst_alloc_add_tgt_dev:4110:Device DISK00 on SCST lun=0
> Aug 30 22:01:10 localhost kernel: [ 2615.221132] [2419]:
> scst_set_sense:1796:Sense set:
> Aug 30 22:01:10 localhost kernel: [ 2615.221135]
> (h)___0__1__2__3__4__5__6__7__8__9__A__B__C__D__E__F
> Aug 30 22:01:10 localhost kernel: [ 2615.221141] 0: 70 00 06 00 00 00 00 0a
> 00 00 00 00 29 00 00 00 p...........)...
> Aug 30 22:01:10 localhost kernel: [ 2615.221144] 10: 00 00 ..
> Aug 30 22:01:10 localhost kernel: [ 2615.221147] [2419]: ENTRY
> scst_alloc_set_UA
> Aug 30 22:01:10 localhost kernel: [ 2615.221151] [2419]:
> scst_alloc_set_UA:7778:Adding new UA to tgt_dev f6e46000
> Aug 30 22:01:10 localhost kernel: [ 2615.221154] [2419]: EXIT
> scst_alloc_set_UA
> Aug 30 22:01:10 localhost kernel: [ 2615.221157] [2419]: ENTRY
> scst_pr_init_tgt_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.221159] [2419]: EXIT
> scst_pr_init_tgt_dev: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.221162] [2419]: ENTRY
> scst_tgt_dev_setup_threads
> Aug 30 22:01:10 localhost kernel: [ 2615.221165] [2419]: ENTRY
> scst_init_threads
> Aug 30 22:01:10 localhost kernel: [ 2615.221168] [2419]: EXIT
> scst_init_threads
> Aug 30 22:01:10 localhost kernel: [ 2615.221171] [2419]: ENTRY
> scst_find_shared_io_tgt_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.221175] [2419]:
> scst_find_shared_io_tgt_dev:3737:tgt_dev (acg f7082c00, io_grouping_type 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221178] [2419]: EXIT
> scst_find_shared_io_tgt_dev: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.221181] [2419]: ENTRY
> scst_add_threads
> Aug 30 22:01:10 localhost kernel: [ 2615.221186] [2419]:
> scst_add_threads:1641:cmd_threads f6e460a0, dev <NULL>, tgt_dev f6e46000,
> num 8, n 0
> Aug 30 22:01:10 localhost kernel: [ 2615.221266] [2419]:
> scst_add_threads:1701:Added thr f69c05d0 to threads list (nr_threads 1, n 1)
> Aug 30 22:01:10 localhost kernel: [ 2615.221276] [2514]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221283] [2514]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_0 (PID 2514) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221313] [2514]:
> scst_ioctx_get:4176:Alloced new IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221322] [2419]:
> scst_add_threads:1701:Added thr f67bd700 to threads list (nr_threads 2, n 2)
> Aug 30 22:01:10 localhost kernel: [ 2615.221352] [2515]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221359] [2515]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_1 (PID 2515) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221366] [2419]:
> scst_add_threads:1701:Added thr f67bdf60 to threads list (nr_threads 3, n 3)
> Aug 30 22:01:10 localhost kernel: [ 2615.221373] [2515]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221378] [2516]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221386] [2516]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_2 (PID 2516) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221396] [2516]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221422] [2419]:
> scst_add_threads:1701:Added thr f67bd6f0 to threads list (nr_threads 4, n 4)
> Aug 30 22:01:10 localhost kernel: [ 2615.221452] [2517]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221459] [2517]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_3 (PID 2517) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221466] [2419]:
> scst_add_threads:1701:Added thr f69c0580 to threads list (nr_threads 5, n 5)
> Aug 30 22:01:10 localhost kernel: [ 2615.221473] [2517]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221479] [2518]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221486] [2518]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_4 (PID 2518) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221496] [2518]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221524] [2419]:
> scst_add_threads:1701:Added thr f69c05f0 to threads list (nr_threads 6, n 6)
> Aug 30 22:01:10 localhost kernel: [ 2615.221557] [2519]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221564] [2519]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_5 (PID 2519) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221571] [2419]:
> scst_add_threads:1701:Added thr f69c0600 to threads list (nr_threads 7, n 7)
> Aug 30 22:01:10 localhost kernel: [ 2615.221578] [2519]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221584] [2520]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221591] [2520]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_6 (PID 2520) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221604] [2520]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221626] [2419]:
> scst_add_threads:1701:Added thr f69c0610 to threads list (nr_threads 8, n 8)
> Aug 30 22:01:10 localhost kernel: [ 2615.221632] [2419]: EXIT
> scst_add_threads: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.221636] [2521]: ENTRY
> scst_cmd_thread
> Aug 30 22:01:10 localhost kernel: [ 2615.221641] [2419]: EXIT
> scst_tgt_dev_setup_threads: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.221645] [2521]: scst:
> scst_cmd_thread:4429:Processing thread DISK000_7 (PID 2521) started
> Aug 30 22:01:10 localhost kernel: [ 2615.221652] [2521]:
> scst_ioctx_get:4187:Linked IO context f7b8b4b0 (p_cmd_threads f6e460a0)
> Aug 30 22:01:10 localhost kernel: [ 2615.221658] [2419]:
> scst_alloc_add_tgt_dev:4160:Calling dev handler's attach_tgt(f6e46000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222692] [2419]:
> scst_alloc_add_tgt_dev:4162:Dev handler's attach_tgt() returned
> Aug 30 22:01:10 localhost kernel: [ 2615.222701] [2419]: EXIT
> scst_alloc_add_tgt_dev: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222705] [2419]: EXIT
> scst_sess_alloc_tgt_devs
> Aug 30 22:01:10 localhost kernel: [ 2615.222713] [2419]:
> scst_init_session:6465:Calling init_result_fn(f681e000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222720] [2419]: ENTRY scst_rx_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222724] [2419]: ENTRY
> scst_alloc_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222736] [2419]: EXIT scst_alloc_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222744] [2419]:
> scst_sess_get:658:Incrementing sess f681e000 refcnt (new value 3)
> Aug 30 22:01:10 localhost kernel: [ 2615.222749] [2419]: ENTRY
> scst_unpack_lun
> Aug 30 22:01:10 localhost kernel: [ 2615.222754] [2419]:
> scst_unpack_lun:6777:Raw LUN:
> Aug 30 22:01:10 localhost kernel: [ 2615.222758]
> (h)___0__1__2__3__4__5__6__7__8__9__A__B__C__D__E__F
> Aug 30 22:01:10 localhost kernel: [ 2615.222763] 0: 00 00 ..
> Aug 30 22:01:10 localhost kernel: [ 2615.222768] [2419]: EXIT
> scst_unpack_lun: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222773] [2419]:
> scst_rx_cmd:235:cmd f66ec000, sess f681e000
> Aug 30 22:01:10 localhost kernel: [ 2615.222777] [2419]: EXIT scst_rx_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222781] [2419]: ENTRY
> scst_cmd_init_done
> Aug 30 22:01:10 localhost kernel: [ 2615.222787] [2419]:
> scst_cmd_init_done:361:Preferred context: 3 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222796] [2419]: scst:
> scst_cmd_init_done:365:tag=0, lun=0, CDB len=16, queue_type=1 (cmd
> f66ec000, sess f681e000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222804] [2419]:
> scst_cmd_init_done:366:Receiving CDB:
> Aug 30 22:01:10 localhost kernel: [ 2615.222807]
> (h)___0__1__2__3__4__5__6__7__8__9__A__B__C__D__E__F
> Aug 30 22:01:10 localhost kernel: [ 2615.222817] 0: 00 00 00 00 00 00 00 00
> 00 00 00 00 00 00 00 00 ................
> Aug 30 22:01:10 localhost kernel: [ 2615.222825] [2419]:
> scst_cmd_init_done:399:Adding cmd f66ec000 to init deferred cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.222830] [2419]: EXIT
> scst_cmd_init_done
> Aug 30 22:01:10 localhost kernel: [ 2615.222835] [2419]:
> scst_init_session:6467:init_result_fn() returned
> Aug 30 22:01:10 localhost kernel: [ 2615.222842] [2419]:
> scst_init_session:6480:Deleting cmd f66ec000 from init deferred cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.222846] [2419]: ENTRY
> scst_cmd_init_done
> Aug 30 22:01:10 localhost kernel: [ 2615.222852] [2419]:
> scst_cmd_init_done:361:Preferred context: 3 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222860] [2419]: scst:
> scst_cmd_init_done:365:tag=0, lun=0, CDB len=16, queue_type=1 (cmd
> f66ec000, sess f681e000)
> Aug 30 22:01:10 localhost kernel: [ 2615.222868] [2419]:
> scst_cmd_init_done:366:Receiving CDB:
> Aug 30 22:01:10 localhost kernel: [ 2615.222871]
> (h)___0__1__2__3__4__5__6__7__8__9__A__B__C__D__E__F
> Aug 30 22:01:10 localhost kernel: [ 2615.222880] 0: 00 00 00 00 00 00 00 00
> 00 00 00 00 00 00 00 00 ................
> Aug 30 22:01:10 localhost kernel: [ 2615.222886] [2419]: ENTRY scst_init_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222890] [2419]: ENTRY
> __scst_init_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.222894] [2419]: ENTRY
> scst_translate_lun
> Aug 30 22:01:10 localhost kernel: [ 2615.222901] [2419]:
> scst_get:625:Incrementing cpu_cmd_count f95f3e80 (new value 1)
> Aug 30 22:01:10 localhost kernel: [ 2615.222910] [2419]:
> scst_translate_lun:3903:Finding tgt_dev for cmd f66ec000 (lun 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.222917] [2419]:
> scst_translate_lun:3907:tgt_dev f6e46000 found
> Aug 30 22:01:10 localhost kernel: [ 2615.222922] [2419]: EXIT
> scst_translate_lun: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222926] [2419]: ENTRY
> scst_pre_parse
> Aug 30 22:01:10 localhost kernel: [ 2615.222931] [2419]: ENTRY
> scst_get_cdb_info
> Aug 30 22:01:10 localhost kernel: [ 2615.222938] [2419]:
> scst_get_cdb_info:6699:opcode=00, cdblen=6 bytes, dev_type=0
> Aug 30 22:01:10 localhost kernel: [ 2615.222946] [2419]:
> scst_get_cdb_info:6716:op = 0x00+'MMMMMMMMMM'+<TEST UNIT READY>
> Aug 30 22:01:10 localhost kernel: [ 2615.222955] [2419]:
> scst_get_cdb_info:6721:data direction 4, op flags 0x5082, lba off 0, lba
> len 0, len off 0, len len 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222963] [2419]: EXIT
> scst_get_cdb_info: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222973] [2419]:
> scst_pre_parse:530:op_name <TEST UNIT READY> (cmd f66ec000), direction=4
> (expected 0, set no), lba 0, bufflen=0, data_len 0, out_bufflen=0 (expected
> len 0, out expected len 0), flags=0x50e2
> Aug 30 22:01:10 localhost kernel: [ 2615.222982] [2419]: EXIT
> scst_pre_parse: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.222987] [2419]: ENTRY
> scst_cmd_set_sn
> Aug 30 22:01:10 localhost kernel: [ 2615.222993] [2419]:
> scst_cmd_set_sn:3793:Implicit HQ cmd f66ec000
> Aug 30 22:01:10 localhost kernel: [ 2615.222999] [2419]:
> scst_cmd_set_sn:3858:HQ cmd f66ec000 (op 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.223023] [2419]: EXIT
> scst_cmd_set_sn
> Aug 30 22:01:10 localhost kernel: [ 2615.223028] [2419]: EXIT
> __scst_init_cmd: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223033] [2419]: EXIT
> scst_init_cmd: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223039] [2419]:
> scst_cmd_init_done:452:Adding cmd f66ec000 to active cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.223052] [2419]: EXIT
> scst_cmd_init_done
> Aug 30 22:01:10 localhost kernel: [ 2615.223060] [2419]:
> scst_sess_put:664:Decrementing sess f681e000 refcnt (new value 2)
> Aug 30 22:01:10 localhost kernel: [ 2615.223065] [2419]: EXIT
> scst_init_session
> Aug 30 22:01:10 localhost kernel: [ 2615.223085] [2521]: ENTRY
> scst_do_job_active
> Aug 30 22:01:10 localhost kernel: [ 2615.223091] [2521]:
> scst_do_job_active:4403:Deleting cmd f66ec000 from active cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.223097] [2521]: ENTRY
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.223103] [2521]:
> scst_process_active_cmd:4242:cmd f66ec000, atomic 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223108] [2521]: ENTRY
> scst_parse_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.223114] [2521]:
> scst_parse_cmd:586:Calling dev handler vdisk_fileio parse(f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223120] [2521]: ENTRY
> scst_sbc_generic_parse
> Aug 30 22:01:10 localhost kernel: [ 2615.223127] [2521]:
> scst_sbc_generic_parse:6893:res 0, bufflen 0, data_len 0, direct 4
> Aug 30 22:01:10 localhost kernel: [ 2615.223133] [2521]: EXIT
> scst_sbc_generic_parse: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223141] [2521]:
> scst_parse_cmd:591:Dev handler vdisk_fileio parse() returned 500
> Aug 30 22:01:10 localhost kernel: [ 2615.223153] [2521]: scst:
> scst_parse_cmd:827:op_name <TEST UNIT READY> (cmd f66ec000), direction=4
> (expected 0, set no), lba=0, bufflen=0, data len 0, out_bufflen=0,
> (expected len 0, out expected len 0), flags=0x50e2
> Aug 30 22:01:10 localhost kernel: [ 2615.223162] [2521]: EXIT
> scst_parse_cmd: 0x1
> Aug 30 22:01:10 localhost kernel: [ 2615.223167] [2521]: ENTRY
> scst_prepare_space
> Aug 30 22:01:10 localhost kernel: [ 2615.223172] [2521]: EXIT
> scst_prepare_space: 0x1
> Aug 30 22:01:10 localhost kernel: [ 2615.223176] [2521]: ENTRY
> scst_tgt_pre_exec
> Aug 30 22:01:10 localhost kernel: [ 2615.223181] [2521]: EXIT
> scst_tgt_pre_exec: 1
> Aug 30 22:01:10 localhost kernel: [ 2615.223186] [2521]: ENTRY
> scst_exec_check_sn
> Aug 30 22:01:10 localhost kernel: [ 2615.223190] [2521]: ENTRY
> scst_exec_check_blocking
> Aug 30 22:01:10 localhost kernel: [ 2615.223195] [2521]: ENTRY
> scst_check_blocked_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.223201] [0]:
> scst_check_blocked_dev:126:New inc on_dev_count 1 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223209] [0]:
> scst_inc_pr_readers_count:65:New inc pr_readers_count 1 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223214] [2521]: ENTRY
> __scst_check_blocked_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.223222] [0]:
> __scst_check_blocked_dev:8054:cmd f66ec000 (tag 0, op 0): blocking further
> cmds on dev DISK00 due to possible double reset UA
> Aug 30 22:01:10 localhost kernel: [ 2615.223230] [0]:
> scst_block_dev:8007:Device BLOCK (new count 1), dev DISK00
> Aug 30 22:01:10 localhost kernel: [ 2615.223235] [2521]: EXIT
> __scst_check_blocked_dev: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223240] [2521]: EXIT
> scst_check_blocked_dev: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223247] [2521]:
> __scst_cmd_get:691:Incrementing cmd f66ec000 ref (new value 2)
> Aug 30 22:01:10 localhost kernel: [ 2615.223252] [2521]: ENTRY
> scst_pre_exec_checks
> Aug 30 22:01:10 localhost kernel: [ 2615.223256] [2521]: ENTRY
> __scst_check_local_events
> Aug 30 22:01:10 localhost kernel: [ 2615.223262] [0]:
> scst_dec_pr_readers_count:95:New dec pr_readers_count 0 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223268] [2521]: ENTRY
> scst_set_pending_UA
> Aug 30 22:01:10 localhost kernel: [ 2615.223274] [2521]:
> scst_set_pending_UA:7623:Setting pending UA cmd f66ec000
> Aug 30 22:01:10 localhost kernel: [ 2615.223281] [0]:
> scst_set_pending_UA:7640:next f6af3210 UA_entry f6af3210
> Aug 30 22:01:10 localhost kernel: [ 2615.223287] [2521]: ENTRY
> scst_set_cmd_error_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223291] [2521]: ENTRY
> scst_set_cmd_error_status
> Aug 30 22:01:10 localhost kernel: [ 2615.223296] [2521]: EXIT
> scst_set_cmd_error_status: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223301] [2521]: ENTRY
> scst_alloc_set_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223305] [2521]: ENTRY
> scst_alloc_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223310] [2521]: EXIT
> scst_alloc_sense: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223316] [0]:
> scst_alloc_set_sense:1400:Sense set:
> Aug 30 22:01:10 localhost kernel: [ 2615.223320]
> (h)___0__1__2__3__4__5__6__7__8__9__A__B__C__D__E__F
> Aug 30 22:01:10 localhost kernel: [ 2615.223330] 0: 70 00 06 00 00 00 00 0a
> 00 00 00 00 29 00 00 00 p...........)...
> Aug 30 22:01:10 localhost kernel: [ 2615.223336] 10: 00 00 ..
> Aug 30 22:01:10 localhost kernel: [ 2615.223340] [2521]: EXIT
> scst_alloc_set_sense: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223345] [2521]: EXIT
> scst_set_cmd_error_sense: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223350] [2521]: EXIT
> scst_set_pending_UA: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223355] [2521]: EXIT
> __scst_check_local_events: 1
> Aug 30 22:01:10 localhost kernel: [ 2615.223359] [2521]: ENTRY
> scst_cmd_done_local
> Aug 30 22:01:10 localhost kernel: [ 2615.223367] [2521]: scst:
> scst_cmd_done_local:1689:cmd f66ec000, status 2, msg_status 0, host_status
> 0, driver_status 0, resp_data_len 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223374] [2521]: ENTRY
> scst_process_redirect_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.223380] [2521]:
> scst_process_redirect_cmd:1364:Context: 4
> Aug 30 22:01:10 localhost kernel: [ 2615.223385] [2521]: ENTRY
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.223391] [2521]:
> scst_process_active_cmd:4242:cmd f66ec000, atomic 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223396] [2521]: ENTRY
> scst_pre_dev_done
> Aug 30 22:01:10 localhost kernel: [ 2615.223400] [2521]: ENTRY
> scst_check_auto_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223404] [2521]: EXIT
> scst_check_auto_sense: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223409] [2521]: ENTRY
> scst_check_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223413] [2521]: EXIT
> scst_check_sense: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.223420] [2521]: scst:
> scst_pre_dev_done:3189:cmd f66ec000 not succeeded with status 2
> Aug 30 22:01:10 localhost kernel: [ 2615.223426] [2521]: EXIT
> scst_pre_dev_done: 1
> Aug 30 22:01:10 localhost kernel: [ 2615.223431] [2521]: ENTRY scst_dev_done
> Aug 30 22:01:10 localhost kernel: [ 2615.223437] [0]:
> scst_check_unblock_dev:165:New dec on_dev_count 0 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223444] [0]:
> scst_check_unblock_dev:173:cmd f66ec000 (tag 0): unblocking dev DISK00
> Aug 30 22:01:10 localhost kernel: [ 2615.223450] [2521]: ENTRY
> scst_unblock_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.223456] [0]:
> scst_unblock_dev:8081:Device UNBLOCK(new 0), dev DISK00
> Aug 30 22:01:10 localhost kernel: [ 2615.223461] [2521]: EXIT
> scst_unblock_dev
> Aug 30 22:01:10 localhost kernel: [ 2615.223466] [2521]: EXIT
> scst_dev_done: 0x1
> Aug 30 22:01:10 localhost kernel: [ 2615.223470] [2521]: ENTRY
> scst_pre_xmit_response
> Aug 30 22:01:10 localhost kernel: [ 2615.223475] [2521]: ENTRY
> scst_on_hq_cmd_response
> Aug 30 22:01:10 localhost kernel: [ 2615.223480] [2521]: EXIT
> scst_on_hq_cmd_response
> Aug 30 22:01:10 localhost kernel: [ 2615.223484] [2521]: ENTRY
> scst_store_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223490] [2521]:
> scst_store_sense:8300:Storing sense (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.223495] [2521]: EXIT
> scst_store_sense
> Aug 30 22:01:10 localhost kernel: [ 2615.223500] [2521]: ENTRY
> scst_adjust_resp_data_len
> Aug 30 22:01:10 localhost kernel: [ 2615.223504] [2521]: EXIT
> scst_adjust_resp_data_len
> Aug 30 22:01:10 localhost kernel: [ 2615.223508] [2521]: EXIT
> scst_pre_xmit_response: 0x1
> Aug 30 22:01:10 localhost kernel: [ 2615.223513] [2521]: ENTRY
> scst_xmit_response
> Aug 30 22:01:10 localhost kernel: [ 2615.223519] [2521]:
> scst_xmit_response:3543:Calling xmit_response(f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.233574] [2521]: ENTRY
> scst_tgt_cmd_done
> Aug 30 22:01:10 localhost kernel: [ 2615.233580] [2521]: ENTRY
> scst_process_redirect_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.233586] [0]:
> scst_process_redirect_cmd:1364:Context: 2
> Aug 30 22:01:10 localhost kernel: [ 2615.233591] [2521]: ENTRY
> scst_check_retries
> Aug 30 22:01:10 localhost kernel: [ 2615.233595] [2521]: EXIT
> scst_check_retries
> Aug 30 22:01:10 localhost kernel: [ 2615.233602] [0]:
> scst_schedule_tasklet:87:Adding cmd f66ec000 to tasklet 0 cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.233607] [2521]: EXIT
> scst_process_redirect_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.233611] [2521]: EXIT
> scst_tgt_cmd_done
> Aug 30 22:01:10 localhost kernel: [ 2615.233617] [2521]: ENTRY
> scst_cmd_tasklet
> Aug 30 22:01:10 localhost kernel: [ 2615.233621] [2521]: ENTRY
> scst_do_job_active
> Aug 30 22:01:10 localhost kernel: [ 2615.233627] [0]:
> scst_do_job_active:4403:Deleting cmd f66ec000 from active cmd list
> Aug 30 22:01:10 localhost kernel: [ 2615.233636] [2521]: ENTRY
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.233642] [0]:
> scst_process_active_cmd:4242:cmd f66ec000, atomic 1
> Aug 30 22:01:10 localhost kernel: [ 2615.233647] [2521]: ENTRY
> scst_finish_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.233654] [0]:
> __scst_cmd_put:697:Decrementing cmd f66ec000 ref (new value 1)
> Aug 30 22:01:10 localhost kernel: [ 2615.233659] [2521]: EXIT
> scst_finish_cmd: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.233662] [2521]: EXIT
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.233666] [2521]: EXIT
> scst_do_job_active
> Aug 30 22:01:10 localhost kernel: [ 2615.233669] [2521]: EXIT
> scst_cmd_tasklet
> Aug 30 22:01:10 localhost kernel: [ 2615.234563] [2521]:
> scst_xmit_response:3599:xmit_response() returned 0
> Aug 30 22:01:10 localhost kernel: [ 2615.234570] [2521]: EXIT
> scst_xmit_response: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.234574] [2521]: EXIT
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.234579] [2521]: EXIT
> scst_process_redirect_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.234583] [2521]: EXIT
> scst_cmd_done_local
> Aug 30 22:01:10 localhost kernel: [ 2615.234588] [2521]: EXIT
> scst_pre_exec_checks: 0
> Aug 30 22:01:10 localhost kernel: [ 2615.234592] [2521]: ENTRY
> scst_post_exec_sn
> Aug 30 22:01:10 localhost kernel: [ 2615.234596] [2521]: EXIT
> scst_post_exec_sn: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.234604] [2521]:
> __scst_cmd_put:697:Decrementing cmd f66ec000 ref (new value 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.234609] [2521]: ENTRY scst_free_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.234616] [2521]:
> scst_free_cmd:5322:Freeing cmd f66ec000 (tag 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.234623] [2521]:
> scst_free_cmd:5338:Calling target's on_free_cmd(f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.234664] [2521]:
> scst_free_cmd:5342:Target's on_free_cmd() returned
> Aug 30 22:01:10 localhost kernel: [ 2615.234671] [2521]:
> scst_free_cmd:5349:Calling dev handler vdisk_fileio on_free_cmd(f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.234679] [2521]:
> scst_free_cmd:5354:Dev handler vdisk_fileio on_free_cmd() returned
> Aug 30 22:01:10 localhost kernel: [ 2615.234683] [2521]: ENTRY
> scst_release_space
> Aug 30 22:01:10 localhost kernel: [ 2615.234687] [2521]: EXIT
> scst_release_space
> Aug 30 22:01:10 localhost kernel: [ 2615.234692] [2521]:
> scst_free_cmd:5361:Releasing sense f69f2f00 (cmd f66ec000)
> Aug 30 22:01:10 localhost kernel: [ 2615.234701] [2521]:
> scst_sess_put:664:Decrementing sess f681e000 refcnt (new value 1)
> Aug 30 22:01:10 localhost kernel: [ 2615.234708] [2521]:
> scst_put:647:Decrementing cpu_cmd_count f95f3e80 (new value 0)
> Aug 30 22:01:10 localhost kernel: [ 2615.234713] [2521]: EXIT scst_free_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.234717] [2521]: EXIT
> scst_exec_check_blocking
> Aug 30 22:01:10 localhost kernel: [ 2615.234721] [2521]: EXIT
> scst_exec_check_sn: 0x0
> Aug 30 22:01:10 localhost kernel: [ 2615.234725] [2521]: EXIT
> scst_process_active_cmd
> Aug 30 22:01:10 localhost kernel: [ 2615.234729] [2521]: EXIT
> scst_do_job_active
> 
> this on initiator
> Aug 30 15:26:46 localhost kernel: scsi1 : Adaptec AIC7XXX EISA/VLB/PCI SCSI
> HBA DRIVER, Rev 6.2.36
> Aug 30 15:26:46 localhost kernel: <Adaptec aic7880 Ultra SCSI adapter>
> Aug 30 15:26:46 localhost kernel: aic7880: Ultra Wide Channel A, SCSI Id
> =7, 16/253 SCBs
> Aug 30 15:26:46 localhost kernel:
> Aug 30 15:27:02 localhost kernel: scsi1:A:1: no active SCB for reconnecting
> targ et - issuing BUS DEVICE RESET
> Aug 30 15:27:02 localhost kernel: SAVED_SCSIID == 0x17, SAVED_LUN == 0x3f,
> ARG_1 == 0xff ACCUM = 0xff
> Aug 30 15:27:02 localhost kernel: SEQ_FLAGS == 0x40, SCBPTR == 0x0, BTT ==
> 0xff, SINDEX == 0x31
> Aug 30 15:27:02 localhost kernel: SCSIID == 0x17, SCB_SCSIID == 0x17,
> SCB_LUN == 0x0, SCB_TAG == 0x2, SCB_CONTROL == 0x40
> Aug 30 15:27:02 localhost kernel: SCSIBUSL == 0xc0, SCSISIGI == 0x86
> Aug 30 15:27:02 localhost kernel: SXFRCTL0 == 0x88
> Aug 30 15:27:02 localhost kernel: SEQCTL == 0x10
> Aug 30 15:27:02 localhost kernel: >>>>>>>>>>>>>>>>>> Dump Card State Begins
> <<<< <<<<<<<<<<<<<
> Aug 30 15:27:02 localhost kernel: scsi1: Dumping Card State in Command
> phase, at SEQADDR 0x1b7
> Aug 30 15:27:02 localhost kernel: Card was paused
> Aug 30 15:27:02 localhost kernel: ACCUM = 0xff, SINDEX = 0x31, DINDEX =
> 0x65, AR G_2 = 0x0
> Aug 30 15:27:02 localhost kernel: HCNT = 0x0 SCBPTR = 0x0
> Aug 30 15:27:02 localhost kernel: SCSISIGI[0x86] ERROR[0x0] SCSIBUSL[0xc0]
> LASTP HASE[0x80]
> Aug 30 15:27:02 localhost kernel: SCSISEQ[0x12] SBLKCTL[0x2] SCSIRATE[0x0]
> SEQCT L[0x10]
> Aug 30 15:27:02 localhost kernel: SEQ_FLAGS[0x40] SSTAT0[0x7] SSTAT1[0x3]
> SSTAT2 [0x0]
> Aug 30 15:27:02 localhost kernel: SSTAT3[0x0] SIMODE0[0x0] SIMODE1[0xac]
> SXFRCTL 0[0x88]
> Aug 30 15:27:02 localhost kernel: DFCNTRL[0x4] DFSTATUS[0x6d]
> Aug 30 15:27:02 localhost kernel: STACK: 0x12b 0x0 0x0 0x191
> Aug 30 15:27:02 localhost kernel: SCB count = 4
> Aug 30 15:27:02 localhost kernel: Kernel NEXTQSCB = 3
> Aug 30 15:27:02 localhost kernel: Card NEXTQSCB = 3
> Aug 30 15:27:02 localhost kernel: QINFIFO entries:
> Aug 30 15:27:02 localhost kernel: Waiting Queue entries:
> Aug 30 15:27:02 localhost kernel: Disconnected Queue entries:
> Aug 30 15:27:02 localhost kernel: QOUTFIFO entries:
> Aug 30 15:27:02 localhost kernel: Sequencer Free SCB List: 1 2 3 4 5 6 7 8
> 9 10 11 12 13 14 15
> Aug 30 15:27:02 localhost kernel: Sequencer SCB Info:
> Aug 30 15:27:02 localhost kernel: 0 SCB_CONTROL[0x40] SCB_SCSIID[0x17]
> SCB_LUN [0x0] SCB_TAG[0x2]
> Aug 30 15:27:02 localhost kernel: 1 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 2 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 3 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 4 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 5 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 6 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 7 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 8 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 9 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 10 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 11 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 12 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 13 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 14 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: 15 SCB_CONTROL[0x0] SCB_SCSIID[0xff]
> SCB_LUN[ 0xff] SCB_TAG[0xff]
> Aug 30 15:27:02 localhost kernel: Pending list:
> Aug 30 15:27:02 localhost kernel: 2 SCB_CONTROL[0x40] SCB_SCSIID[0x17]
> SCB_LUN [0x0]
> Aug 30 15:27:02 localhost kernel: Kernel Free SCB list: 1 0
> Aug 30 15:27:02 localhost kernel: Untagged Q(1): 2
> Aug 30 15:27:02 localhost kernel:
> Aug 30 15:27:02 localhost kernel: <<<<<<<<<<<<<<<<< Dump Card State Ends
> >>>>>>> >>>>>>>>>>>
> Aug 30 15:27:02 localhost kernel: scsi1: Bus Device Reset on A:1. 1 SCBs
> aborted


-- 
steve

Stay Hungry, Stay Foolish.