[storage-discuss] Re: iscsitgtd dumping core on SXCR b54

[Nigel Smith]

Rick, I've been able to reproduce the same crash & core dump, using build 54 
(with your recent iscsi target package applied).
I created a 200 Mb file and shared it with the iscsi target.
I then connected to the target using the solaris initiator from the same PC
by setting the discovery-address to be 127.0.0.1 (localhost).
(You need to disable 'tcp_fusion' for this to work).
I then formatted that disk, and created a zpool on it.
The target core dumped in the middle of creating the zpool.
The target restarted automatically and it did actually seem to successfully complete creating the zpool.

Here is my core dump:

# cd /var/core/
# mdb - core.iscsitgtd.4632
Loading modules: [ libumem.so.1 libavl.so.1 libc.so.1 libnvpair.so.1 libuutil.so.1 ld.so.1 ]
> $c
libc.so.1`_lwp_kill+0x15(e, 6)
libc.so.1`raise+0x22(6)
libc.so.1`abort+0xcd(809fc50, 80d3950, 65737341, 6f697472, 6166206e, 64656c69)
libc.so.1`_assert+0x6e(807675c, 807674c, 259)
t10_cmd_state_machine+0x25e(80d3950, 2)
t10_cmd_shoot_event+0x53(80d3950, 2)
trans_send_complete+0x6c(80d3950, 0)
spc_mselect_data+0x92(80d3950, 80b2ab0, 0, 80b2ab0, 20)
sbc_data+0x2b(80d3950, 80b2ab0, 0, 80b2ab0, 20)
trans_rqst_dataout+0x142(80d3950, 80b2ab0, 20, 0, 80b2ab0, 8069c98)
spc_mselect+0x54(80d3950, 80a1ad8, 10)
sbc_cmd+0x23(80d3950, 80a1ad8, 10)
lu_runner+0x79b(80afdd0)
libc.so.1`_thr_setup+0x52(d2702c00)
libc.so.1`_lwp_start(d2702c00, 0, 0, 0, 0, 0)
>

Here is the same warning about opcode:0x41 from the initiator:

# cat /var/adm/messages | grep kern.warning
Jan 27 13:52:28 solaris iscsi: [ID 867852 kern.warning] WARNING: iscsi connection(37) protocol error - received an unsupported opcode:0x41
Jan 27 13:52:28 solaris scsi_vhci: [ID 734749 kern.warning] WARNING: vhci_scsi_reset 0x1
Jan 27 13:52:39 solaris iscsi: [ID 158826 kern.warning] WARNING: iscsi connection(37) login failed - failed to receive login response

Here is my script to reproduce the problem:

# iscsitadm list target
Target: sandbox
    iSCSI Name: iqn.1986-03.com.sun:02:1b993d5b-ca55-e822-f4d1-faa99b949707.sandbox
    Connections: 0
# echo 'do_tcp_fusion/W0' | mdb -wk
do_tcp_fusion:  0               =       0x0
# iscsiadm add discovery-address 127.0.0.1
# format
Searching for disks...done

c2t0100000C2920DB8300002A0045B925E7d0: configured with capacity of 199.98MB


AVAILABLE DISK SELECTIONS:
       0. c1t0d0 <DEFAULT cyl 4093 alt 2 hd 128 sec 32>
          /pci at 0,0/pci1000,30 at 10/sd at 0,0
       1. c2t0100000C2920DB8300002A0045B925E7d0 <SUN-SOLARIS-1 cyl 16382 alt 2 hd 5 sec 5>
          /scsi_vhci/disk at g0100000c2920db8300002a0045b925e7
Specify disk (enter its number): 1
selecting c2t0100000C2920DB8300002A0045B925E7d0
[disk formatted]
bash-3.00# zpool create iscsit c2t0100000C2920DB8300002A0045B925E7d0
bash-3.00# zpool list
NAME                    SIZE    USED   AVAIL    CAP  HEALTH     ALTROOT
iscsit                  187M     90K    187M     0%  ONLINE     -

I'm not sure if it is possible to capture a packet trace from localhost.
I will try tomorrow.
Thanks
Nigel Smith
 
 
This message posted from opensolaris.org