Oops, forgot to attach the login debug info using "iscsid -d 8 -f &" last time.
Debug output attached for oneway-CHAP and Mutual-CHAP. Mutual-CHAP works fine with our target. Thx, Arvind. -----Original Message----- From: open-iscsi@googlegroups.com [mailto:open-is...@googlegroups.com] On Behalf Of Arvind Jain Sent: Wednesday, January 28, 2009 8:43 PM To: open-iscsi@googlegroups.com Subject: RE: CHAP with Open-iSCSI Mike, I have the following info as you requested: [r...@localhost ~]# iscsid -d 8 -f iscsid: sysfs_init: sysfs_path='/sys' iscsid: sysfs_attr_get_value: open '/module/scsi_transport_iscsi'/'version' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/module/scsi_transport_iscsi/version' iscsid: sysfs_attr_get_value: add to cache '/sys/module/scsi_transport_iscsi/version' iscsid: sysfs_attr_get_value: cache '/sys/module/scsi_transport_iscsi/version' with attribute value '2.0-867' iscsid: transport class version 2.0-867. iscsid version 2.0-869 iscsid: in ctldev_open iscsid: created NETLINK_ISCSI socket... iscsid: InitiatorName==iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: InitiatorName=iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: InitiatorAlias=localhost.localdomain iscsid: in ctldev_close iscsid: Max file limits 1024 1024 iscsid: reaped pid 3625, reap_count now 0 [r...@localhost ~]# iscsiadm -m node -T iqn.2008-07.com.wasabi:osd.1 -p 192.168.0.90,3260 node.name = iqn.2008-07.com.wasabi:osd.1 node.tpgt = -1 node.startup = manual iface.hwaddress = default iface.iscsi_ifacename = default iface.net_ifacename = default iface.transport_name = tcp iface.initiatorname = <empty> node.discovery_address = 192.168.0.90 node.discovery_port = 3260 node.discovery_type = send_targets node.session.initial_cmdsn = 0 node.session.initial_login_retry_max = 4 node.session.cmds_max = 128 node.session.queue_depth = 32 node.session.auth.authmethod = CHAP node.session.auth.username = user0 node.session.auth.password = ******** node.session.auth.username_in = <empty> node.session.auth.password_in = <empty> node.session.timeo.replacement_timeout = 120 node.session.err_timeo.abort_timeout = 15 node.session.err_timeo.lu_reset_timeout = 20 node.session.err_timeo.host_reset_timeout = 60 node.session.iscsi.FastAbort = Yes node.session.iscsi.InitialR2T = No node.session.iscsi.ImmediateData = No node.session.iscsi.FirstBurstLength = 262144 node.session.iscsi.MaxBurstLength = 16776192 node.session.iscsi.DefaultTime2Retain = 0 node.session.iscsi.DefaultTime2Wait = 2 node.session.iscsi.MaxConnections = 1 node.session.iscsi.MaxOutstandingR2T = 1 node.session.iscsi.ERL = 0 node.conn[0].address = 192.168.0.90 node.conn[0].port = 3260 node.conn[0].startup = manual node.conn[0].tcp.window_size = 524288 node.conn[0].tcp.type_of_service = 0 node.conn[0].timeo.logout_timeout = 15 node.conn[0].timeo.login_timeout = 15 node.conn[0].timeo.auth_timeout = 45 node.conn[0].timeo.noop_out_interval = 30 node.conn[0].timeo.noop_out_timeout = 30 node.conn[0].iscsi.MaxRecvDataSegmentLength = 131072 node.conn[0].iscsi.HeaderDigest = None node.conn[0].iscsi.DataDigest = None node.conn[0].iscsi.IFMarker = No node.conn[0].iscsi.OFMarker = No [r...@localhost ~]# The above info is with the Oneway-CHAP. Let me know if you need any other info. Thx, Arvind. -----Original Message----- From: open-iscsi@googlegroups.com [mailto:open-is...@googlegroups.com] On Behalf Of Mike Christie Sent: Wednesday, January 28, 2009 3:31 PM To: open-iscsi@googlegroups.com Subject: Re: CHAP with Open-iSCSI Arvind Jain wrote: > Mike, > I have attached the wire shark trace for OneWay-CHAP and Mutual-CHAP. I am > not sure how helpful this is. > > In case of OneWay-CHAP, Open-iscsi initiator does not continues with the > login step and gives and error as follows: > > Logging in to [iface: default, target: iqn.2008-07.com.wasabi:osd.1, portal: > 192.168.0.90,3260] > iscsiadm: Could not login to [iface: default, target: > iqn.2008-07.com.wasabi:osd.1, portal: 192.168.0.90,3260]: > iscsiadm: initiator reported error (5 - encountered iSCSI login failure) > Target discovery or login failed > Could you give me the output of iscsiadm -m node -T iqn.2008-07.com.wasabi:osd.1 -p 192.168.0.90,3260 And could you run iscsid by hand with debugging and give me that output when you try to login # iscsid -d 8 -f & will print it out to the console. --~--~---------~--~----~------------~-------~--~----~ You received this message because you are subscribed to the Google Groups "open-iscsi" group. To post to this group, send email to open-iscsi@googlegroups.com To unsubscribe from this group, send email to open-iscsi+unsubscr...@googlegroups.com For more options, visit this group at http://groups.google.com/group/open-iscsi -~----------~----~----~----~------~----~------~--~---
[r...@localhost ~]# iscsid -d 8 -f & iscsid: sysfs_init: sysfs_path='/sys' iscsid: sysfs_attr_get_value: open '/module/scsi_transport_iscsi'/'version' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/module/scsi_transport_iscsi/version' iscsid: sysfs_attr_get_value: add to cache '/sys/module/scsi_transport_iscsi/version' iscsid: sysfs_attr_get_value: cache '/sys/module/scsi_transport_iscsi/version' with attribute value '2.0-867' iscsid: transport class version 2.0-867. iscsid version 2.0-869 iscsid: in ctldev_open iscsid: created NETLINK_ISCSI socket... iscsid: InitiatorName==iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: InitiatorName=iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: InitiatorAlias=localhost.localdomain iscsid: in ctldev_close [1] 3565 [r...@localhost ~]# iscsid: Max file limits 1024 1024 iscsid: reaped pid 3566, reap_count now 0 iscsid: poll result 1 iscsid: in read_transports iscsid: Adding new transport tcp iscsid: sysfs_attr_get_value: open '/class/iscsi_transport/tcp'/'handle' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/iscsi_transport/tcp/handle' iscsid: sysfs_attr_get_value: add to cache '/sys/class/iscsi_transport/tcp/handle' iscsid: sysfs_attr_get_value: cache '/sys/class/iscsi_transport/tcp/handle' with attribute value '3498551968' iscsid: sysfs_attr_get_value: open '/class/iscsi_transport/tcp'/'caps' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/iscsi_transport/tcp/caps' iscsid: sysfs_attr_get_value: add to cache '/sys/class/iscsi_transport/tcp/caps' iscsid: sysfs_attr_get_value: cache '/sys/class/iscsi_transport/tcp/caps' with attribute value '0x39' iscsid: Matched transport tcp iscsid: Allocted session 0x807ba28 iscsid: authentication setup complete... iscsid: resolved 192.168.0.90 to 192.168.0.90 iscsid: get conn context 0x8082e50 iscsid: set TCP recv window size to 524288, actually got 208896 iscsid: set TCP send window size to 524288, actually got 208896 iscsid: connecting to 192.168.0.90:3260 iscsid: sched conn context 0x8082e50 event 2, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: Setting login timer 0x8080dd8 timeout 15 iscsid: thread 0x8080dd8 schedule: delay 60 state 3 iscsid: thread 08080dd8 wait some more iscsid: exec thread 08082e50 callback iscsid: put conn context 0x8082e50 iscsid: connected local port 60589 to 192.168.0.90:3260 iscsid: in kcreate_session iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: expecting event 11, got 106, handling... iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 106 iscsid: in nlpayload_read iscsid: sysfs_attr_get_value: open '/class/scsi_host/host1'/'proc_name' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/scsi_host/host1/proc_name' iscsid: sysfs_attr_get_value: add to cache '/sys/class/scsi_host/host1/proc_name' iscsid: sysfs_attr_get_value: cache '/sys/class/scsi_host/host1/proc_name' with attribute value 'iscsi_tcp' iscsid: in read_transports iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: created new iSCSI session sid 1 host no 1 iscsid: in kcreate_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: created new iSCSI connection 1:0 iscsid: in kbind_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: bound iSCSI connection 1:0 to session 1 iscsid: sysfs_attr_get_value: open '/class/iscsi_connection/connection1:0'/'exp_statsn' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/iscsi_connection/connection1:0/exp_statsn' iscsid: sysfs_attr_get_value: add to cache '/sys/class/iscsi_connection/connection1:0/exp_statsn' iscsid: sysfs_attr_get_value: cache '/sys/class/iscsi_connection/connection1:0/exp_statsn' with attribute value '0' iscsid: sending login PDU with current stage 0, next stage 1, transit 0x80, isid 0x00023d010000 exp_statsn 0 iscsid: > InitiatorName=iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: > InitiatorAlias=localhost.localdomain iscsid: > TargetName=iqn.2008-07.com.wasabi:osd.1 iscsid: > SessionType=Normal iscsid: > AuthMethod=CHAP,None iscsid: in ksend_pdu_begin iscsid: send PDU began for hdr 48 bytes and data 172 bytes iscsid: in kwritev iscsid: wrote 48 bytes of PDU header iscsid: in kwritev iscsid: wrote 172 bytes of PDU data iscsid: in ksend_pdu_end iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: send PDU finished for conn 1:0 iscsid: thread removed iscsid: poll result 1 iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 101 iscsid: get conn context 0x8082e50 iscsid: message real length is 184 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 1, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: exec thread 08082e50 callback iscsid: in krecv_pdu_begin iscsid: recv PDU began, pdu handle 0x0x8083788 iscsid: in kread iscsid: read 48 bytes of PDU header iscsid: read 48 PDU header bytes, opcode 0x23, dlength 64, data 0x807e9cc, max 8192 iscsid: in kread iscsid: read 64 bytes of PDU data iscsid: finished reading login PDU, 48 hdr, 0 ah, 64 data, 0 pad iscsid: login current stage 0, next stage 1, transit 0x80 iscsid: > TargetAlias=myosdtarget1 iscsid: > AuthMethod=CHAP iscsid: > TargetPortalGroupTag=0 iscsid: in krecv_pdu_end iscsid: recv PDU finished for pdu handle 0x0x8083788 iscsid: put conn context 0x8082e50 iscsid: login response status 0000 iscsid: Login authentication failed with target iqn.2008-07.com.wasabi:osd.1 iscsid: login_rsp ret (5) iscsid: conn 0 giving up on login attempts iscsid: iscsi_login_eh iscsid: login failed STATE_IN_LOGIN/R_STAGE_NO_CHANGE 4 iscsid: disconnect conn iscsid: disconnecting conn 0x807e958, fd 6 iscsid: stop conn (conn state 2) iscsid: in kstop_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: kdestroy conn iscsid: in kdestroy_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: kdestroy session 1 iscsid: in kdestroy_session iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: expecting event 12, got 105, handling... iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 105 iscsid: get conn context 0x8082e50 iscsid: message real length is 72 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 5, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: in nlpayload_read iscsid: expecting event 12, got 104, handling... iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 104 iscsid: in nlpayload_read iscsid: session destroyed sid 1 host no 1 iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: thread 08080dd8 delete: state 1 iscsid: deleting a scheduled/waiting thread! iscsid: thread 08080dfc delete: state 0 iscsid: destroying session iscsid: thread 08082e50 delete: state 4 iscsid: deleting a scheduled/waiting thread! iscsid: put conn context 0x8082e50 iscsid: Releasing session 0x807ba28 iscsid: thread removed
[r...@localhost ~]# iscsid: poll result 1 iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: poll result 1 iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: poll result 1 iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: poll result 1 iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: poll result 1 iscsid: in read_transports iscsid: Matched transport tcp iscsid: Allocted session 0x807ba28 iscsid: authentication setup complete... iscsid: resolved 192.168.0.90 to 192.168.0.90 iscsid: get conn context 0x8082e50 iscsid: set TCP recv window size to 524288, actually got 208896 iscsid: set TCP send window size to 524288, actually got 208896 iscsid: connecting to 192.168.0.90:3260 iscsid: sched conn context 0x8082e50 event 2, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: Setting login timer 0x8080dd8 timeout 15 iscsid: thread 0x8080dd8 schedule: delay 60 state 3 iscsid: exec thread 08082e50 callback iscsid: put conn context 0x8082e50 iscsid: connected local port 56224 to 192.168.0.90:3260 iscsid: in kcreate_session iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: expecting event 11, got 106, handling... iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 106 iscsid: in nlpayload_read iscsid: sysfs_attr_get_value: open '/class/scsi_host/host2'/'proc_name' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/scsi_host/host2/proc_name' iscsid: sysfs_attr_get_value: add to cache '/sys/class/scsi_host/host2/proc_name' iscsid: sysfs_attr_get_value: cache '/sys/class/scsi_host/host2/proc_name' with attribute value 'iscsi_tcp' iscsid: in read_transports iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: created new iSCSI session sid 2 host no 2 iscsid: in kcreate_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: created new iSCSI connection 2:0 iscsid: in kbind_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: bound iSCSI connection 2:0 to session 2 iscsid: sysfs_attr_get_value: open '/class/iscsi_connection/connection2:0'/'exp_statsn' iscsid: sysfs_attr_get_value: new uncached attribute '/sys/class/iscsi_connection/connection2:0/exp_statsn' iscsid: sysfs_attr_get_value: add to cache '/sys/class/iscsi_connection/connection2:0/exp_statsn' iscsid: sysfs_attr_get_value: cache '/sys/class/iscsi_connection/connection2:0/exp_statsn' with attribute value '0' iscsid: sending login PDU with current stage 0, next stage 0, transit 0x0, isid 0x00023d020000 exp_statsn 0 iscsid: > InitiatorName=iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: > InitiatorAlias=localhost.localdomain iscsid: > TargetName=iqn.2008-07.com.wasabi:osd.1 iscsid: > SessionType=Normal iscsid: > AuthMethod=CHAP iscsid: in ksend_pdu_begin iscsid: send PDU began for hdr 48 bytes and data 168 bytes iscsid: in kwritev iscsid: wrote 48 bytes of PDU header iscsid: in kwritev iscsid: wrote 168 bytes of PDU data iscsid: in ksend_pdu_end iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: send PDU finished for conn 2:0 iscsid: thread removed iscsid: poll result 1 iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 101 iscsid: get conn context 0x8082e50 iscsid: message real length is 184 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 1, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: thread 08080dd8 wait some more iscsid: exec thread 08082e50 callback iscsid: in krecv_pdu_begin iscsid: recv PDU began, pdu handle 0x0x8083788 iscsid: in kread iscsid: read 48 bytes of PDU header iscsid: read 48 PDU header bytes, opcode 0x23, dlength 64, data 0x807e9cc, max 8192 iscsid: in kread iscsid: read 64 bytes of PDU data iscsid: finished reading login PDU, 48 hdr, 0 ah, 64 data, 0 pad iscsid: login current stage 0, next stage 0, transit 0x0 iscsid: > TargetAlias=myosdtarget1 iscsid: > AuthMethod=CHAP iscsid: > TargetPortalGroupTag=0 iscsid: in krecv_pdu_end iscsid: recv PDU finished for pdu handle 0x0x8083788 iscsid: put conn context 0x8082e50 iscsid: login response status 0000 iscsid: sending login PDU with current stage 0, next stage 0, transit 0x0, isid 0x00023d020000 exp_statsn 1 iscsid: > CHAP_A=5 iscsid: in ksend_pdu_begin iscsid: send PDU began for hdr 48 bytes and data 12 bytes iscsid: in kwritev iscsid: wrote 48 bytes of PDU header iscsid: in kwritev iscsid: wrote 12 bytes of PDU data iscsid: in ksend_pdu_end iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: send PDU finished for conn 2:0 iscsid: thread removed iscsid: poll result 1 iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 101 iscsid: get conn context 0x8082e50 iscsid: message real length is 660 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 1, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: exec thread 08082e50 callback iscsid: in krecv_pdu_begin iscsid: recv PDU began, pdu handle 0x0x8083788 iscsid: in kread iscsid: read 48 bytes of PDU header iscsid: read 48 PDU header bytes, opcode 0x23, dlength 539, data 0x807e9cc, max 8192 iscsid: in kread iscsid: read 539 bytes of PDU data iscsid: finished reading login PDU, 48 hdr, 0 ah, 539 data, 3 pad iscsid: login current stage 0, next stage 0, transit 0x0 iscsid: > CHAP_A=5 iscsid: > CHAP_I=41 iscsid: > CHAP_C=0x23be84e16cd6ae529049f1f1bbe9ebb3a6db3c870c3e99245e0d1c06b747deb3124dc843bb8ba61f035a7d0938251f5dd4cbfc96f5453b130d890a1cdbae32209a50ee407836fd124932f69e7d49dcad4f14f2444066d06bc430b7323ba122f622919de18b1fdab0ca9902b9729d492c807ec599d5e980b2eac9cc53bf67d6bf14d67e2ddc8e6683ef574961ff698f61cdd11e9d9c167272e61df0844f4a7702d7e8392c53cbc9121e33749e0cf4d5d49fd4a4597e35cf3222f4cccfd3902d48d38f75e6d91d2ae5c0f72b788187440e5f5000d4618dbe7b0515073b33821f187092da6454ceb1853e6915f8466a0496730ed9162f6768d4f74a4ad0576876 iscsid: in krecv_pdu_end iscsid: recv PDU finished for pdu handle 0x0x8083788 iscsid: put conn context 0x8082e50 iscsid: login response status 0000 iscsid: sending login PDU with current stage 0, next stage 1, transit 0x80, isid 0x00023d020000 exp_statsn 2 iscsid: > CHAP_N=user0 iscsid: > CHAP_R=0xb779e0bc0efdf06a9d812fe6f85c11e7 iscsid: > CHAP_I=46 iscsid: > CHAP_C=0x0f0165ccfb9938cf1b79d6f31aa3d533 iscsid: in ksend_pdu_begin iscsid: send PDU began for hdr 48 bytes and data 108 bytes iscsid: in kwritev iscsid: wrote 48 bytes of PDU header iscsid: in kwritev iscsid: wrote 108 bytes of PDU data iscsid: in ksend_pdu_end iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: send PDU finished for conn 2:0 iscsid: thread removed iscsid: poll result 1 iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 101 iscsid: get conn context 0x8082e50 iscsid: message real length is 176 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 1, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: exec thread 08082e50 callback iscsid: in krecv_pdu_begin iscsid: recv PDU began, pdu handle 0x0x8083788 iscsid: in kread iscsid: read 48 bytes of PDU header iscsid: read 48 PDU header bytes, opcode 0x23, dlength 55, data 0x807e9cc, max 8192 iscsid: in kread iscsid: read 55 bytes of PDU data iscsid: finished reading login PDU, 48 hdr, 0 ah, 55 data, 3 pad iscsid: login current stage 0, next stage 1, transit 0x80 iscsid: > CHAP_N=user0 iscsid: > CHAP_R=0x3259bdfdc0d249feb99320049b7719eb iscsid: in krecv_pdu_end iscsid: recv PDU finished for pdu handle 0x0x8083788 iscsid: put conn context 0x8082e50 iscsid: login response status 0000 iscsid: initiator authenticated target iqn.2008-07.com.wasabi:osd.1 iscsid: sending login PDU with current stage 1, next stage 3, transit 0x80, isid 0x00023d020000 exp_statsn 3 iscsid: > HeaderDigest=None iscsid: > DataDigest=None iscsid: > DefaultTime2Wait=2 iscsid: > DefaultTime2Retain=0 iscsid: > IFMarker=No iscsid: > OFMarker=No iscsid: > ErrorRecoveryLevel=0 iscsid: > InitialR2T=No iscsid: > ImmediateData=No iscsid: > MaxBurstLength=16776192 iscsid: > FirstBurstLength=262144 iscsid: > MaxOutstandingR2T=1 iscsid: > MaxConnections=1 iscsid: > DataPDUInOrder=Yes iscsid: > DataSequenceInOrder=Yes iscsid: > MaxRecvDataSegmentLength=131072 iscsid: in ksend_pdu_begin iscsid: send PDU began for hdr 48 bytes and data 312 bytes iscsid: in kwritev iscsid: wrote 48 bytes of PDU header iscsid: in kwritev iscsid: wrote 312 bytes of PDU data iscsid: in ksend_pdu_end iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: send PDU finished for conn 2:0 iscsid: thread removed iscsid: poll result 1 iscsid: in ctldev_handle iscsid: in nl_read iscsid: ctldev_handle got event type 101 iscsid: get conn context 0x8082e50 iscsid: message real length is 436 bytes, recv_handle 0x8083750 iscsid: in nlpayload_read iscsid: sched conn context 0x8082e50 event 1, tmo 0 iscsid: thread 0x8082e50 schedule: delay 0 state 3 iscsid: thread 08080dd8 wait some more iscsid: exec thread 08082e50 callback iscsid: in krecv_pdu_begin iscsid: recv PDU began, pdu handle 0x0x8083788 iscsid: in kread iscsid: read 48 bytes of PDU header iscsid: read 48 PDU header bytes, opcode 0x23, dlength 313, data 0x807e9cc, max 8192 iscsid: in kread iscsid: read 313 bytes of PDU data iscsid: finished reading login PDU, 48 hdr, 0 ah, 313 data, 1 pad iscsid: login current stage 1, next stage 3, transit 0x80 iscsid: > HeaderDigest=None iscsid: > DataDigest=None iscsid: > DefaultTime2Wait=2 iscsid: > DefaultTime2Retain=0 iscsid: > IFMarker=No iscsid: > OFMarker=No iscsid: > ErrorRecoveryLevel=0 iscsid: > InitialR2T=Yes iscsid: > ImmediateData=No iscsid: > MaxBurstLength=262144 iscsid: > FirstBurstLength=Irrelevant iscsid: > MaxOutstandingR2T=1 iscsid: > MaxConnections=1 iscsid: > DataPDUInOrder=Yes iscsid: > DataSequenceInOrder=Yes iscsid: > MaxRecvDataSegmentLength=262144 iscsid: in krecv_pdu_end iscsid: recv PDU finished for pdu handle 0x0x8083788 iscsid: put conn context 0x8082e50 iscsid: login response status 0000 iscsid: thread 08080dd8 delete: state 1 iscsid: deleting a scheduled/waiting thread! iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 0 to: iscsid: 131072 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 1 to: iscsid: 262144 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 2 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 3 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 4 to: iscsid: 1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 5 to: iscsid: 1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 6 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 7 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 8 to: iscsid: 262144 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 9 to: iscsid: 1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 10 to: iscsid: 1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 11 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 14 to: iscsid: 4 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 15 to: iscsid: iqn.2008-07.com.wasabi:osd.1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 16 to: iscsid: 0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 17 to: iscsid: 192.168.0.90 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 18 to: iscsid: 3260 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 19 to: iscsid: 120 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 22 to: iscsid: user0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 23 to: iscsid: user0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 24 to: iscsid: targetsecret0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 25 to: iscsid: initiatorsecret0 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 26 to: iscsid: 1 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 27 to: iscsid: 15 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 28 to: iscsid: 20 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 30 to: iscsid: 30 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 31 to: iscsid: 30 iscsid: in kset_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: expecting event 16, got 103, handling... iscsid: in nlpayload_read iscsid: received iferror -38 iscsid: set operational parameter 32 to: iscsid: default iscsid: in kset_host_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 1 to: iscsid: iqn.2005-03.org.open-iscsi:1bd5bc7d3378 iscsid: in kset_host_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 2 to: iscsid: default iscsid: in kset_host_param iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: set operational parameter 0 to: iscsid: default iscsid: in kstart_conn iscsid: in __kipc_call iscsid: in kwritev iscsid: in nlpayload_read iscsid: in nlpayload_read iscsid: scanning host2 using /sys/class/iscsi_session iscsid: scanning host2 completed iscsid: mgmt_ipc_write_rsp: rsp to fd 5 iscsid: in ctldev_close iscsid: Releasing session 0x807ba28 iscsid: scanning host2 from pid 3659 iscsid: connection2:0 is operational now iscsid: thread removed iscsid: reaped pid 3659, reap_count now 0