We are testing "Adding a second connection to existing iSCSI session” with below steps:
Step 1. Initiator successfully performs iSCSI login on a tcp connection (b/w initiator and target) to establish iSCSI session.
Step 2. Establish a second TCP connection to the target.
Step 3. Start login on the second TCP connection using ISID and TSIH of iSCSI session established in Step 1.
During Step 3, OOPS is observed on target side. All further attempts to connect to iSCSI target fails after the OOPS.
LIO Version: Datera Inc. iSCSI Target v4.1.0
Linux Kernel: 4.4.0-22-generic
dmesg
=====
[ 862.784477] BUG: unable to handle kernel NULL pointer dereference at 00000000000001f8
[ 862.784486] IP: [<ffffffffc0604b44>] iscsi_target_login_thread+0x724/0xfa0 [iscsi_target_mod]
[ 862.784570] PGD 0
[ 862.784572] Oops: 0000 [#1] SMP
[ 862.784575] Modules linked in: target_core_user uio tcm_fc libfc ib_srpt tcm_usb_gadget libcomposite udc_core tcm_loop vhost_scsi vhost iscsi_target_mod tcm_qla2xxx qla2xxx scsi_transport_fc target_core_file target_core_iblock target_core_pscsi target_core_mod configfs pci_stub vboxpci(OE) vboxnetadp(OE) vboxnetflt(OE) vboxdrv(OE) vmw_vsock_vmci_transport vsock vmhgfs(OE) coretemp kvm_intel kvm binfmt_misc irqbypass crct10dif_pclmul crc32_pclmul aesni_intel vmw_balloon aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd joydev input_leds serio_raw i2c_piix4 vmw_vmci shpchp 8250_fintek mac_hid ib_iser rdma_cm iw_cm ib_cm ib_sa ib_mad ib_core ib_addr iscsi_tcp libiscsi_tcp libiscsi scsi_transport_iscsi parport_pc ppdev lp parport autofs4 hid_generic usbhid hid vmwgfx ttm psmouse drm_kms_helper syscopyarea
[ 862.784609] sysfillrect sysimgblt mptspi mptscsih fb_sys_fops drm ahci libahci e1000 mptbase scsi_transport_spi pata_acpi floppy fjes
[ 862.784618] CPU: 0 PID: 9241 Comm: iscsi_np Tainted: G OE 4.4.0-24-generic #43-Ubuntu
[ 862.784620] Hardware name: VMware, Inc. VMware Virtual Platform/440BX Desktop Reference Platform, BIOS 6.00 05/20/2014
[ 862.784622] task: ffff8800759d1b80 ti: ffff880075a00000 task.ti: ffff880075a00000
[ 862.784624] RIP: 0010:[<ffffffffc0604b44>] [<ffffffffc0604b44>] iscsi_target_login_thread+0x724/0xfa0 [iscsi_target_mod]
[ 862.784632] RSP: 0018:ffff880075a03e40 EFLAGS: 00010246
[ 862.784633] RAX: 0000000000000000 RBX: ffff880075a52800 RCX: 0000000000037726
[ 862.784635] RDX: 0000000000037725 RSI: ffff88007b619fe0 RDI: ffff880033bce800
[ 862.784636] RBP: ffff880075a03ec0 R08: 0000000000019fe0 R09: ffffffffc06067c6
[ 862.784637] R10: ffffea0001d1d880 R11: 654d687475410032 R12: ffff880074763140
[ 862.784638] R13: ffff880075a52820 R14: ffff880075a528d8 R15: ffff880033bce800
[ 862.784640] FS: 0000000000000000(0000) GS:ffff88007b600000(0000) knlGS:0000000000000000
[ 862.784641] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 862.784642] CR2: 00000000000001f8 CR3: 0000000072f8e000 CR4: 00000000000406f0
[ 862.784716] Stack:
[ 862.784719] ffff880075e87080 ffff88003526f358 ffff8800799cc420 ffff880000000000
[ 862.784721] ffff880079cd0100 ffff880075a52828 00ff88003526ee00 ffff880075a528d8
[ 862.784723] ffff8800759d1b80 ffff880075a52800 0000000058f0fa77 ffff880075a0aac0
[ 862.784725] Call Trace:
[ 862.784736] [<ffffffffc0604420>] ? iscsi_target_login_sess_out+0x240/0x240 [iscsi_target_mod]
[ 862.784782] [<ffffffff810a06a8>] kthread+0xd8/0xf0
[ 862.784786] [<ffffffff810a05d0>] ? kthread_create_on_node+0x1e0/0x1e0
[ 862.784789] [<ffffffff81825f8f>] ret_from_fork+0x3f/0x70
[ 862.784791] [<ffffffff810a05d0>] ? kthread_create_on_node+0x1e0/0x1e0
[ 862.784792] Code: 00 00 4c 89 e2 4c 89 fe 48 89 df e8 c7 19 00 00 85 c0 0f 88 32 01 00 00 0f b6 45 b7 4c 89 ff 41 88 44 24 09 49 8b 87 48 05 00 00 <4c> 8b b0 f8 01 00 00 49 8b 87 10 05 00 00 ff 90 98 00 00 00 41
[ 862.784811] RIP [<ffffffffc0604b44>] iscsi_target_login_thread+0x724/0xfa0 [iscsi_target_mod]
[ 862.784819] RSP <ffff880075a03e40>
[ 862.784820] CR2: 00000000000001f8
[ 862.784823] ---[ end trace 7e41630f165c8027 ]---
iSCSI PDU Logs
===========
Step 1. Initiator successfully performs iSCSI login on a tcp connection to establish iSCSI session.
Opcode: Login Request (0x03)
.1.. .... = I: Immediate Delivery
Flags: 0x81
1... .... = T: Transit to next stage
.0.. .... = C: Text is complete
.... 00.. = CSG: Security Negotiation (0x00)
.... ..01 = NSG: Operational Negotiation (0x01)
VersionMax: 0x00
VersionMin: 0x00
TotalAHSLength: 0x00
DataSegmentLength: 0x00009d
ISID: 00230d030000
TSIH: 0x0000
InitiatorTaskTag: 0xa3a3a3a3
CID: 0x0000
CmdSN: 0x00000000
ExpStatSN: 0x00000000
Data Segment:
InitiatorName=iqn.2016-01.org.calsoft:nochap
TargetName=iqn.2003-01.org.linux-iscsi.srai-virtualbox.x8664:sn.2859286a0512
SessionType=Normal
AuthMethod=None
Opcode: Login Response (0x23)
Flags: 0x81
1... .... = T: Transit to next stage
.0.. .... = C: Text is complete
.... 00.. = CSG: Security Negotiation (0x00)
.... ..01 = NSG: Operational Negotiation (0x01)
VersionMax: 0x00
VersionActive: 0x00
TotalAHSLength: 0x00
DataSegmentLength: 0x00003e
ISID: 00230d030000
TSIH: 0x0000
InitiatorTaskTag: 0xa3a3a3a3
StatSN: 0x8b444b16
ExpCmdSN: 0x00000000
MaxCmdSN: 0x00000000
StatusClass: Success (0x00)
StatusDetail: Login is proceeding OK (0x00)
Data Segment:
AuthMethod=None
TargetAlias=LIO Target
TargetPortalGroupTag=1
Opcode: Login Request (0x03)
.1.. .... = I: Immediate Delivery
Flags: 0x87
1... .... = T: Transit to next stage
.0.. .... = C: Text is complete
.... 01.. = CSG: Operational Negotiation (0x01)
.... ..11 = NSG: Full Feature Phase (0x03)
VersionMax: 0x00
VersionMin: 0x00
TotalAHSLength: 0x00
DataSegmentLength: 0x000118
ISID: 00230d030000
TSIH: 0x0000
InitiatorTaskTag: 0xa3a3a3a3
CID: 0x0000
CmdSN: 0x00000000
ExpStatSN: 0x8b444b17
Data Segment:
MaxConnections=4
MaxBurstLength=1024
MaxRecvDataSegmentLength=1024
ErrorRecoveryLevel=0
ImmediateData=Yes
MaxOutstandingR2T=1
InitialR2T=Yes
DataDigest=None
HeaderDigest=None
FirstBurstLength=512
DataSequenceInOrder=Yes
DataPDUInOrder=Yes
DefaultTime2Retain=20
DefaultTime2Wait=2
Opcode: Login Response (0x23)
Flags: 0x87
1... .... = T: Transit to next stage
.0.. .... = C: Text is complete
.... 01.. = CSG: Operational Negotiation (0x01)
.... ..11 = NSG: Full Feature Phase (0x03)
VersionMax: 0x00
VersionActive: 0x00
TotalAHSLength: 0x00
DataSegmentLength: 0x0000e0
ISID: 00230d030000
TSIH: 0x0001
InitiatorTaskTag: 0xa3a3a3a3
StatSN: 0x8b444b17
ExpCmdSN: 0x00000000
MaxCmdSN: 0x00000000
StatusClass: Success (0x00)
StatusDetail: Login is proceeding OK (0x00)
Data Segment:
HeaderDigest=None
DataDigest=None
MaxConnections=4
ImmediateData=Yes
MaxRecvDataSegmentLength=262144
MaxBurstLength=1024
FirstBurstLength=512
DefaultTime2Wait=2
DefaultTime2Retain=20
MaxOutstandingR2T=1
ErrorRecoveryLevel=0
Step 3. Start login on the second TCP connection using ISID and TSIH of iSCSI session established in Step 1.
Opcode: Login Request (0x03)
.1.. .... = I: Immediate Delivery
Flags: 0x81
1... .... = T: Transit to next stage
.0.. .... = C: Text is complete
.... 00.. = CSG: Security Negotiation (0x00)
.... ..01 = NSG: Operational Negotiation (0x01)
VersionMax: 0x00
VersionMin: 0x00
TotalAHSLength: 0x00
DataSegmentLength: 0x00008a
ISID: 00230d030000
TSIH: 0x0001
InitiatorTaskTag: 0xa3a3a3a3
CID: 0x0001
CmdSN: 0x00000000
ExpStatSN: 0x8b444b18
Data Segment:
InitiatorName=iqn.2016-01.org.calsoft:nochap
TargetName=iqn.2003-01.org.linux-iscsi.srai-virtualbox.x8664:sn.2859286a0512
AuthMethod=None
Regards,
Sumit Rai
Principal Development Engineer
Calsoft Pvt. Ltd., Pune, India
--
To unsubscribe from this list: send the line "unsubscribe target-devel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
