I have installed mec_as2 on Centos 5.2 Linux with VNC.
It is running the whole time, i start and stop it with the script from the thead "Pseudo multi-local mec-as2 on linux".
This morning I tried to send a file, first time with the Menu "send file" of the gui, second time I copy the file into the outbox folder.
But both from these files disappear from disk, in the log file, there is no error logged, but both files are logged as encrypted, but they were never sent!
After restarting mec_as2 everything went well.
It was the second time, i had this situation. But I was never able the reproduce it, it happens only after a while...
Did someone has solved this problem once?
Is there a way that mec_as2 brings more information to log?
Regards
Charley
Details and Log:
Message 1225881536625-10 is disappeard.
Message 1225881657251-11 is disappeard.
After Restart,
Message 1225881776892-0 was sent.
I sent allways the same file.
Log-File:
[05.11.2008 11:38:27] Schlüssel und Zertifikate wurden von "/home/mec_as2/mec_as2/certificates.p12" geladen.
[05.11.2008 11:38:45] Schlüssel und Zertifikate wurden von "/home/mec_as2/mec_as2/certificates.p12" geladen.
[05.11.2008 11:38:58] mec_as2-1225881536625-10@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus SHA-1 digital signiert, benutzt wurde der Schlüssel Alias "maxschildas2".
[05.11.2008 11:39:04] mec_as2-1225881536625-10@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus 3DES verschlüsselt, benutzt wurde der Schlüssel Alias "valora-as2".
[05.11.2008 11:39:04] mec_as2-1225881536625-10@MAXSCHILDAGCH_ValoraAS2: Ausgehende AS2 Nachricht aus "test.txt" für den Empfänger "Valora" erstellt in 7s, Rohdatengrösse: 3,00 KB.
[05.11.2008 11:40:57] Verarbeite die Datei "test.txt" für die Beziehung "MaxSchild AG/Valora".
[05.11.2008 11:40:58] mec_as2-1225881657251-11@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus SHA-1 digital signiert, benutzt wurde der Schlüssel Alias "maxschildas2".
[05.11.2008 11:40:59] mec_as2-1225881657251-11@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus 3DES verschlüsselt, benutzt wurde der Schlüssel Alias "valora-as2".
[05.11.2008 11:40:59] mec_as2-1225881657251-11@MAXSCHILDAGCH_ValoraAS2: Ausgehende AS2 Nachricht aus "test.txt" für den Empfänger "Valora" erstellt in 2s, Rohdatengrösse: 3,00 KB.
[05.11.2008 11:40:59] mec_as2-1225881657251-11@MAXSCHILDAGCH_ValoraAS2: Die Datei "test.txt" wurde gelöscht und der Verarbeitungswarteschlange des Servers übergeben.
[05.11.2008 11:42:08] Willkommen, admin
[05.11.2008 11:42:08] m-e-c as2 1.1 build 25
[05.11.2008 11:42:23] Schlüssel und Zertifikate wurden von "/home/mec_as2/mec_as2/certificates.p12" geladen.
[05.11.2008 11:42:56] Verarbeite die Datei "test.txt" für die Beziehung "MaxSchild AG/Valora".
[05.11.2008 11:42:58] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus SHA-1 digital signiert, benutzt wurde der Schlüssel Alias "maxschildas2".
[05.11.2008 11:42:59] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Die ausgehende Nachricht wurde mit dem Algorithmus 3DES verschlüsselt, benutzt wurde der Schlüssel Alias "valora-as2".
[05.11.2008 11:42:59] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Ausgehende AS2 Nachricht aus "test.txt" für den Empfänger "Valora" erstellt in 2s, Rohdatengrösse: 3,00 KB.
[05.11.2008 11:42:59] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Die Datei "test.txt" wurde gelöscht und der Verarbeitungswarteschlange des Servers übergeben.
[05.11.2008 11:42:59] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Sende Nachricht an http://as2.valora.com:8080/as2/HttpReceiver, erwarte synchrone MDN zur Empfangsbestätigung.
[05.11.2008 11:43:00] mec_as2-1225881776892-0@MAXSCHILDAGCH_ValoraAS2: Nachricht erfolgreich versandt (HTTP 200); 3,00 KB Bytes übertragen in 1s [2.0 KB/s].
Charley,
no, we didnt hear about such an issue so far.
Anyway there is no need to use the script "Pseudo multi-local mec-as2 on linux", m-e-c as2 build 25 supports multiple local stations.
Regards
Heller
Hello Heller
I use mec_as2 on a linux server without terminal.
With that script and VNC i can run it like a service and it will start automatic after system reboot.
Is there an other possibility to run it on a server like a service?
Regards
Charley
daddykom,
I thought the script starts multiple instances of the program to have multiple local stations, sorry.
Regards
Heller
Hi Heller
Thats true, it can start multiple instances of the program on one local station under vnc.
But it can also start only one station on vnc, and so it can be used for a server without screen...
Regards
Charley
Hello,
nice to see that my script is used.
I confirm that the "Pseudo multi-local mec-as2 on linux"
can be used :
1) to attach a pseudo terminal to the application (multi-local or not)
2) to separate really local stations (if confidency is needed between locals)
I recommand to stop/start mec-AS2 every day as I think there is some memory leak . (sorry Heller)
I confirm there is some problems when mec-as2 is running for a long time (sometime not so long :>)...).
Maybe it comes from Java ? I though a garbage collector was included ?
For me it looks like the JMS Server is the Problem.
Friday evening I restartet the program and test the communication. Everything works fine.
Today I tried to send a message, but the message is prepared, but not sent.
I need help here, because I am not able to solve the problem myself. I am a php and python programmer, i no nothing from java.
Friday I activated all debugging options from JMS. I append these log records for the part of the sending of the message.
There is also a error message in that log!!!
Can someone expirienced look at this log and find out the problem? I saved the actual situation of the files of mec_as2 and can give you all the log file if you need.
I controlled the ports 16023 and 16434 of JMS. They have not changed since friday.
Would be nice if we can solve that problem...
Regards
Charley
Her the log:
(I can send it also to an email adresse if someone wishes that.)
JndiServer[#0.0.8].react(#0.0.0,((fr.dyade.aaa.jndi2.server.TcpRequestNot@35c350,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@1da9952,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@87f637,name=as2_messagequeue))))
FINEST 2008-11-17 10:47:00,329, JndiServer.doReact((TcpRequestNot)((fr.dyade.aaa.jndi2.server.TcpRequestNot@35c350,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@1da9952,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@87f637,name=as2_messagequeue))))
FINEST 2008-11-17 10:47:00,329, RequestManager.invoke(((fr.dyade.aaa.jndi2.server.TcpRequestContext@1da9952,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@87f637,name=as2_messagequeue)))
FINEST 2008-11-17 10:47:00,329, TcpRequestContext.getRequest()
FINEST 2008-11-17 10:47:00,329, RequestManager.invokeReadRequest(((fr.dyade.aaa.jndi2.server.TcpRequestContext@1da9952,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@87f637,name=as2_messagequeue)))
FINEST 2008-11-17 10:47:00,329, TcpRequestContext.getRequest()
FINEST 2008-11-17 10:47:00,332, ObjectFactory.getObjectInstance(Reference Class Name: org.objectweb.joram.client.jms.Queue
Type: dest.agentId
Content: #0.0.1121
Type: dest.adminName
Content: null
,null,null,null)
FINEST 2008-11-17 10:47:00,332, NamingContextImpl.lookup(queueFactory)
FINEST 2008-11-17 10:47:00,332, SimpleNamingConnection.invoke((fr.dyade.aaa.jndi2.msg.LookupRequest@ffc7f0,name=queueFactory))
FINEST 2008-11-17 10:47:00,332, SimpleNamingConnection.open()
FINEST 2008-11-17 10:47:00,332, Agent#0.0.8 [] not saved
FINEST 2008-11-17 10:47:00,332, JndiServer.Monitor#1, connection from /127.0.0.1:39666
FINEST 2008-11-17 10:47:00,332, Channel#0.directSendTo(#0.0.0, #0.0.8, ((fr.dyade.aaa.jndi2.server.TcpRequestNot@17de25d,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory))))
FINEST 2008-11-17 10:47:00,333, Engine#0: (fr.dyade.aaa.jndi2.server.Container@1500efd,name=,id=#0.0.8,fixed=true).react(#0.0.0, ((fr.dyade.aaa.jndi2.server.TcpRequestNot@839d9a,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory))))
FINEST 2008-11-17 10:47:00,333,
JndiServer[#0.0.8].react(#0.0.0,((fr.dyade.aaa.jndi2.server.TcpRequestNot@839d9a,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory))))
FINEST 2008-11-17 10:47:00,333, JndiServer.doReact((TcpRequestNot)((fr.dyade.aaa.jndi2.server.TcpRequestNot@839d9a,messageId=null,persistent=true,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),ctx=((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory))))
FINEST 2008-11-17 10:47:00,333, RequestManager.invoke(((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory)))
FINEST 2008-11-17 10:47:00,333, TcpRequestContext.getRequest()
FINEST 2008-11-17 10:47:00,333, RequestManager.invokeReadRequest(((fr.dyade.aaa.jndi2.server.TcpRequestContext@19852b0,resolvedName=null),request=(fr.dyade.aaa.jndi2.msg.LookupRequest@15ce034,name=queueFactory)))
FINEST 2008-11-17 10:47:00,333, TcpRequestContext.getRequest()
FINEST 2008-11-17 10:47:00,337, ObjectFactory.getObjectInstance(Reference Class Name: org.objectweb.joram.client.jms.tcp.QueueTcpConnectionFactory
Type: cf.host
Content: 195.144.44.130
Type: cf.port
Content: 16023
Type: cf.url
Content: null
Type: cf.TcpNoDelay
Content: true
Type: cf.SoLinger
Content: -1
Type: cf.SoTimeout
Content: 0
Type: cf.cnxT
Content: 0
Type: cf.txT
Content: 0
Type: cf.cnxPT
Content: 0
Type: cf.socketFactory
Content: fr.dyade.aaa.util.SocketFactory14
Type: cf.asyncSend
Content: false
Type: cf.queueMessageReadMax
Content: 1
Type: cf.topicAckBufferMax
Content: 0
Type: cf.multiThreadSync
Content: false
Type: cf.multiThreadSyncDelay
Content: 1
Type: cf.multiThreadSyncThreshold
Content: 10
Type: cf.topicPassivationThreshold
Content: 2147483647
Type: cf.topicActivationThreshold
Content: 0
Type: cf.outLocalPort
Content: 0
Type: cf.outLocalAddress
Content: null
Type: cf.reliableClass
Content: org.objectweb.joram.client.jms.tcp.ReliableTcpClient
,null,null,null)
FINEST 2008-11-17 10:47:00,337, TcpConnection.((org.objectweb.joram.client.jms.FactoryParameters@1a3e641,host=195.144.44.130,port=16023,urlnull,connectingTimer=0,txPendingTimer=0,cnxPendingTimer=0,asyncSend=false,topicAckBufferMax=0,multiThreadSync=false,multiThreadSyncDelay=1,multiThreadSyncThreshold=10,topicPassivationThreshold=2147483647,topicActivationThreshold=0,outLocalAddress=null,outLocalPort=0),as2user,messagequeuepasswd,org.objectweb.joram.client.jms.tcp.ReliableTcpClient)
FINEST 2008-11-17 10:47:00,337, Agent#0.0.8 [] not saved
FINEST 2008-11-17 10:47:00,337, ReliableTcpClient[as2user,-1].doConnect(195.144.44.130,16023)
FINEST 2008-11-17 10:47:00,337, ReliableTcpClient[as2user,-1].createSocket(195.144.44.130,16023) on interface null:0
FINEST 2008-11-17 10:47:00,344, -> accept connection
FINEST 2008-11-17 10:47:00,345, -> read userName = as2user
FINEST 2008-11-17 10:47:00,345, -> read userPassword = messagequeuepasswd
FINEST 2008-11-17 10:47:00,345, -> read key = -1
FINEST 2008-11-17 10:47:00,345, -> read heartBeat = 0
FINEST 2008-11-17 10:47:00,345, Channel#0.directSendTo(#0.0.0, #0.0.10, (org.objectweb.joram.mom.notifications.GetProxyIdNot@1111c6e,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,345, Engine#0: (org.objectweb.joram.mom.dest.AdminTopic@14b2f1a,name=JoramAdminTopic,id=#0.0.10,fixed=true).react(#0.0.0, (org.objectweb.joram.mom.notifications.GetProxyIdNot@619b21,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,345, (org.objectweb.joram.mom.dest.AdminTopic@14b2f1a,name=JoramAdminTopic,id=#0.0.10,fixed=true): setSave().
FINEST 2008-11-17 10:47:00,346, Agent#0.0.10 [JoramAdminTopic] saved
FINEST 2008-11-17 10:47:00,346, Channel#0.directSendTo(#0.0.0, #0.0.1027, ((org.objectweb.joram.mom.proxies.OpenConnectionNot@fb9ad,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),reliable=true,heartBeat=0))
FINEST 2008-11-17 10:47:00,355, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.0, ((org.objectweb.joram.mom.proxies.OpenConnectionNot@6734e4,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),reliable=true,heartBeat=0))
FINEST 2008-11-17 10:47:00,355, UserAgent.react(#0.0.0,((org.objectweb.joram.mom.proxies.OpenConnectionNot@6734e4,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),reliable=true,heartBeat=0))
FINEST 2008-11-17 10:47:00,355, setNoSave()
FINEST 2008-11-17 10:47:00,355, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,355, Engine#0, push(#0.0.1027, #0.0.1027, (org.objectweb.joram.mom.proxies.ReturnConnectionNot@1c19b4f,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,355, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,355, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.1027, (org.objectweb.joram.mom.proxies.ReturnConnectionNot@1bb6ecc,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,355, UserAgent.react(#0.0.1027,(org.objectweb.joram.mom.proxies.ReturnConnectionNot@1bb6ecc,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,355, setNoSave()
FINEST 2008-11-17 10:47:00,355, Agent#0.0.1027 [as2user] not saved
FINEST 2008-11-17 10:47:00,355, TcpConnection.start()
FINEST 2008-11-17 10:47:00,355, AckedQueue.reset()
FINEST 2008-11-17 10:47:00,355, TcpProxyService.registerConnection(org.objectweb.joram.mom.proxies.tcp.TcpConnection@671c2c)
FINEST 2008-11-17 10:47:00,356, TcpWriter.run()
FINEST 2008-11-17 10:47:00,356, AckedQueue.get()
FINEST 2008-11-17 10:47:00,356, TcpConnectionListener.acceptConnection()
FINEST 2008-11-17 10:47:00,356, TcpReader.run()
FINEST 2008-11-17 10:47:00,356, RequestMultiplexer.setStatus(OPEN)
FINEST 2008-11-17 10:47:00,356, Requestor.request((org.objectweb.joram.shared.client.CnxConnectRequest@1e08da0,requestId=-1,target=null),0)
FINEST 2008-11-17 10:47:00,356, Requestor.setStatus(RUN)
FINEST 2008-11-17 10:47:00,356, -> request #0 wait
FINEST 2008-11-17 10:47:00,362, TcpReader reads msg: (org.objectweb.joram.mom.proxies.ProxyMessage@6c326d,id=0,ackId=-1,obj=(org.objectweb.joram.shared.client.CnxConnectRequest@162c38f,requestId=0,target=null))
FINEST 2008-11-17 10:47:00,362, Channel#0.directSendTo(#0.0.0, #0.0.1027, ((org.objectweb.joram.mom.proxies.RequestNot@1151235,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6c326d,id=0,ackId=-1,obj=(org.objectweb.joram.shared.client.CnxConnectRequest@162c38f,requestId=0,target=null))))
FINEST 2008-11-17 10:47:00,362, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.0, ((org.objectweb.joram.mom.proxies.RequestNot@5e7d1c,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6c326d,id=0,ackId=-1,obj=(org.objectweb.joram.shared.client.CnxConnectRequest@162c38f,requestId=0,target=null))))
FINEST 2008-11-17 10:47:00,362, UserAgent.react(#0.0.0,((org.objectweb.joram.mom.proxies.RequestNot@5e7d1c,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6c326d,id=0,ackId=-1,obj=(org.objectweb.joram.shared.client.CnxConnectRequest@162c38f,requestId=0,target=null))))
FINEST 2008-11-17 10:47:00,362, setNoSave()
FINEST 2008-11-17 10:47:00,362, AckedQueue.ack(-1)
FINEST 2008-11-17 10:47:00,362, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,362, UserAgent.sendToClient(1329,(org.objectweb.joram.shared.client.CnxConnectReply@167cae4correlationId=0))
FINEST 2008-11-17 10:47:00,362, AckedQueue.push((org.objectweb.joram.mom.proxies.ProxyMessage@13974cc,id=0,ackId=0,obj=(org.objectweb.joram.shared.client.CnxConnectReply@167cae4correlationId=0)))
FINEST 2008-11-17 10:47:00,362, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,375, AckedQueue.get()
FINEST 2008-11-17 10:47:00,376, RequestMultiplexer.route((org.objectweb.joram.shared.client.CnxConnectReply@9faa75correlationId=0))
FINEST 2008-11-17 10:47:00,376, -> rl = org.objectweb.joram.client.jms.connection.Requestor@6ff3f4)
FINEST 2008-11-17 10:47:00,376, Requestor.replyReceived((org.objectweb.joram.shared.client.CnxConnectReply@9faa75correlationId=0))
FINEST 2008-11-17 10:47:00,376, Requestor.setStatus(DONE)
FINEST 2008-11-17 10:47:00,376, -> request #0 awake
FINEST 2008-11-17 10:47:00,376, -> request #0 done
FINEST 2008-11-17 10:47:00,376, Requestor.setStatus(INIT)
FINEST 2008-11-17 10:47:00,376, QueueSend:c1329s0: created.
FINEST 2008-11-17 10:47:00,376, Requestor.request((org.objectweb.joram.shared.client.CommitRequest@6d3f05,requestId=-1,target=null),producerMessages=[(org.objectweb.joram.shared.client.ProducerMessages@4492b8,requestId=-1,target=#0.0.1121),messages=[(org.objectweb.joram.shared.messages.Message@1fc80a2,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],asyncSend=false)],ackRequests=null,asyncSend=false),0)
FINEST 2008-11-17 10:47:00,376, writeVectorTo: 1
FINEST 2008-11-17 10:47:00,376, writeVectorTo: msg#0
FINEST 2008-11-17 10:47:00,377, Requestor.setStatus(RUN)
FINEST 2008-11-17 10:47:00,377, -> request #1 wait
FINEST 2008-11-17 10:47:00,378, readVectorFrom: 1
FINEST 2008-11-17 10:47:00,378, readVectorFrom: msg#0
FINEST 2008-11-17 10:47:00,383, TcpReader reads msg: (org.objectweb.joram.mom.proxies.ProxyMessage@6114e7,id=1,ackId=0,obj=(org.objectweb.joram.shared.client.CommitRequest@1a37705,requestId=1,target=null),producerMessages=[(org.objectweb.joram.shared.client.ProducerMessages@db1115,requestId=-1,target=#0.0.1121),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],asyncSend=false)],ackRequests=null,asyncSend=false))
FINEST 2008-11-17 10:47:00,383, Channel#0.directSendTo(#0.0.0, #0.0.1027, ((org.objectweb.joram.mom.proxies.RequestNot@c4410c,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6114e7,id=1,ackId=0,obj=(org.objectweb.joram.shared.client.CommitRequest@1a37705,requestId=1,target=null),producerMessages=[(org.objectweb.joram.shared.client.ProducerMessages@db1115,requestId=-1,target=#0.0.1121),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],asyncSend=false)],ackRequests=null,asyncSend=false))))
FINEST 2008-11-17 10:47:00,383, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.0, ((org.objectweb.joram.mom.proxies.RequestNot@8aa547,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6114e7,id=1,ackId=0,obj=(org.objectweb.joram.shared.client.CommitRequest@1a37705,requestId=1,target=null),producerMessages=[(org.objectweb.joram.shared.client.ProducerMessages@db1115,requestId=-1,target=#0.0.1121),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],asyncSend=false)],ackRequests=null,asyncSend=false))))
FINEST 2008-11-17 10:47:00,383, UserAgent.react(#0.0.0,((org.objectweb.joram.mom.proxies.RequestNot@8aa547,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@6114e7,id=1,ackId=0,obj=(org.objectweb.joram.shared.client.CommitRequest@1a37705,requestId=1,target=null),producerMessages=[(org.objectweb.joram.shared.client.ProducerMessages@db1115,requestId=-1,target=#0.0.1121),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],asyncSend=false)],ackRequests=null,asyncSend=false))))
FINEST 2008-11-17 10:47:00,383, setNoSave()
FINEST 2008-11-17 10:47:00,384, AckedQueue.ack(0)
FINEST 2008-11-17 10:47:00,384, AckedQueue acked 0
FINEST 2008-11-17 10:47:00,384, UserAgent.sendNot(#0.0.1121,((((org.objectweb.joram.mom.notifications.ClientMessages@6902a7,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1329),requestId=1),message=(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null),messages=null,asyncSend=false))
FINEST 2008-11-17 10:47:00,384, Engine#0, push(#0.0.1027, #0.0.1121, ((((org.objectweb.joram.mom.notifications.ClientMessages@6902a7,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1329),requestId=1),message=(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null),messages=null,asyncSend=false))
FINEST 2008-11-17 10:47:00,384, ClientContext[#0.0.1027:1329].addMultiReplyContext(1,1)
FINEST 2008-11-17 10:47:00,384, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,384, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,385, Engine#0: (org.objectweb.joram.mom.dest.Queue@128594c,name=,id=#0.0.1121,fixed=false).react(#0.0.1027, ((((org.objectweb.joram.mom.notifications.ClientMessages@2d284e,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1329),requestId=1),message=(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null),messages=null,asyncSend=false))
FINEST 2008-11-17 10:47:00,385, (org.objectweb.joram.mom.dest.Queue@128594c,name=,id=#0.0.1121,fixed=false): setNoSave().
FINEST 2008-11-17 10:47:00,385, (org.objectweb.joram.mom.dest.Queue@128594c,name=,id=#0.0.1121,fixed=false): setSave().
FINEST 2008-11-17 10:47:00,385, Engine#0, push(#0.0.1121, #0.0.1027, ((((org.objectweb.joram.mom.notifications.QueueMsgReply@18d0470,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1321), correlationId=2),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)]))
FINEST 2008-11-17 10:47:00,385, Engine#0, push(#0.0.1121, #0.0.1027, ((org.objectweb.joram.mom.proxies.SendReplyNot@11e6645,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),key=1329,requestId=1))
FINEST 2008-11-17 10:47:00,385, Agent#0.0.1121 [] saved
FINEST 2008-11-17 10:47:00,386, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.1121, ((((org.objectweb.joram.mom.notifications.QueueMsgReply@1eb54fb,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1321), correlationId=2),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)]))
FINEST 2008-11-17 10:47:00,386, UserAgent.react(#0.0.1121,((((org.objectweb.joram.mom.notifications.QueueMsgReply@1eb54fb,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null), clientContext=1321), correlationId=2),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)]))
FINEST 2008-11-17 10:47:00,386, setNoSave()
FINEST 2008-11-17 10:47:00,386, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,386, UserAgent.sendToClient(1321,(org.objectweb.joram.shared.client.ConsumerMessages@1184351correlationId=2),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],comingFrom=#0.0.1121,queueMode=true))
FINEST 2008-11-17 10:47:00,386, AckedQueue.push((org.objectweb.joram.mom.proxies.ProxyMessage@1eb7c6d,id=1,ackId=2,obj=(org.objectweb.joram.shared.client.ConsumerMessages@1184351correlationId=2),messages=[(org.objectweb.joram.shared.messages.Message@3e8da0,id=ID:0.0.1027c1329m0,type=2,persistent=true,priority=4,expiration=0,timestamp=1226915220376,toId=#0.0.1121,replyToId=null,correlationId=null)],comingFrom=#0.0.1121,queueMode=true)))
FINEST 2008-11-17 10:47:00,386, writeVectorTo: 1
FINEST 2008-11-17 10:47:00,386, writeVectorTo: msg#0
FINEST 2008-11-17 10:47:00,386, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,386, AckedQueue.get()
FINEST 2008-11-17 10:47:00,387, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.1121, ((org.objectweb.joram.mom.proxies.SendReplyNot@135efa8,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),key=1329,requestId=1))
FINEST 2008-11-17 10:47:00,387, UserAgent.react(#0.0.1121,((org.objectweb.joram.mom.proxies.SendReplyNot@135efa8,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),key=1329,requestId=1))
FINEST 2008-11-17 10:47:00,387, setNoSave()
FINEST 2008-11-17 10:47:00,387, UserAgent.doReact(((org.objectweb.joram.mom.proxies.SendReplyNot@135efa8,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),key=1329,requestId=1))
FINEST 2008-11-17 10:47:00,387, ClientContext[#0.0.1027:1329].setReply(1)
FINEST 2008-11-17 10:47:00,387, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,387, UserAgent.sendToClient(1329,(org.objectweb.joram.shared.client.ServerReply@91f03correlationId=1))
FINEST 2008-11-17 10:47:00,387, AckedQueue.push((org.objectweb.joram.mom.proxies.ProxyMessage@d33665,id=1,ackId=1,obj=(org.objectweb.joram.shared.client.ServerReply@91f03correlationId=1)))
FINEST 2008-11-17 10:47:00,388, AckedQueue.get()
FINEST 2008-11-17 10:47:00,388, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,395, RequestMultiplexer.route((org.objectweb.joram.shared.client.ServerReply@982d9ecorrelationId=1))
FINEST 2008-11-17 10:47:00,395, -> rl = org.objectweb.joram.client.jms.connection.Requestor@db0a6f)
FINEST 2008-11-17 10:47:00,395, Requestor.replyReceived((org.objectweb.joram.shared.client.ServerReply@982d9ecorrelationId=1))
FINEST 2008-11-17 10:47:00,395, Requestor.setStatus(DONE)
FINEST 2008-11-17 10:47:00,395, -> request #1 awake
FINEST 2008-11-17 10:47:00,395, -> request #1 done
FINEST 2008-11-17 10:47:00,395, Requestor.setStatus(INIT)
FINEST 2008-11-17 10:47:00,395, --- QueueSend:c1329s0: closing...
FINEST 2008-11-17 10:47:00,395, QueueSend:c1329s0: closed.
FINEST 2008-11-17 10:47:00,395, Requestor.close()
FINEST 2008-11-17 10:47:00,395, Requestor[INIT,0].abortRequest()
FINEST 2008-11-17 10:47:00,395, Requestor.setStatus(CLOSE)
FINEST 2008-11-17 10:47:00,395, Requestor.request((org.objectweb.joram.shared.client.CnxCloseRequest@89ffe6,requestId=-1,target=null),0)
FINEST 2008-11-17 10:47:00,395, Requestor.setStatus(RUN)
FINEST 2008-11-17 10:47:00,395, -> request #2 wait
FINEST 2008-11-17 10:47:00,396, TcpReader reads msg: (org.objectweb.joram.mom.proxies.ProxyMessage@1ff7a3e,id=2,ackId=1,obj=(org.objectweb.joram.shared.client.CnxCloseRequest@1b2aba1,requestId=2,target=null))
FINEST 2008-11-17 10:47:00,396, Channel#0.directSendTo(#0.0.0, #0.0.1027, ((org.objectweb.joram.mom.proxies.RequestNot@1220923,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@1ff7a3e,id=2,ackId=1,obj=(org.objectweb.joram.shared.client.CnxCloseRequest@1b2aba1,requestId=2,target=null))))
FINEST 2008-11-17 10:47:00,396, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.0, ((org.objectweb.joram.mom.proxies.RequestNot@185e5b9,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@1ff7a3e,id=2,ackId=1,obj=(org.objectweb.joram.shared.client.CnxCloseRequest@1b2aba1,requestId=2,target=null))))
FINEST 2008-11-17 10:47:00,396, UserAgent.react(#0.0.0,((org.objectweb.joram.mom.proxies.RequestNot@185e5b9,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null),cKey=1329,msg=(org.objectweb.joram.mom.proxies.ProxyMessage@1ff7a3e,id=2,ackId=1,obj=(org.objectweb.joram.shared.client.CnxCloseRequest@1b2aba1,requestId=2,target=null))))
FINEST 2008-11-17 10:47:00,396, setNoSave()
FINEST 2008-11-17 10:47:00,396, AckedQueue.ack(1)
FINEST 2008-11-17 10:47:00,396, AckedQueue acked 1
FINEST 2008-11-17 10:47:00,396, UserAgent.setSave()
FINEST 2008-11-17 10:47:00,396, UserAgent.sendToClient(1329,(org.objectweb.joram.shared.client.CnxCloseReply@1acd991correlationId=2))
FINEST 2008-11-17 10:47:00,396, AckedQueue.push((org.objectweb.joram.mom.proxies.ProxyMessage@ffda1e,id=2,ackId=2,obj=(org.objectweb.joram.shared.client.CnxCloseReply@1acd991correlationId=2)))
FINEST 2008-11-17 10:47:00,396, AckedQueue.get()
FINEST 2008-11-17 10:47:00,396, Agent#0.0.1027 [as2user] saved
FINEST 2008-11-17 10:47:00,397, RequestMultiplexer.route((org.objectweb.joram.shared.client.CnxCloseReply@1491c66correlationId=2))
FINEST 2008-11-17 10:47:00,397, -> rl = org.objectweb.joram.client.jms.connection.Requestor@6ff3f4)
FINEST 2008-11-17 10:47:00,397, Requestor.replyReceived((org.objectweb.joram.shared.client.CnxCloseReply@1491c66correlationId=2))
FINEST 2008-11-17 10:47:00,397, Requestor.setStatus(DONE)
FINEST 2008-11-17 10:47:00,397, -> request #2 awake
FINEST 2008-11-17 10:47:00,397, -> request #2 done
FINEST 2008-11-17 10:47:00,397, Requestor.setStatus(INIT)
FINEST 2008-11-17 10:47:00,397, RequestMultiplexer.close()
FINEST 2008-11-17 10:47:00,397, RequestMultiplexer.setStatus(CLOSE)
FINEST 2008-11-17 10:47:00,397, -> requestsTable={}
FINEST 2008-11-17 10:47:00,399,
java.io.EOFException
at org.objectweb.joram.shared.stream.StreamUtil.readFully(StreamUtil.java:53)
at org.objectweb.joram.shared.stream.StreamUtil.readIntFrom(StreamUtil.java:165)
at org.objectweb.joram.mom.proxies.tcp.IOControl.receive(IOControl.java:123)
at org.objectweb.joram.mom.proxies.tcp.TcpReader.run(TcpReader.java:85)
at java.lang.Thread.run(Thread.java:619)
FINEST 2008-11-17 10:47:00,399, Channel#0.directSendTo(#0.0.0, #0.0.1027, (org.objectweb.joram.mom.proxies.CloseConnectionNot@4b2479,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,399, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.0, (org.objectweb.joram.mom.proxies.CloseConnectionNot@147ac17,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,399, UserAgent.react(#0.0.0,(org.objectweb.joram.mom.proxies.CloseConnectionNot@147ac17,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:00,400, setNoSave()
FINEST 2008-11-17 10:47:00,400, Agent#0.0.1027 [as2user] not saved
FINEST 2008-11-17 10:47:00,400, TcpWriter.close()
java.lang.Exception
at org.objectweb.joram.mom.proxies.tcp.TcpWriter.close(TcpWriter.java:109)
at org.objectweb.joram.mom.proxies.tcp.TcpWriter.shutdown(TcpWriter.java:104)
at fr.dyade.aaa.util.Daemon.stop(Daemon.java:267)
at org.objectweb.joram.mom.proxies.tcp.TcpConnection.close(TcpConnection.java:138)
at org.objectweb.joram.mom.proxies.tcp.TcpReader$1.run(TcpReader.java:108)
at java.lang.Thread.run(Thread.java:619)
FINEST 2008-11-17 10:47:00,400,
java.lang.InterruptedException
at java.lang.Object.wait(Native Method)
at java.lang.Object.wait(Object.java:485)
at org.objectweb.joram.mom.proxies.AckedQueue.get(AckedQueue.java:62)
at org.objectweb.joram.mom.proxies.tcp.TcpWriter.run(TcpWriter.java:78)
at java.lang.Thread.run(Thread.java:619)
FINEST 2008-11-17 10:47:00,400, TcpWriter.close()
java.lang.Exception
at org.objectweb.joram.mom.proxies.tcp.TcpWriter.close(TcpWriter.java:109)
at fr.dyade.aaa.util.Daemon.finish(Daemon.java:246)
at fr.dyade.aaa.util.Daemon.stop(Daemon.java:275)
at org.objectweb.joram.mom.proxies.tcp.TcpConnection.close(TcpConnection.java:138)
at org.objectweb.joram.mom.proxies.tcp.TcpReader$1.run(TcpReader.java:108)
at java.lang.Thread.run(Thread.java:619)
FINEST 2008-11-17 10:47:00,401, TcpReader.close()
FINEST 2008-11-17 10:47:00,401, TcpProxyService.unregisterConnection(org.objectweb.joram.mom.proxies.tcp.TcpConnection@671c2c)
FINEST 2008-11-17 10:47:17,986, Channel#0.directSendTo(#0.0.11, #0.0.11, (org.objectweb.joram.mom.notifications.WakeUpNot@1a58d5,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, Channel#0.directSendTo(#0.0.1027, #0.0.1027, (org.objectweb.joram.mom.notifications.WakeUpNot@1be29da,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@17d7c7f,name=JoramAdminProxy,id=#0.0.11,fixed=true).react(#0.0.11, (org.objectweb.joram.mom.notifications.WakeUpNot@1add01c,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, UserAgent.react(#0.0.11,(org.objectweb.joram.mom.notifications.WakeUpNot@1add01c,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, setNoSave()
FINEST 2008-11-17 10:47:17,987, Agent#0.0.11 [JoramAdminProxy] not saved
FINEST 2008-11-17 10:47:17,987, Engine#0: (org.objectweb.joram.mom.proxies.UserAgent@75a340,name=as2user,id=#0.0.1027,fixed=true).react(#0.0.1027, (org.objectweb.joram.mom.notifications.WakeUpNot@3a061b,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, UserAgent.react(#0.0.1027,(org.objectweb.joram.mom.notifications.WakeUpNot@3a061b,messageId=null,persistent=false,detachable=false,detached=false,context=null,expiration=0,priority=4,deadNotificationAgentId=null))
FINEST 2008-11-17 10:47:17,987, setNoSave()
FINEST 2008-11-17 10:47:17,987, Agent#0.0.1027 [as2user] not saved
daddykom,
we have seen in the past that sometimes the jms server (perhaps java programs in common?) is sensitive to network problems (e.g. doubled ip addresses). Are you sure nothing like this happened, could you check this?
Regards
Heller
Hi Heller
No, it is a small inhouse net and we use everywhere fixed ips.
I checked also the log files, ehte is nothing like this.
Regards
Charley
Hi Heller
I gave up to solve the problem, it undersand not enough from java.
Actualy I restart mec_as2 every hour.
Anyway the problem exists from time to time.
I created a work around: I compare the input files to the log of mec_as2. If they did not exist in the log, i resend them automaticly.
I can live with it, but the situation that files disapear is not something to advise mec_as2.
But it seems that this problem exist only, when mec_as2 works in VNC.
Regards
Charley