WFS/FFS/DM 7.6.4 / WFS/FFS/DM 7.6.8 / WFS/FFS/DM 7.6.9 / AS400 V5R4M0 / HTML / iSM 5.5sp2
September 22, 2009, 04:22 AM
AdeH
are you usng the REPLY-TO on the listener? If not, youmight try setting it to PASSTHRU? Otherwise, check the log to see why and where the message is being sent out?
iWay 5.5 SMSP1 and 6.0.1 on Intel/Linux
October 01, 2009, 10:22 AM
Pascal Bellerose
It seems like it's the listener that is trying to use the FTPEmit Agent.
The logs show an error stating that the user name password used was not allowed. But we confirmed that we had all acces on the FTP server.
The only concern I have is that the listener will always try to move the file to the destination directory specified in the listener's settings. During the PFlow execution the file the listener has picked up is being deleted. I think the FTP listener tries to move the file when it no longer exists.
I'm ok with teh fact that we get an error because of that. But I don't want the deadletter.
I've checked the "Reply" setting as AdeH requested, but could not find any other possible value than "True" or "False"
I must specify that we are running iSM5.5 sp2.13562 and we are not in the blue screen. We are in the white screen with registry and deployments and all that stuff...
Here's how it looks in the log:
610 09:38:35.438 KX.ConsoTransferCorpo.HandleTransferResults Encoding from KX.ConsoTransferCorpo.HandleTransferResults context is: Cp1252
611 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults logging in with possible account needed
612 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults FTP sending USER CST\X000KXCRPPRD
613 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults FTP sending PASS ****
614 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults Don't need ACCT, returning
615 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults FTP sending CWD TransferStatus
616 09:38:35.453 KX.ConsoTransferCorpo.HandleTransferResults FTP sending QUIT
617 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults starting W.KX.ConsoTransferCorpo.HandleTransferResults.1
618 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults logging in with possible account needed
619 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending USER CST\X000KXCRPPRD
620 09:38:35.500 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Run FTP Worker
621 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending PASS ****
622 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults Don't need ACCT, returning
623 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending CWD TransferStatus
624 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending TYPE A
625 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults not using PASV, using PORT command to: khalix.cascades.com using port: 1474
626 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending PORT 10,131,7,146,5,194
627 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults FTP sending NLST
628 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults issuing server socket accept
629 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults returned server socket accept
630 09:38:35.500 KX.ConsoTransferCorpo.HandleTransferResults got client socket on PORT command
631 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults Added candidate 'TransferEnded.txt' from directory TransferStatus to list
632 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults KX.ConsoTransferCorpo.HandleTransferResults Good file: name:TransferEnded.txt local:false
633 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults processing 1 file candidates
634 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults FTP sending TYPE A
635 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults not using PASV, using PORT command to: khalix.cascades.com using port: 1478
636 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults FTP sending PORT 10,131,7,146,5,198
637 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults FTP sending RETR TransferEnded.txt
638 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults issuing server socket accept
639 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults returned server socket accept
640 09:38:35.624 KX.ConsoTransferCorpo.HandleTransferResults got client socket on PORT command
641 09:38:35.856 W.KX.ConsoTransferCorpo.HandleTransferResults.1 FTP Worker accepts work for TransferEnded.txt
642 09:38:35.856 KX.ConsoTransferCorpo.HandleTransferResults FTP sending QUIT
643 09:38:35.856 W.KX.ConsoTransferCorpo.HandleTransferResults.1 waitForDocument: notified, fileset: true
644 09:38:35.856 W.KX.ConsoTransferCorpo.HandleTransferResults.1 TID not found, so creating it as KX.ConsoTransferCorpo.HandleTransferResults-FTP-W.KX.ConsoTransferCorpo.HandleTransferResults.1_20091001133835856Z
645 09:38:35.856 W.KX.ConsoTransferCorpo.HandleTransferResults.1 starting parseAndValidate
646 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Flat document accepted
647 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for agent
648 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 checking for cached agent
649 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 attempting to load agent: com.ibi.agents.XDFailAgent
650 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 setupAgents: no other agents, adding agent XDFailAgent: {agentInstance=com.ibi.agents.XDFailAgent@1bef5e8, agentParms=null, agentAttribs={}, agentName=com.ibi.agents.XDFailAgent}
651 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for pflowloc
652 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 checking for cached pflow: KX.ConsoTransferCorpo.HandleTransferResults
653 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Attempt to load flow: C:/Program Files/Apache Software Foundation/Tomcat 5.5/webapps/iway.corporatif.KX/WEB-INF/config/KX/processData/67A816F7-3069-4EED-977B-973F1AB19F3E/compileFlow.xml
654 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 building fresh agents
655 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 attempting to load agent: com.ibi.agents.XDRunCmdAgent
656 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 joinTargteList: {}
657 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 setupPflows: adding pflow KX.ConsoTransferCorpo.HandleTransferResults from pflow
658 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 numagents: 1
659 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 starting pflow, doc count=0
660 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 pflow performing KX.ConsoTransferCorpo.HandleTransferResults from $system on edge success, type Root
661 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 xable - flow root
662 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 pflow performing Start from subflowStart on edge success, type Start
663 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 xable - flow start
664 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 setting flow variable Debug=true
665 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 setting flow variable timeout=0
666 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 setting flow variable debug=false
667 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Set external register ConsoTransfer.KX_ConsoTransfer_HdlTrf_Exe_Path [SREG(KX_ConsoTransfer_HdlTrf_Exe_Path)]=C:\Program Files\Cascades Canada inc\KX.ConsoTransferCorpo\KX.ConsoTransferCorpo.HandleTransferResults\KX.ConsoTransferCorpo.HandleTransferResults.exe
668 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 node Start retList[0]: success
669 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 pflow performing Handle Transfer Results from Start on edge $complete, type Agent
670 09:38:35.871 W.KX.ConsoTransferCorpo.HandleTransferResults.1 {com.ibi.agents.XDRunCmdAgent} command is: C:\Program Files\Cascades Canada inc\KX.ConsoTransferCorpo\KX.ConsoTransferCorpo.HandleTransferResults\KX.ConsoTransferCorpo.HandleTransferResults.exe
671 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 xable - after unlocked execute of Handle Transfer Resultsretval=success
672 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 node Handle Transfer Results retList[0]: success
673 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 pflow performing End from Handle Transfer Results on edge $complete, type Terminate
674 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Ending pflow, subthreads=0
675 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 back from pflow, doc count=1
676 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 building outbound sibling chain
677 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 number of siblings for head doc: 0
678 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 number of outbound siblings: 0
679 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for *
680 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for out_transforms
681 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for out_validation
682 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for *
683 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for out_reviewer
684 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for preemit
685 09:39:03.828 W.KX.ConsoTransferCorpo.HandleTransferResults.1 sendToAll [std] reply to XDReply: [protocol=ftp TransferEnded.txt/khalix.cascades.com]
686 09:39:03.843 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Router selected default for *
687 09:39:03.843 W.KX.ConsoTransferCorpo.HandleTransferResults.1 no preemitters, emitting contents of doc, usestream=false encoding=ISO-8859-1
688 09:39:03.858 W.KX.ConsoTransferCorpo.HandleTransferResults.1 logging in with possible account needed
689 09:39:03.858 W.KX.ConsoTransferCorpo.HandleTransferResults.1 FTP sending USER CST\X000KXCRPPRD
690 09:39:03.858 W.KX.ConsoTransferCorpo.HandleTransferResults.1 FTP sending PASS ****
691 09:39:03.874 W.KX.ConsoTransferCorpo.HandleTransferResults.1 FTPEmitter - Error processing FTP:
com.ibi.edaqm.XDFTPException: User CST\X000KXCRPPRD cannot log in.
at com.ibi.edaqm.XDFTPControlSocket.validateReply(XDFTPControlSocket.java:568)
at com.ibi.edaqm.XDFTPClient.sendCredentials(XDFTPClient.java:241)
at com.ibi.edaqm.XDFTPClient.login(XDFTPClient.java:232)
at com.ibi.edaqm.XDFTPEmit.send(XDFTPEmit.java:189)
at com.ibi.edaqm.XDFTPEmit.emit(XDFTPEmit.java:170)
at com.ibi.edaqm.XDWorker.sendToAll(XDWorker.java:2492)
at com.ibi.edaqm.XDWorker.sendToAll(XDWorker.java:2313)
at com.ibi.edaqm.XDWorker.invokeAgent(XDWorker.java:980)
at com.ibi.edaqm.XDFTPWorker.run(XDFTPWorker.java:84)
at java.lang.Thread.run(Unknown Source)
692 09:39:03.874 W.KX.ConsoTransferCorpo.HandleTransferResults.1 Cannot emit reply to FTPEmit, deadLetter=C:/Program Files/Apache Software Foundation/Tomcat 5.5/webapps/iway.corporatif.KX/WEB-INF/config/KX/deadletter\2009-10-01T13_39_03.874Z-.XDFTPEmit: XD[FAIL] cause: 0 subcause: 0 message: com.ibi.edaqm.XDFTPException: User CST\X000KXCRPPRD cannot log in.
XD[FAIL] cause: 0 subcause: 0 message: com.ibi.edaqm.XDFTPException: User CST\X000KXCRPPRD cannot log in.
at com.ibi.edaqm.XDFTPEmit.emit(XDFTPEmit.java:174)
at com.ibi.edaqm.XDWorker.sendToAll(XDWorker.java:2492)
at com.ibi.edaqm.XDWorker.sendToAll(XDWorker.java:2313)
at com.ibi.edaqm.XDWorker.invokeAgent(XDWorker.java:980)
at com.ibi.edaqm.XDFTPWorker.run(XDFTPWorker.java:84)
at java.lang.Thread.run(Unknown Source)