我在设置 iSCSI Target Attach 时犯了什么错误?

问题描述 投票:0回答:1

我使用 ceph-iscsi 构建了一个 iSCSI 网关,并设置了一个 iSCSI 目标和一个可以连接到该目标的启动器。

如下图所示,我在服务器的Bios - 网络设置中输入了iSCSI Initiator和Target信息。

enter image description here

enter image description here

enter image description here

iSCSI 连接失败,我附上了 ceph-iscsi 的一些内核日志。

在日志中,“在 CID 上未收到对 NOPIN 的响应:1,在消息“在 CID 上启动 NOPIN 响应计时器:1 到 5”之后,I_T Nexus iqn.2023-07.com.kakao 连接失败:initiator1111,i,0x349691d2ea8a,iqn.2023-07.com.kakao:target,t,0x0输出 iSCSI 连接 1 后的秒数,并且在 iSCSI 连接终止后,从头开始再次尝试 iSCSI 连接并重复。

请告知是什么问题。

# ceph-iscsi kern.log
[507977.797512] iscsi_start_login_thread_timer: Added timeout timer to iSCSI login request for 15 seconds.
[507977.797519] __iscsi_target_login_thread: Moving to TARG_CONN_STATE_XPT_UP.
[507977.797538] rx_data: rx_loop: 48, total_rx: 48, data: 48
[507977.797541] iscsit_get_login_rx: Got Login Command, Flags 0x01, ITT: 0x01000000, CmdSN: 0x01000000, ExpStatSN: 0x00000000, CID: 256, Length: 145
[507977.797548] rx_data: rx_loop: 148, total_rx: 148, data: 148
[507977.797551] __iscsi_target_login_thread: Received iSCSI login request from 192.168.36.100:1029 on iSCSI/TCP Network Portal 192.168.36.5:3260
[507977.797556] __iscsi_target_login_thread: Moving to TARG_CONN_STATE_IN_LOGIN.
[507977.797589] iscsi_target_set_sock_callbacks: Entering iscsi_target_set_sock_callbacks: conn: 000000003f28dd8e
[507977.797596] iscsi_target_locate_portal: Located Storage Object: iqn.2023-07.com.kakao:target
[507977.797600] iscsi_target_locate_portal: Located Portal Group Object: 1
[507977.797798] iscsi_update_param_value: iSCSI Parameter updated to TargetPortalGroupTag=1
[507977.797802] iscsi_update_param_value: iSCSI Parameter updated to ErrorRecoveryLevel=0
[507977.797806] iscsi_decode_text_input: Got key: InitiatorName=iqn.2023-07.com.kakao:initiator1111
[507977.797811] iscsi_update_param_value: iSCSI Parameter updated to InitiatorName=iqn.2023-07.com.kakao:initiator1111
[507977.797814] iscsi_decode_text_input: Got key: SessionType=Normal
[507977.797816] iscsi_update_param_value: iSCSI Parameter updated to SessionType=Normal
[507977.797818] iscsi_decode_text_input: Got key: TargetName=iqn.2023-07.com.kakao:target
[507977.797821] iscsi_update_param_value: iSCSI Parameter updated to TargetName=iqn.2023-07.com.kakao:target
[507977.797823] iscsi_decode_text_input: Got key: AuthMethod=CHAP
[507977.797826] iscsi_update_param_value: iSCSI Parameter updated to AuthMethod=CHAP
[507977.797832] iscsi_encode_text_output: Sending key: AuthMethod=CHAP
[507977.797834] iscsi_encode_text_output: Sending key: TargetAlias=LIO Target
[507977.797836] iscsi_encode_text_output: Sending key: TargetPortalGroupTag=1
[507977.797839] iscsi_target_do_tx_login_io: Sending Login Response, Flags: 0x00, ITT: 0x01000000, ExpCmdSN; 0x00000001, MaxCmdSN: 0x00000001, StatSN: 0xdc4e8515, Length: 62
[507977.797862] tx_data: tx_loop: 112, total_tx: 112, data: 112
[507977.797867] iscsit_alloc_conn: Moving to TARG_CONN_STATE_FREE.
[507980.933577] iscsi_target_sk_data_ready: Entering iscsi_target_sk_data_ready: conn: 000000003f28dd8e
[507980.933620] iscsi_target_do_login_rx: entering iscsi_target_do_login_rx, conn: 000000003f28dd8e, kworker/151:1:1427
[507980.933631] iscsi_target_do_login_rx: Starting login timer for kworker/151:1/1427
[507980.933642] rx_data: rx_loop: 48, total_rx: 48, data: 48
[507980.933646] iscsit_get_login_rx: Got Login Command, Flags 0x01, ITT: 0x01000000, CmdSN: 0x01000000, ExpStatSN: 0x16854edc, CID: 256, Length: 9
[507980.933657] rx_data: rx_loop: 12, total_rx: 12, data: 12
[507980.933661] iscsi_target_do_login_rx: iscsi_target_do_login_rx after rx_login_io, 000000003f28dd8e, kworker/151:1:1427
[507980.933670] iscsi_decode_text_input: Got key: CHAP_A=5
[507980.933683] chap_check_algorithm: Selected md5 Algorithm
[507980.933702] chap_server_open: [server] Got CHAP_A=5
[507980.933704] chap_server_open: [server] Sending CHAP_A=5
[507980.933708] chap_server_open: [server] Sending CHAP_I=3
[507980.933711] chap_gen_challenge: [server] Sending CHAP_C=0xbd0bba967bf1a1b22b327130aa3494ee
[507980.933711]
[507980.933715] iscsi_target_do_authentication: Received OK response from LIO Authentication, continuing.
[507980.933718] iscsi_target_do_tx_login_io: Sending Login Response, Flags: 0x00, ITT: 0x01000000, ExpCmdSN; 0x00000001, MaxCmdSN: 0x00000001, StatSN: 0xdc4e8516, Length: 60
[507980.933759] tx_data: tx_loop: 108, total_tx: 108, data: 108
[507999.109620] iscsi_target_sk_data_ready: Entering iscsi_target_sk_data_ready: conn: 000000003f28dd8e
[507999.109666] iscsi_target_do_login_rx: entering iscsi_target_do_login_rx, conn: 000000003f28dd8e, kworker/151:1:1427
[507999.109673] iscsi_target_do_login_rx: Starting login timer for kworker/151:1/1427
[507999.109682] rx_data: rx_loop: 48, total_rx: 48, data: 48
[507999.109687] iscsit_get_login_rx: Got Login Command, Flags 0x81, ITT: 0x01000000, CmdSN: 0x01000000, ExpStatSN: 0x17854edc, CID: 256, Length: 58
[507999.109699] rx_data: rx_loop: 60, total_rx: 60, data: 60
[507999.109703] iscsi_target_do_login_rx: iscsi_target_do_login_rx after rx_login_io, 000000003f28dd8e, kworker/151:1:1427
[507999.109712] iscsi_decode_text_input: Got key: CHAP_N=lucian86
[507999.109729] chap_server_compute_hash: [server] Got CHAP_N=lucian86
[507999.109733] chap_server_compute_hash: [server] Got CHAP_R=06E3CD958548DF9BBD60741BEAC61020
[507999.109751] chap_server_compute_hash: [server] md5 Server Digest: 06e3cd958548df9bbd60741beac61020
[507999.109755] chap_server_compute_hash: [server] md5 Digests match, CHAP connection successful.
[507999.109755]
[507999.109759] iscsi_target_do_authentication: iSCSI security negotiation completed successfully.
[507999.109770] iscsi_target_do_tx_login_io: Sending Login Response, Flags: 0x81, ITT: 0x01000000, ExpCmdSN; 0x00000001, MaxCmdSN: 0x00000001, StatSN: 0xdc4e8517, Length: 0
[507999.109788] tx_data: tx_loop: 48, total_tx: 48, data: 48
[508072.581782] iscsi_target_sk_data_ready: Entering iscsi_target_sk_data_ready: conn: 000000003f28dd8e
[508072.581839] iscsi_target_do_login_rx: entering iscsi_target_do_login_rx, conn: 000000003f28dd8e, kworker/151:1:1427
[508072.581848] iscsi_target_do_login_rx: Starting login timer for kworker/151:1/1427
[508072.581859] rx_data: rx_loop: 48, total_rx: 48, data: 48
[508072.581865] iscsit_get_login_rx: Got Login Command, Flags 0x87, ITT: 0x01000000, CmdSN: 0x01000000, ExpStatSN: 0x18854edc, CID: 256, Length: 284
[508072.581876] rx_data: rx_loop: 284, total_rx: 284, data: 284
[508072.581879] iscsi_target_do_login_rx: iscsi_target_do_login_rx after rx_login_io, 000000003f28dd8e, kworker/151:1:1427
[508072.581887] iscsi_decode_text_input: Got key: HeaderDigest=None
[508072.581896] iscsi_update_param_value: iSCSI Parameter updated to HeaderDigest=None
[508072.581899] iscsi_decode_text_input: Got key: DataDigest=None
[508072.581902] iscsi_update_param_value: iSCSI Parameter updated to DataDigest=None
[508072.581904] iscsi_decode_text_input: Got key: ErrorRecoveryLevel=0
[508072.581916] iscsi_update_param_value: iSCSI Parameter updated to ErrorRecoveryLevel=0
[508072.581919] iscsi_decode_text_input: Got key: InitialR2T=No
[508072.581921] iscsi_update_param_value: iSCSI Parameter updated to InitialR2T=Yes
[508072.581923] iscsi_decode_text_input: Got key: ImmediateData=Yes
[508072.581926] iscsi_decode_text_input: Got key: MaxRecvDataSegmentLength=65536
[508072.581930] iscsi_update_param_value: iSCSI Parameter updated to MaxRecvDataSegmentLength=65536
[508072.581935] iscsi_check_acceptor_state: Saving op->MaxRecvDataSegmentLength from original initiator received value: 65536
[508072.581938] iscsi_update_param_value: iSCSI Parameter updated to MaxRecvDataSegmentLength=262144
[508072.581941] iscsi_check_acceptor_state: Updated MaxRecvDataSegmentLength to target MXDSL value: 262144
[508072.581943] iscsi_decode_text_input: Got key: MaxBurstLength=262144
[508072.581947] iscsi_update_param_value: iSCSI Parameter updated to MaxBurstLength=262144
[508072.581949] iscsi_decode_text_input: Got key: FirstBurstLength=65536
[508072.581952] iscsi_update_param_value: iSCSI Parameter updated to FirstBurstLength=65536
[508072.581953] iscsi_decode_text_input: Got key: MaxConnections=1
[508072.581956] iscsi_update_param_value: iSCSI Parameter updated to MaxConnections=1
[508072.581958] iscsi_decode_text_input: Got key: DataPDUInOrder=Yes
[508072.581961] iscsi_update_param_value: iSCSI Parameter updated to DataPDUInOrder=Yes
[508072.581963] iscsi_decode_text_input: Got key: DataSequenceInOrder=Yes
[508072.581965] iscsi_update_param_value: iSCSI Parameter updated to DataSequenceInOrder=Yes
[508072.581967] iscsi_decode_text_input: Got key: DefaultTime2Wait=2
[508072.581970] iscsi_update_param_value: iSCSI Parameter updated to DefaultTime2Wait=2
[508072.581972] iscsi_decode_text_input: Got key: DefaultTime2Retain=20
[508072.581975] iscsi_update_param_value: iSCSI Parameter updated to DefaultTime2Retain=20
[508072.581976] iscsi_decode_text_input: Got key: MaxOutstandingR2T=1
[508072.581979] iscsi_update_param_value: iSCSI Parameter updated to MaxOutstandingR2T=1
[508072.581989] iscsi_encode_text_output: Sending key: HeaderDigest=None
[508072.581990] iscsi_encode_text_output: Sending key: DataDigest=None
[508072.581992] iscsi_encode_text_output: Sending key: MaxConnections=1
[508072.581994] iscsi_encode_text_output: Sending key: InitialR2T=Yes
[508072.581996] iscsi_encode_text_output: Sending key: ImmediateData=Yes
[508072.581998] iscsi_encode_text_output: Sending key: MaxRecvDataSegmentLength=262144
[508072.582000] iscsi_encode_text_output: Sending key: MaxBurstLength=262144
[508072.582001] iscsi_encode_text_output: Sending key: FirstBurstLength=65536
[508072.582004] iscsi_encode_text_output: Sending key: DefaultTime2Wait=2
[508072.582006] iscsi_encode_text_output: Sending key: DefaultTime2Retain=20
[508072.582008] iscsi_encode_text_output: Sending key: MaxOutstandingR2T=1
[508072.582010] iscsi_encode_text_output: Sending key: ErrorRecoveryLevel=0
[508072.582013] iscsi_target_restore_sock_callbacks: Entering iscsi_target_restore_sock_callbacks: conn: 000000003f28dd8e
[508072.582017] iscsi_target_do_tx_login_io: Sending Login Response, Flags: 0x87, ITT: 0x01000000, ExpCmdSN; 0x00000001, MaxCmdSN: 0x00000001, StatSN: 0xdc4e8518, Length: 243
[508072.582260] tx_data: tx_loop: 292, total_tx: 292, data: 292
[508072.582267] iscsi_post_login_handler: Moving to TARG_CONN_STATE_LOGGED_IN.
[508072.582269] iscsi_set_connection_parameters: ------------------------------------------------------------------
[508072.582271] iscsi_set_connection_parameters: AuthMethod:                   CHAP
[508072.582274] iscsi_set_connection_parameters: HeaderDigest:                 None
[508072.582276] iscsi_set_connection_parameters: DataDigest:                   None
[508072.582279] iscsi_set_connection_parameters: MaxXmitDataSegmentLength:     262144
[508072.582282] iscsi_set_connection_parameters: MaxRecvDataSegmentLength:     65536
[508072.582286] iscsi_set_connection_parameters: ------------------------------------------------------------------
[508072.582288] iscsi_set_session_parameters: ------------------------------------------------------------------
[508072.582292] iscsi_set_session_parameters: MaxConnections:               1
[508072.582294] iscsi_set_session_parameters: TargetName:                   iqn.2023-07.com.kakao:target
[508072.582297] iscsi_set_session_parameters: InitiatorName:                iqn.2023-07.com.kakao:initiator1111
[508072.582300] iscsi_set_session_parameters: TargetAlias:                  LIO Target
[508072.582301] iscsi_set_session_parameters: TargetPortalGroupTag:         1
[508072.582304] iscsi_set_session_parameters: InitialR2T:                   Yes
[508072.582305] iscsi_set_session_parameters: ImmediateData:                Yes
[508072.582308] iscsi_set_session_parameters: MaxBurstLength:               262144
[508072.582311] iscsi_set_session_parameters: FirstBurstLength:             65536
[508072.582314] iscsi_set_session_parameters: DefaultTime2Wait:             2
[508072.582316] iscsi_set_session_parameters: DefaultTime2Retain:           20
[508072.582317] iscsi_set_session_parameters: MaxOutstandingR2T:            1
[508072.582319] iscsi_set_session_parameters: DataPDUInOrder:               Yes
[508072.582321] iscsi_set_session_parameters: DataSequenceInOrder:          Yes
[508072.582322] iscsi_set_session_parameters: ErrorRecoveryLevel:           0
[508072.582325] iscsi_set_session_parameters: SessionType:                  Normal
[508072.582326] iscsi_set_session_parameters: ------------------------------------------------------------------
[508072.582338] iscsi_post_login_handler: Moving to TARG_SESS_STATE_LOGGED_IN.
[508072.582340] iscsi_post_login_handler: iSCSI Login successful on CID: 1 from 192.168.36.100:1029 to 192.168.36.5:3260,1
[508072.582345] iscsi_post_login_handler: Incremented iSCSI Connection count to 1 from node: iqn.2023-07.com.kakao:initiator1111
[508072.582347] iscsi_post_login_handler: Established iSCSI session from node: iqn.2023-07.com.kakao:initiator1111
[508072.582349] iscsi_post_login_handler: Incremented number of active iSCSI sessions to 1 on iSCSI Target Portal Group: 1
[508072.582354] __iscsit_start_nopin_timer: Started NOPIN Timer on CID: 1 at 5 second interval
[508077.701623] iscsit_start_nopin_response_timer: Started NOPIN Response Timer on CID: 1 to 5 seconds
[508077.701659] iscsit_build_nopin_rsp: Built NOPIN Unsolicited Response ITT: 0xffffffff, TTT: 0x00000000, StatSN: 0xdc4e8519, Length 0
[508077.701671] iscsit_send_unsolicited_nopin: Sending Unsolicited NOPIN TTT: 0x00000000 StatSN: 0xdc4e8519 CID: 1
[508077.701710] tx_data: tx_loop: 48, total_tx: 48, data: 48
[508082.821626] Did not receive response to NOPIN on CID: 1, failing connection for I_T Nexus iqn.2023-07.com.kakao:initiator1111,i,0x349691d2ea8a,iqn.2023-07.com.kakao:target,t,0x01
[508082.840602] rx_data: rx_loop: -512 total_rx: 0
[508082.840612] iscsit_take_action_for_connection_exit: Moving to TARG_CONN_STATE_CLEANUP_WAIT.
[508082.840617] iscsit_handle_connection_cleanup: Performing cleanup for failed iSCSI Connection ID: 1 from iqn.2023-07.com.kakao:initiator1111
[508082.840624] iscsit_close_connection: Closing iSCSI connection CID 1 on SID: 4
[508082.840661] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000081
[508082.840715] iscsit_close_connection: Moving to TARG_CONN_STATE_FREE.
[508082.840719] iscsit_close_connection: Decremented iSCSI connection count to 0 from node: iqn.2023-07.com.kakao:initiator1111
[508082.840743] iscsit_close_session: Moving to TARG_SESS_STATE_FREE.
[508082.840745] iscsit_close_session: Released iSCSI session from node: iqn.2023-07.com.kakao:initiator1111
[508082.840747] iscsit_close_session: Decremented number of active iSCSI Sessions on iSCSI TPG: 1 to 0

使用 open-iscsi 连接 iSCSI 效果很好,无需使用 Bios - 网络。


按照 @Mike Andrews 的建议,我将 NOPIN_TIMEOUT 设置为 0,并且“未收到对 CID 上 NOPIN 的响应:1,I_T Nexus 连接失败...”消息消失了!

谢谢@迈克·安德鲁斯

但是,如果如下所示发送了 tx,并且 120 秒内没有收到 rx,则终止。对此有什么建议吗?

        ...
        [558929.675224] iscsi_target_restore_sock_callbacks: Entering iscsi_target_restore_sock_callbacks: conn: 00000000dd3dace4
        [558929.675226] iscsi_target_do_tx_login_io: Sending Login Response, Flags: 0x87, ITT: 0x01000000, ExpCmdSN; 0x00000001, MaxCmdSN: 0x00000001, StatSN: 0xd2907d03, Length: 243
        [558929.675449] tx_data: tx_loop: 292, total_tx: 292, data: 292
        [558929.675453] iscsi_post_login_handler: Moving to TARG_CONN_STATE_LOGGED_IN.
        [558929.675456] iscsi_set_connection_parameters: ------------------------------------------------------------------
        [558929.675459] iscsi_set_connection_parameters: AuthMethod:                   CHAP
        [558929.675460] iscsi_set_connection_parameters: HeaderDigest:                 None
        [558929.675462] iscsi_set_connection_parameters: DataDigest:                   None
        [558929.675465] iscsi_set_connection_parameters: MaxXmitDataSegmentLength:     262144
        [558929.675467] iscsi_set_connection_parameters: MaxRecvDataSegmentLength:     65536
        [558929.675471] iscsi_set_connection_parameters: ------------------------------------------------------------------
        [558929.675472] iscsi_set_session_parameters: ------------------------------------------------------------------
        [558929.675475] iscsi_set_session_parameters: MaxConnections:               1
        [558929.675478] iscsi_set_session_parameters: TargetName:                   iqn.2023-07.com.kakao:target
        [558929.675481] iscsi_set_session_parameters: InitiatorName:                iqn.2023-07.com.kakao:initiator1111
        [558929.675483] iscsi_set_session_parameters: TargetAlias:                  LIO Target
        [558929.675485] iscsi_set_session_parameters: TargetPortalGroupTag:         1
        [558929.675487] iscsi_set_session_parameters: InitialR2T:                   Yes
        [558929.675489] iscsi_set_session_parameters: ImmediateData:                Yes
        [558929.675491] iscsi_set_session_parameters: MaxBurstLength:               262144
        [558929.675493] iscsi_set_session_parameters: FirstBurstLength:             65536
        [558929.675495] iscsi_set_session_parameters: DefaultTime2Wait:             2
        [558929.675497] iscsi_set_session_parameters: DefaultTime2Retain:           20
        [558929.675499] iscsi_set_session_parameters: MaxOutstandingR2T:            1
        [558929.675501] iscsi_set_session_parameters: DataPDUInOrder:               Yes
        [558929.675502] iscsi_set_session_parameters: DataSequenceInOrder:          Yes
        [558929.675504] iscsi_set_session_parameters: ErrorRecoveryLevel:           0
        [558929.675506] iscsi_set_session_parameters: SessionType:                  Normal
        [558929.675508] iscsi_set_session_parameters: ------------------------------------------------------------------
        [558929.675515] iscsi_post_login_handler: Moving to TARG_SESS_STATE_LOGGED_IN.
        [558929.675516] iscsi_post_login_handler: iSCSI Login successful on CID: 2 from 192.168.36.100:1151 to 192.168.36.5:3260,1
        [558929.675521] iscsi_post_login_handler: Incremented iSCSI Connection count to 1 from node: iqn.2023-07.com.kakao:initiator1111
        [558929.675522] iscsi_post_login_handler: Established iSCSI session from node: iqn.2023-07.com.kakao:initiator1111
        [558929.675524] iscsi_post_login_handler: Incremented number of active iSCSI sessions to 1 on iSCSI Target Portal Group: 1
        [558929.675652] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [558929.675670] iscsit_setup_scsi_cmd: Got SCSI Command, ITT: 0x01000000, CmdSN: 0x01000000, ExpXferLen: 512, Length: 0, CID: 2
        [558929.675680] iscsit_check_received_cmdsn: Received CmdSN matches ExpCmdSN, incremented ExpCmdSN to: 0x00000002
        [558929.676364] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000081
        [558929.676377] iscsit_build_datain_pdu: Built DataIN ITT: 0x01000000, StatSN: 0xd2907d04, DataSN: 0x00000000, Offset: 0, Length: 512, CID: 2
        [558929.676439] tx_data: tx_loop: 48, total_tx: 48, data: 48
        [558929.882533] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [558929.882546] iscsit_setup_scsi_cmd: Got SCSI Command, ITT: 0x02000000, CmdSN: 0x02000000, ExpXferLen: 16384, Length: 0, CID: 2
        [558929.882552] iscsit_check_received_cmdsn: Received CmdSN matches ExpCmdSN, incremented ExpCmdSN to: 0x00000003
        [558929.882574] lio_release_cmd: Entering lio_release_cmd for se_cmd: 00000000324266a7
        [558929.883429] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000082
        [558929.883432] iscsit_build_datain_pdu: Built DataIN ITT: 0x02000000, StatSN: 0xd2907d05, DataSN: 0x00000000, Offset: 0, Length: 16384, CID: 2
        [558929.883482] tx_data: tx_loop: 48, total_tx: 48, data: 48
        [558942.986774] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [558942.986792] iscsit_setup_scsi_cmd: Got SCSI Command, ITT: 0x03000000, CmdSN: 0x03000000, ExpXferLen: 16384, Length: 0, CID: 2
        [558942.986800] iscsit_check_received_cmdsn: Received CmdSN matches ExpCmdSN, incremented ExpCmdSN to: 0x00000004
        [558942.986828] lio_release_cmd: Entering lio_release_cmd for se_cmd: 00000000d821126d
        [558943.194949] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000083
        [558943.194953] iscsit_build_datain_pdu: Built DataIN ITT: 0x03000000, StatSN: 0xd2907d06, DataSN: 0x00000000, Offset: 0, Length: 16384, CID: 2
        [558943.195002] tx_data: tx_loop: 48, total_tx: 48, data: 48
        [558956.558319] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [558956.558335] iscsit_setup_scsi_cmd: Got SCSI Command, ITT: 0x04000000, CmdSN: 0x04000000, ExpXferLen: 512, Length: 0, CID: 2
        [558956.558343] iscsit_check_received_cmdsn: Received CmdSN matches ExpCmdSN, incremented ExpCmdSN to: 0x00000005
        [558956.558372] lio_release_cmd: Entering lio_release_cmd for se_cmd: 00000000728b221d
        [558958.411518] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000084
        [558958.411529] iscsit_build_datain_pdu: Built DataIN ITT: 0x04000000, StatSN: 0xd2907d07, DataSN: 0x00000000, Offset: 0, Length: 512, CID: 2
        [558958.411585] tx_data: tx_loop: 48, total_tx: 48, data: 48
        [558998.282819] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [558998.282838] iscsit_setup_scsi_cmd: Got SCSI Command, ITT: 0x05000000, CmdSN: 0x05000000, ExpXferLen: 512, Length: 0, CID: 2
        [558998.282845] iscsit_check_received_cmdsn: Received CmdSN matches ExpCmdSN, incremented ExpCmdSN to: 0x00000006
        [558998.282872] lio_release_cmd: Entering lio_release_cmd for se_cmd: 00000000677c3747
        [558998.490952] iscsit_increment_maxcmdsn: Updated MaxCmdSN to 0x00000085
        [558998.490955] iscsit_build_datain_pdu: Built DataIN ITT: 0x05000000, StatSN: 0xd2907d08, DataSN: 0x00000000, Offset: 0, Length: 512, CID: 2
        [558998.490985] tx_data: tx_loop: 48, total_tx: 48, data: 48



        [559122.279650] rx_data: rx_loop: -104 total_rx: 0
        [559124.299046] iscsit_take_action_for_connection_exit: Moving to TARG_CONN_STATE_CLEANUP_WAIT.
        [559124.299057] iscsit_handle_connection_cleanup: Performing cleanup for failed iSCSI Connection ID: 2 from iqn.2023-07.com.kakao:initiator1111
        [559124.299061] iscsit_close_connection: Closing iSCSI connection CID 2 on SID: 9
        [559124.299146] lio_release_cmd: Entering lio_release_cmd for se_cmd: 00000000e102a5f8
        [559124.299183] iscsit_close_connection: Moving to TARG_CONN_STATE_FREE.
        [559124.299187] iscsit_close_connection: Decremented iSCSI connection count to 0 from node: iqn.2023-07.com.kakao:initiator1111
        [559124.299209] iscsit_close_session: Moving to TARG_SESS_STATE_FREE.
        [559124.299211] iscsit_close_session: Released iSCSI session from node: iqn.2023-07.com.kakao:initiator1111
        [559124.299213] iscsit_close_session: Decremented number of active iSCSI Sessions on iSCSI TPG: 1 to 0
        [559153.291127] iscsi_start_login_thread_timer: Added timeout timer to iSCSI login request for 15 seconds.
        [559153.291138] __iscsi_target_login_thread: Moving to TARG_CONN_STATE_XPT_UP.
        [559153.291148] rx_data: rx_loop: 48, total_rx: 48, data: 48
        [559153.291153] iscsit_get_login_rx: Got Login Command, Flags 0x01, ITT: 0x01000000, CmdSN: 0x01000000, ExpStatSN: 0x00000000, CID: 1024, Length: 145
        [559153.291160] rx_data: rx_loop: 148, total_rx: 148, data: 148
        [559153.291163] __iscsi_target_login_thread: Received iSCSI login request from 192.168.36.100:1155 on iSCSI/TCP Network Portal 192.168.36.5:3260
        [559153.291167] __iscsi_target_login_thread: Moving to TARG_CONN_STATE_IN_LOGIN.
        [559153.291197] iscsi_target_set_sock_callbacks: Entering iscsi_target_set_sock_callbacks: conn: 000000004edc1cbe

        < repeated >

storage ceph iscsi
1个回答
0
投票

Linux LIO iSCSI 目标通过将未经请求的 NOP-IP PDU 发送回启动器并期待响应来探测启动器的响应能力。当 5 秒内没有收到消息时,它会关闭连接。这是一种向后的协议交互,处理起来可能很棘手。它以引发轻量级 iSCSI 启动器而闻名。

如果您查看 iPXE 的 iSCSI Targets Known to Work with iPXE 页面,您将看到如何禁用此行为。 (我不知道您的戴尔是否正在运行 iPXE 启动器,但这是一个很好的参考。)此命令将其完全关闭:

  lio_node --setnodeattr <TARGET_IQN> <TPGT> <INITIATOR_IQN> nopin_timeout 0

在Linux内核中,您可以看到将其设置为0会短路启动计时器的过程。您不应该再看到“Started NOPIN Timer...”调试消息:

void __iscsit_start_nopin_timer(struct iscsit_conn *conn)
{
    struct iscsit_session *sess = conn->sess;
    struct iscsi_node_attrib *na = iscsit_tpg_get_node_attrib(sess);

    lockdep_assert_held(&conn->nopin_timer_lock);

    /*
    * NOPIN timeout is disabled.
     */
    if (!na->nopin_timeout)
        return;

    if (conn->nopin_timer_flags & ISCSI_TF_RUNNING)
        return;

    conn->nopin_timer_flags &= ~ISCSI_TF_STOP;
    conn->nopin_timer_flags |= ISCSI_TF_RUNNING;
    mod_timer(&conn->nopin_timer, jiffies + na->nopin_timeout * HZ);

    pr_debug("Started NOPIN Timer on CID: %d at %u second"
        " interval\n", conn->cid, na->nopin_timeout);
}
© www.soinside.com 2019 - 2024. All rights reserved.