FTP Failure after particular time
Hi,
My iSeries (V5R4M0) system transfers the file to Unix server ovr SSL. It uses FTP Command ccc to set clear command channel. The problem is when we have big file and it takes more time, we get the error "No response from remote host; all connections closed." What I observed is any time data transfer exceeds 2 hrs we will have this message in FTPOUT log. Also, it seems file gets transferred correctly. I have tested in Active and Passive modes. We get the same error in both cases. We don't get this error message if data tranbsfer gets completed within 2 hrs.
I am attaching FTPOUT log and Debug 100 Log: (I have masked the IP & USer Ids below). Please reply if anyone gets any idea by looking into logs.
Output redirected to a file. Input read from specified override file. Connecting to remote host XXX.XX.XXX.XXX using port 21. 220- 220- 220 hostname FTP server (SecureTransport 4.9.2) ready. 234 SSLv23/TLSv1 Connection is secure. Enter login ID (LLLLLLL): 331 Password required for uuuuu. 230 Virtual user UUUUU logged in. UNIX Type: L8 200 PBSZ=0 200 PROT command successful Data protection level set to P. Enter an FTP subcommand. > ccc 200 command channel cleared. Enter an FTP subcommand. > DEBUG 100 DEBUG is on. DEBUG value is 100. Enter an FTP subcommand. > PUT EMOVE10LIB/IMTPHY05.IMTPHY05 DoNotUse1 >>> PASV 227 Entering Passive Mode (XXX,XX,XXX,XXX,40,81) >>> STOR DoNotUse1 150 Opening ASCII mode SSL data connection for DoNotUse1. Connection is secure. No response from remote host; all connections closed. Enter an FTP subcommand. > QUIT
Debug 100 Log:
Thu Mar 10 11:23:19 2011 Trace Point: QTMF2002FF Entry type: RETURN To: 1600 From: qtmfutil 1726 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:23:19 2011 Trace Point: QTMF1A02FE Entry type: CALL From: 1600 To: qtmfsyp3 749 qtmf_RecReply(BOOL) INT, PCHAR Thu Mar 10 11:23:19 2011 Trace Point: QTMF1A01FE Entry type: CALL From: 1A02 To: qtmfsyp3 329 GetAChar()ta(PCHAR, INT, PCHAR Thu Mar 10 11:23:19 2011 Trace Point: QTMF1905FE Entry type: CALL From: 1A01 To: qtmfsyp2 1904 qtmf_SysRead(qtmf_SocketInfo_t Thu Mar 10 11:33:19 2011 Trace Point: QTMF190504 Entry type: DATA *000000000000000000000000000252CDAC1F3EFE000000000000000000020015*..............êòÐ..Ú............*..............R...>.............* *8018CBFD00000000000000000000000500000000000000008000000000000000*Ø.ôÙ....................Ø.......*................................* *EF6C1F3245003E80000020000000000000000000000000000000000000000167*Õ%..á..Ø.......................Å*.l.2E.>... ....................g* *00000000000000008000000000000000EF6C1F3245005E900000200000000020*........Ø.......Õ%..á.;°........*.................l.2E.^... .... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF190508 Entry type: DATA *FFFFFFFA *ŸŸŸ³ *.... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1905FF Entry type: RETURN To: 1A01 From: qtmfsyp2 2185 qtmf_SysRead(qtmf_SocketInfo_t Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0100 Entry type: DATA *FFFFFFFA *ŸŸŸ³ *.... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A01FF Entry type: RETURN To: 1A02 From: qtmfsyp3 407 GetAChar() Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0201 Entry type: DATA Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A03FE Entry type: CALL From: 1A02 To: qtmfsyp3 2173 qtmf_CleanupConnections()PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0301 Entry type: DATA *00000000000252CDAC1F3EFE0000000000000000000200158018CBFD00000000*......êòÐ..Ú............Ø.ôÙ....*......R...>.....................* *000000000000000500000000000000008000000000000000EF6C1F3245003E80*................Ø.......Õ%..á..Ø*.........................l.2E.>.* *0000200000000000000000000000000000000000000001670000000000000000*.......................Å........*.. ....................g........* *8000000000000000EF6C1F3245005E9000002000000000200000001000000000*Ø.......Õ%..á.;°................*.........l.2E.^... .... ........* Thu Mar 10 11:33:19 2011 Trace Point: QTMF2002FE Entry type: CALL From: 1A03 To: qtmfutil 1610 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:33:19 2011 Trace Point: QTMF200203 Entry type: DATA *00000000000000000000000000000000 *................ *................ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF200200 Entry type: DATA *000000000000000000000000 *............ *............ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF2002FF Entry type: RETURN To: 1A03 From: qtmfutil 1726 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:33:19 2011 Trace Point: QTMF1002FE Entry type: CALL From: 1A03 To: qtmfclie 3449 qtmf_InitGlobalVars()NT, PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF1002FF Entry type: RETURN To: 1A03 From: qtmfclie 3643 qtmf_InitGlobalVars() Thu Mar 10 11:33:19 2011 Trace Point: QTMF1802FE Entry type: CALL From: 1A03 To: qtmfsyp1 1189 qtmf_DisplayMessage(BOOL, PSZ, Thu Mar 10 11:33:19 2011 Trace Point: QTMF180200 Entry type: DATA *00000000E3C3D7F3C3F6C200 *....TCP3C6B. *............ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF2000FE Entry type: CALL From: 1802 To: qtmfutil 724 qtmf_Trim(PSZ, const INT)PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF2000FF Entry type: RETURN To: 1802 From: qtmfutil 764 qtmf_Trim(PSZ, const INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF180205 Entry type: DATA *0035D596409985A2979695A28540869996944099859496A385408896A2A35E40*..No response from remote host; *.5..@........@....@......@....^@* *81939340839695958583A3899695A240839396A285844B00 *all connections closed.. *...@...........@......K. * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FE Entry type: CALL From: 1802 To: qtmfsyp1 443 GetNextWord(PCHAR, PCHAR, INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FF Entry type: RETURN To: 1802 From: qtmfsyp1 534 GetNextWord(PCHAR, PCHAR, INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FE Entry type: CALL From: 1802 To: qtmfsyp1 443 GetNextWord(PCHAR, PCHAR, INT) 5722TC1 V5R4M0 060210 FTP Debug Trace S10A9715 Date-03/10/11 Time-11:33:19 Page-594
Thanks
Sim
Software/Hardware used:
My iSeries (V5R4M0) system transfers the file to Unix server ovr SSL. It uses FTP Command ccc to set clear command channel. The problem is when we have big file and it takes more time, we get the error "No response from remote host; all connections closed." What I observed is any time data transfer exceeds 2 hrs we will have this message in FTPOUT log. Also, it seems file gets transferred correctly. I have tested in Active and Passive modes. We get the same error in both cases. We don't get this error message if data tranbsfer gets completed within 2 hrs.
I am attaching FTPOUT log and Debug 100 Log: (I have masked the IP & USer Ids below). Please reply if anyone gets any idea by looking into logs.
Output redirected to a file. Input read from specified override file. Connecting to remote host XXX.XX.XXX.XXX using port 21. 220- 220- 220 hostname FTP server (SecureTransport 4.9.2) ready. 234 SSLv23/TLSv1 Connection is secure. Enter login ID (LLLLLLL): 331 Password required for uuuuu. 230 Virtual user UUUUU logged in. UNIX Type: L8 200 PBSZ=0 200 PROT command successful Data protection level set to P. Enter an FTP subcommand. > ccc 200 command channel cleared. Enter an FTP subcommand. > DEBUG 100 DEBUG is on. DEBUG value is 100. Enter an FTP subcommand. > PUT EMOVE10LIB/IMTPHY05.IMTPHY05 DoNotUse1 >>> PASV 227 Entering Passive Mode (XXX,XX,XXX,XXX,40,81) >>> STOR DoNotUse1 150 Opening ASCII mode SSL data connection for DoNotUse1. Connection is secure. No response from remote host; all connections closed. Enter an FTP subcommand. > QUIT
Debug 100 Log:
Thu Mar 10 11:23:19 2011 Trace Point: QTMF2002FF Entry type: RETURN To: 1600 From: qtmfutil 1726 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:23:19 2011 Trace Point: QTMF1A02FE Entry type: CALL From: 1600 To: qtmfsyp3 749 qtmf_RecReply(BOOL) INT, PCHAR Thu Mar 10 11:23:19 2011 Trace Point: QTMF1A01FE Entry type: CALL From: 1A02 To: qtmfsyp3 329 GetAChar()ta(PCHAR, INT, PCHAR Thu Mar 10 11:23:19 2011 Trace Point: QTMF1905FE Entry type: CALL From: 1A01 To: qtmfsyp2 1904 qtmf_SysRead(qtmf_SocketInfo_t Thu Mar 10 11:33:19 2011 Trace Point: QTMF190504 Entry type: DATA *000000000000000000000000000252CDAC1F3EFE000000000000000000020015*..............êòÐ..Ú............*..............R...>.............* *8018CBFD00000000000000000000000500000000000000008000000000000000*Ø.ôÙ....................Ø.......*................................* *EF6C1F3245003E80000020000000000000000000000000000000000000000167*Õ%..á..Ø.......................Å*.l.2E.>... ....................g* *00000000000000008000000000000000EF6C1F3245005E900000200000000020*........Ø.......Õ%..á.;°........*.................l.2E.^... .... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF190508 Entry type: DATA *FFFFFFFA *ŸŸŸ³ *.... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1905FF Entry type: RETURN To: 1A01 From: qtmfsyp2 2185 qtmf_SysRead(qtmf_SocketInfo_t Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0100 Entry type: DATA *FFFFFFFA *ŸŸŸ³ *.... * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A01FF Entry type: RETURN To: 1A02 From: qtmfsyp3 407 GetAChar() Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0201 Entry type: DATA Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A03FE Entry type: CALL From: 1A02 To: qtmfsyp3 2173 qtmf_CleanupConnections()PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF1A0301 Entry type: DATA *00000000000252CDAC1F3EFE0000000000000000000200158018CBFD00000000*......êòÐ..Ú............Ø.ôÙ....*......R...>.....................* *000000000000000500000000000000008000000000000000EF6C1F3245003E80*................Ø.......Õ%..á..Ø*.........................l.2E.>.* *0000200000000000000000000000000000000000000001670000000000000000*.......................Å........*.. ....................g........* *8000000000000000EF6C1F3245005E9000002000000000200000001000000000*Ø.......Õ%..á.;°................*.........l.2E.^... .... ........* Thu Mar 10 11:33:19 2011 Trace Point: QTMF2002FE Entry type: CALL From: 1A03 To: qtmfutil 1610 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:33:19 2011 Trace Point: QTMF200203 Entry type: DATA *00000000000000000000000000000000 *................ *................ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF200200 Entry type: DATA *000000000000000000000000 *............ *............ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF2002FF Entry type: RETURN To: 1A03 From: qtmfutil 1726 qtmf_CloseConnection(qtmf_Sock Thu Mar 10 11:33:19 2011 Trace Point: QTMF1002FE Entry type: CALL From: 1A03 To: qtmfclie 3449 qtmf_InitGlobalVars()NT, PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF1002FF Entry type: RETURN To: 1A03 From: qtmfclie 3643 qtmf_InitGlobalVars() Thu Mar 10 11:33:19 2011 Trace Point: QTMF1802FE Entry type: CALL From: 1A03 To: qtmfsyp1 1189 qtmf_DisplayMessage(BOOL, PSZ, Thu Mar 10 11:33:19 2011 Trace Point: QTMF180200 Entry type: DATA *00000000E3C3D7F3C3F6C200 *....TCP3C6B. *............ * Thu Mar 10 11:33:19 2011 Trace Point: QTMF2000FE Entry type: CALL From: 1802 To: qtmfutil 724 qtmf_Trim(PSZ, const INT)PCHAR Thu Mar 10 11:33:19 2011 Trace Point: QTMF2000FF Entry type: RETURN To: 1802 From: qtmfutil 764 qtmf_Trim(PSZ, const INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF180205 Entry type: DATA *0035D596409985A2979695A28540869996944099859496A385408896A2A35E40*..No response from remote host; *.5..@........@....@......@....^@* *81939340839695958583A3899695A240839396A285844B00 *all connections closed.. *...@...........@......K. * Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FE Entry type: CALL From: 1802 To: qtmfsyp1 443 GetNextWord(PCHAR, PCHAR, INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FF Entry type: RETURN To: 1802 From: qtmfsyp1 534 GetNextWord(PCHAR, PCHAR, INT) Thu Mar 10 11:33:19 2011 Trace Point: QTMF1803FE Entry type: CALL From: 1802 To: qtmfsyp1 443 GetNextWord(PCHAR, PCHAR, INT) 5722TC1 V5R4M0 060210 FTP Debug Trace S10A9715 Date-03/10/11 Time-11:33:19 Page-594
Thanks
Sim
Software/Hardware used:
ASKED:
March 10, 2011 5:30 PM
UPDATED:
April 13, 2011 4:47 AM
Answer Wiki:
Most likely it's getting hung up. Does the FTP server or client have any throttling? It could also be a setting on the system itself (namely where you're copying the data to). If possible, it might be easier to see if you can change the idle timeout setting, or break the file into parts (if possible) and see if that rectifies the issue at all.
To see all answers submitted to the Answer Wiki: View Answer History.
Hi Ehanse,
If I compress file and send it, it goes out successfully wihtout any error message. I am doing this currently when the file size is huge and it takes longer than 2 hrs for FTP. But, irrespective of the file type, it fails when it is huge and it takes more than 2 hrs. I will check the timeout setting on both systems. But, Control Connection has anything to do with time out when data connection is active and transferring data ?
Thanks
How big is this file? and what kind of network is it running across?
If your two systems are sitting next to each other in a rack then perhaps it’s time to upgrade the switch their using.
You can also look at DoubleTake from Vision Solutions. You can utilize AS400 remote journaling and replicate the file real-time from the AS400 to the Unix system. You can also setup two way replication if necessary.