Discussion:
Bookworm: IBM DSD3300 iSCSI connection problem
(too old to reply)
Greg
2024-06-16 19:50:01 UTC
Permalink
Hi there,

I'm trying to mount iscsi share exported from old IBM DS3300.
Unfortunately I get the following error:

ping timeout of 5 secs expired, recv timeout 5, last rx 4405941922, last
ping 4405943173, now 4405944448

DS3300 is in "Optimal" state.

Thanks in advance for any help

More info from dmesg:

[444198.925420] scsi 10:0:0:31: Attached scsi generic sg7 type 0
[444209.025722] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405941922, last ping 4405943173, now 4405944448
[444209.025765] connection12:0: detected conn error (1022)
[444211.083687] sd 10:0:0:0: Power-on or device reset occurred
[444221.313734] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405944962, last ping 4405946240, now 4405947520
[444221.313780] connection12:0: detected conn error (1022)
[444223.373262] sd 10:0:0:0: Power-on or device reset occurred
[444233.601772] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405948034, last ping 4405949312, now 4405950592
[444233.601814] connection12:0: detected conn error (1022)

and so on...
On DS3300 error log I see:

Date/Time: 6/16/24 9:27:04 PM
Sequence number: 621
Event type: 180D
Description: Session terminated unexpectedly
Event specific codes: 0/0/0
Event category: Internal
Component type: iSCSI Initiator
Component location: iqn.1993-08.org.debian:01:bc2c2e478b92
Logged by: Controller in slot A

Raw data:
4d 45 4c 48 03 00 00 00 6d 02 00 00 00 00 00 00
0d 18 49 02 88 3c 6f 66 00 00 00 00 00 00 00 00
00 00 00 00 04 00 00 00 19 00 00 00 19 00 00 00
26 00 00 00 69 71 6e 2e 31 39 39 33 2d 30 38 2e
6f 72 67 2e 64 65 62 69 61 6e 3a 30 31 3a 62 63
32 63 32 65 34 37 38 62 39 32 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01 00 00 00 00 00 00 00 00 00 00 00

From DS3300 service console:

06/16/24-19:26:55 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0038 0021 f0000 0000
06/16/24-19:26:55 (GMT) (IOSched): NOTE: QLUtmConnection: Calling UTM
with initiator ID 0x38 Request 0x2
06/16/24-19:26:55 (GMT) (IOSched): NOTE: CloseConnectionNotification:
Free connection object for InitiatorId 0x38 pPortal
06/16/24-19:26:55 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [38]
Not connected - prev 25
06/16/24-19:26:57 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0039 0023 0000 0000
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUtmConnection: Calling UTM
with initiator ID 0x39 Request 0x1
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [39]
Connected - prev 21
06/16/24-19:26:57 (GMT) (IOSched): WARN: LoginPduContinue:
ClosingSession (all conns) to allow new login. pSession = 1C25240
06/16/24-19:26:57 (GMT) (IOSched): NOTE: CloseSession:
Session:0x1c25248, Tsih:0x1d1dbf4 pSessionItn:0x40e872c.
06/16/24-19:26:57 (GMT) (IOSched): NOTE: InstantiateSession:
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Session:0x0x1c25248
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Initiator
Name:iqn.1993-08.org.debian:01:bc2c2e478b92
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Target
Name:iqn.1992-01.com.lsi:1535.600a0b8000496dab00000000666d0069
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Target Obj:0x0x2fabd1c
06/16/24-19:26:57 (GMT) (IOSched): NOTE: InstantiateSession:
SES_TYPE_NORMAL, SES_STATE_ACTIVE, SES_TRAN_IN_LOGIN.
06/16/24-19:26:57 (GMT) (IOSched): WARN: AddConnectionToSession: Add
new connection to this session,
Type:2 HostCID:0 TSIH:48 ConnCnt:1 MaxConns:1 MaxConnNeg:0
pSession:0x1c25248
06/16/24-19:26:57 (GMT) (IOSched): NOTE: LoginPduContinue:
SES_STATE_LOGGED_IN - normal
06/16/24-19:26:57 (GMT) (IOSched): NOTE:
Initiator = iqn.1993-08.org.debian:01:bc2c2e478b92
06/16/24-19:26:57 (GMT) (IOSched): NOTE:
Target = iqn.1992-01.com.lsi:1535.600a0b8000496dab00000009
06/16/24-19:26:57 (GMT) (IOSched): NOTE: CID:
0000, SSID: 3dafefe
06/16/24-19:26:57 (GMT) (IOSched): NOTE: LoginPduContinue: eitItn
allocated was 0x40e872c for initiator [39] Session:0x01c20
06/16/24-19:26:57 (GMT) (IOSched): WARN: DdbSetParms:Session:0x1c25248
Conn:0x3dafed8 sNegotiated.MaxRecvDataSegmentLength 0
06/16/24-19:26:57 (GMT) (setAliasAltTask): NOTE: snrAliasAltTask:
IconSendInfeasibleException Error
06/16/24-19:26:57 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0039 0025 0000 0000
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [39]
Logged In.
Timothy M Butterworth
2024-06-17 09:10:01 UTC
Permalink
Post by Greg
Hi there,
I'm trying to mount iscsi share exported from old IBM DS3300.
ping timeout of 5 secs expired, recv timeout 5, last rx 4405941922,
<http://voice.google.com/calls?a=nc,%2B14405941922> last
ping 4405943173, now 4405944448
DS3300 is in "Optimal" state.
Thanks in advance for any help
[444198.925420] scsi 10:0:0:31: Attached scsi generic sg7 type 0
[444209.025722] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405941922,
<http://voice.google.com/calls?a=nc,%2B14405941922> last ping 4405943173,
<http://voice.google.com/calls?a=nc,%2B14405943173> now 4405944448
<http://voice.google.com/calls?a=nc,%2B14405944448>
[444209.025765] connection12:0: detected conn error (1022)
[444211.083687] sd 10:0:0:0: Power-on or device reset occurred
[444221.313734] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405944962, last ping 4405946240, now 4405947520
[444221.313780] connection12:0: detected conn error (1022)
[444223.373262] sd 10:0:0:0: Power-on or device reset occurred
[444233.601772] connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405948034, last ping 4405949312, now 4405950592
[444233.601814] connection12:0: detected conn error (1022)
According to these errors a ping test is failing. Can you ping and
traceroute to the DS3300 from the client? It looks like you have a
connectivity problem. If you recently setup a firewall then you need to
open ICMP echo-request and echo-reply.
Post by Greg
and so on...
Date/Time: 6/16/24 9:27:04 PM
Sequence number: 621
Event type: 180D
Description: Session terminated unexpectedly
Event specific codes: 0/0/0
Event category: Internal
Component type: iSCSI Initiator
Component location: iqn.1993-08.org.debian:01:bc2c2e478b92
Logged by: Controller in slot A
4d 45 4c 48 03 00 00 00 6d 02 00 00 00 00 00 00
0d 18 49 02 88 3c 6f 66 00 00 00 00 00 00 00 00
00 00 00 00 04 00 00 00 19 00 00 00 19 00 00 00
26 00 00 00 69 71 6e 2e 31 39 39 33 2d 30 38 2e
6f 72 67 2e 64 65 62 69 61 6e 3a 30 31 3a 62 63
32 63 32 65 34 37 38 62 39 32 00 00 00 00 00 00
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
01 00 00 00 00 00 00 00 00 00 00 00
06/16/24-19:26:55 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0038 0021 f0000 0000
06/16/24-19:26:55 (GMT) (IOSched): NOTE: QLUtmConnection: Calling UTM
with initiator ID 0x38 Request 0x2
Free connection object for InitiatorId 0x38 pPortal
06/16/24-19:26:55 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [38]
Not connected - prev 25
06/16/24-19:26:57 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0039 0023 0000 0000
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUtmConnection: Calling UTM
with initiator ID 0x39 Request 0x1
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [39]
Connected - prev 21
ClosingSession (all conns) to allow new login. pSession = 1C25240
Session:0x1c25248, Tsih:0x1d1dbf4 pSessionItn:0x40e872c.
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Session:0x0x1c25248
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Initiator
Name:iqn.1993-08.org.debian:01:bc2c2e478b92
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Target
Name:iqn.1992-01.com.lsi:1535.600a0b8000496dab00000000666d0069
06/16/24-19:26:57 (GMT) (IOSched): NOTE: Target Obj:0x0x2fabd1c
SES_TYPE_NORMAL, SES_STATE_ACTIVE, SES_TRAN_IN_LOGIN.
06/16/24-19:26:57 (GMT) (IOSched): WARN: AddConnectionToSession: Add
new connection to this session,
Type:2 HostCID:0 TSIH:48 ConnCnt:1 MaxConns:1 MaxConnNeg:0
pSession:0x1c25248
SES_STATE_LOGGED_IN - normal
Initiator = iqn.1993-08.org.debian:01:bc2c2e478b92
Target = iqn.1992-01.com.lsi:1535.600a0b8000496dab00000009
0000, SSID: 3dafefe
06/16/24-19:26:57 (GMT) (IOSched): NOTE: LoginPduContinue: eitItn
allocated was 0x40e872c for initiator [39] Session:0x01c20
06/16/24-19:26:57 (GMT) (IOSched): WARN: DdbSetParms:Session:0x1c25248
Conn:0x3dafed8 sNegotiated.MaxRecvDataSegmentLength 0
IconSendInfeasibleException Error
06/16/24-19:26:57 (GMT) (IOSched): NOTE: DDB Changed on port 0
mbox[0-5] 8014 0001 0039 0025 0000 0000
06/16/24-19:26:57 (GMT) (IOSched): NOTE: QLUpdateInitiatorData: [39]
Logged In.
--
⢀⣎⠟⠻⢶⣊⠀
⣟⠁⢠⠒⠀⣿⡁ Debian - The universal operating system
⢿⡄⠘⠷⠚⠋⠀ https://www.debian.org/
⠈⠳⣄⠀⠀
Greg
2024-06-17 21:00:01 UTC
Permalink
Post by Greg
Hi there,
I'm trying to mount iscsi share exported from old IBM DS3300.
ping timeout of 5 secs expired, recv timeout 5, last rx
4405941922,<http://voice.google.com/calls?a=nc,%2B14405941922> last
ping 4405943173, now 4405944448
DS3300 is in "Optimal" state.
Thanks in advance for any help
[444198.925420] scsi 10:0:0:31: Attached scsi generic sg7 type 0
[444209.025722]  connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx
4405941922,<http://voice.google.com/calls?a=nc,%2B14405941922> last
ping 4405943173,<http://voice.google.com/calls?a=nc,%2B14405943173>
now 4405944448<http://voice.google.com/calls?a=nc,%2B14405944448>
[444209.025765]  connection12:0: detected conn error (1022)
[444211.083687] sd 10:0:0:0: Power-on or device reset occurred
[444221.313734]  connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405944962, last ping 4405946240, now 4405947520
[444221.313780]  connection12:0: detected conn error (1022)
[444223.373262] sd 10:0:0:0: Power-on or device reset occurred
[444233.601772]  connection12:0: ping timeout of 5 secs expired, recv
timeout 5, last rx 4405948034, last ping 4405949312, now 4405950592
[444233.601814]  connection12:0: detected conn error (1022)
According to these errors a ping test is failing. Can you ping and
traceroute to the DS3300 from the client? It looks like you have a
connectivity problem. If you recently setup a firewall then you need to
open ICMP echo-request and echo-reply.
Thanks for the tip. The problem is definitely related to firewall.

Regards
Greg

Loading...