Project

General

Profile

Weird problem with archiving chat

Maciej Bursztynowski
Added over 5 years ago

Hi, It's me again.

I have very, very weird problem.

I have users which, where registered ~1 month ago:

Me-old-1

Me-old-2

and 2 newly created users

Me-new-1

Me-new-2

When I'm logged as Me-old-1 and chatting with any other user, messages are archiving in mysql.

When I'm logged as Me-new-1 and chatting with Me-new-2, messages are not archived.

I've tested it on different XMPP Clients, enabling and disabling AMP, other plugins/components... and I don't know what's going on. What could happened?

There is log when chatting Me-new-1 with Me-new-2 (archiving doesn't work)

2013-08-08 14:21:03.080 [pool-16-thread-8]  ClientConnectionManager.processSocketData()  FINEST: Processing socket data: from=null, to=null, DATA=<message type="chat" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=172, XMLNS=null, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225
2013-08-08 14:21:03.080 [pool-16-thread-8]  ClientConnectionManager.processSocketData()  FINEST: XMLNS set for packet: from=null, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225
2013-08-08 14:21:03.082 [in_6-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:03.083 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.083 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:03.083 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:03.113 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : sess-man@localhost.localdomain
2013-08-08 14:21:03.114 [in_6-message-router]  MessageRouter.processPacket()  FINEST:   1. Packet will be processed by: sess-man@localhost.localdomain, from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:03.114 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:03.115 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, connection: user_jid=testarch@labo.4prm.com/AQQ, packets=26, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.116 [in_6-sess-man]    PacketDefaultHandler.preprocess()  FINEST:   Skipping setting correct from attribute: testarch@labo.4prm.com/AQQ, is already correct.
2013-08-08 14:21:03.116 [in_6-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.117 [in_6-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.117 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:03.119 [in_0-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.120 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.120 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:03.120 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:03.121 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.121 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:03.121 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:03.122 [in_0-message-router]  MessageRouter.processPacket()  FINEST:   2. Packet will be processed by: sess-man@localhost.localdomain, from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.123 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.123 [in_0-sess-man]    SessionManager.getXMPPResourceConnection()  FINEST: Searching for resource connection for: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.123 [in_0-sess-man]    SessionManager.getResourceConnection()  FINEST: Session not null, searching session for jid: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.123 [in_0-sess-man]    SessionManager.getResourceConnection()  FINEST: Found session: user_jid=testarch2@labo.4prm.com/AQQ, packets=26, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false, for jid: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.124 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, connection: user_jid=testarch2@labo.4prm.com/AQQ, packets=26, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.124 [in_0-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.125 [in_0-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:03.126 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:03.129 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.130 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:03.130 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:03.131 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:03.132 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226
2013-08-08 14:21:03.132 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:03.133 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   1. Packet will be processed by: c2s@localhost.localdomain, from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.134 [in_7-c2s]         ClientConnectionManager.processPacket()  FINEST: Processing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:03.134 [in_7-c2s]         ConnectionManager.writePacketToSocket()  FINEST: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, type: accept, Socket: TLS: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226 Socket[addr=/10.2.0.103,port=54226,localport=5222], jid: testarch2@labo.4prm.com/AQQ, Writing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session117" from="testarch@labo.4prm.com/AQQ"><composing xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=194, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.671 [pool-16-thread-1]  ClientConnectionManager.processSocketData()  FINEST: Processing socket data: from=null, to=null, DATA=<message type="chat" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=223, XMLNS=null, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225
2013-08-08 14:21:04.671 [pool-16-thread-1]  ClientConnectionManager.processSocketData()  FINEST: XMLNS set for packet: from=null, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225
2013-08-08 14:21:04.673 [in_6-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:04.676 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.676 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.677 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.677 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : sess-man@localhost.localdomain
2013-08-08 14:21:04.677 [in_6-message-router]  MessageRouter.processPacket()  FINEST:   1. Packet will be processed by: sess-man@localhost.localdomain, from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:04.678 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat
2013-08-08 14:21:04.678 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, connection: user_jid=testarch@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.678 [in_6-sess-man]    PacketDefaultHandler.preprocess()  FINEST:   Skipping setting correct from attribute: testarch@labo.4prm.com/AQQ, is already correct.
2013-08-08 14:21:04.680 [in_6-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.680 [in_6-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=chat, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.681 [in_6-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:04.682 [in_0-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.683 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.683 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.684 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.684 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.685 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.685 [in_0-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.686 [in_0-message-router]  MessageRouter.processPacket()  FINEST:   2. Packet will be processed by: sess-man@localhost.localdomain, from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.687 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=sess-man@localhost.localdomain, to=null, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.687 [in_0-sess-man]    SessionManager.getXMPPResourceConnection()  FINEST: Searching for resource connection for: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.688 [in_0-sess-man]    SessionManager.getResourceConnection()  FINEST: Session not null, searching session for jid: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.688 [in_0-sess-man]    SessionManager.getResourceConnection()  FINEST: Found session: user_jid=testarch2@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false, for jid: testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.688 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, connection: user_jid=testarch2@labo.4prm.com/AQQ, packets=27, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.689 [in_0-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.691 [in_0-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.692 [in_0-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:04.693 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.693 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch2@labo.4prm.com/AQQ
2013-08-08 14:21:04.693 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch2@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.694 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch2@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.695 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226
2013-08-08 14:21:04.695 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.696 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   1. Packet will be processed by: c2s@localhost.localdomain, from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.696 [in_7-c2s]         ClientConnectionManager.processPacket()  FINEST: Processing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>CData size: 5</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.697 [in_7-c2s]         ConnectionManager.writePacketToSocket()  FINEST: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, type: accept, Socket: TLS: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226 Socket[addr=/10.2.0.103,port=54226,localport=5222], jid: testarch2@labo.4prm.com/AQQ, Writing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, DATA=<message type="chat" xmlns="jabber:client" to="testarch2@labo.4prm.com/AQQ" id="session118" from="testarch@labo.4prm.com/AQQ"><body>tak ?</body><request xmlns="urn:xmpp:receipts"/><active xmlns="http://jabber.org/protocol/chatstates"/></message>, SIZE=245, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=chat
2013-08-08 14:21:04.727 [pool-16-thread-7]  ClientConnectionManager.processSocketData()  FINEST: Processing socket data: from=null, to=null, DATA=<message to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=154, XMLNS=null, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226
2013-08-08 14:21:04.728 [pool-16-thread-7]  ClientConnectionManager.processSocketData()  FINEST: XMLNS set for packet: from=null, to=null, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null from connection: c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226
2013-08-08 14:21:04.729 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null
2013-08-08 14:21:04.730 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.731 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.731 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.732 [in_7-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : sess-man@localhost.localdomain
2013-08-08 14:21:04.733 [in_7-message-router]  MessageRouter.processPacket()  FINEST:   1. Packet will be processed by: sess-man@localhost.localdomain, from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null
2013-08-08 14:21:04.734 [in_7-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null
2013-08-08 14:21:04.735 [in_7-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null, connection: user_jid=testarch2@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.735 [in_7-sess-man]    PacketDefaultHandler.preprocess()  FINEST:   Skipping setting correct from attribute: testarch2@labo.4prm.com/AQQ, is already correct.
2013-08-08 14:21:04.736 [in_7-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=29, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.737 [in_7-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=NONE, TYPE=null, conn: user_jid=testarch2@labo.4prm.com/AQQ, packets=29, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54226, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.738 [in_7-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:04.740 [in_2-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=null, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null
2013-08-08 14:21:04.741 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.741 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.742 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.743 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.743 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.744 [in_2-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponent@f63055, srecv=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor=tigase.server.monitor.MonitorComponent@d5cabc, muc=tigase.muc.MUCComponent@1b8b3bb}, for all VHosts: {3}
2013-08-08 14:21:04.744 [in_2-message-router]  MessageRouter.processPacket()  FINEST:   2. Packet will be processed by: sess-man@localhost.localdomain, from=sess-man@localhost.localdomain, to=null, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null
2013-08-08 14:21:04.746 [in_2-sess-man]    SessionManager.processPacket()     FINEST:   Received packet: from=sess-man@localhost.localdomain, to=null, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null
2013-08-08 14:21:04.746 [in_2-sess-man]    SessionManager.getXMPPResourceConnection()  FINEST: Searching for resource connection for: testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.747 [in_2-sess-man]    SessionManager.getResourceConnection()  FINEST: Session not null, searching session for jid: testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.747 [in_2-sess-man]    SessionManager.getResourceConnection()  FINEST: Found session: user_jid=testarch@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false, for jid: testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.748 [in_2-sess-man]    SessionManager.processPacket()     FINEST:   processing packet: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null, connection: user_jid=testarch@labo.4prm.com/AQQ, packets=28, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.748 [in_2-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: Message (message)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=29, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.749 [in_2-sess-man]    SessionManager.walk()              FINEST:   XMPPProcessorIfc: MessageArchivePlugin (message-archive-xep-0136)
 Request: from=sess-man@localhost.localdomain, to=sess-man@localhost.localdomain, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null, conn: user_jid=testarch@labo.4prm.com/AQQ, packets=29, connectioId=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, domain=labo.4prm.com, authState=AUTHORIZED, isAnon=false
2013-08-08 14:21:04.750 [in_2-sess-man]    SessionManager.processPacket()     FINEST:   Packet processed by: [message, message-archive-xep-0136]
2013-08-08 14:21:04.752 [in_6-message-router]  MessageRouter.processPacket()  FINEST:   Processing packet: from=sess-man@localhost.localdomain, to=c2s@localhost.localdomain/10.2.0.3_5222_10.2.0.103_54225, DATA=<message xmlns="jabber:client" to="testarch@labo.4prm.com/AQQ" id="session32" from="testarch2@labo.4prm.com/AQQ"><received xmlns="urn:xmpp:receipts" id="session118"/></message>, SIZE=176, XMLNS=jabber:client, PRIORITY=NORMAL, PERMISSION=AUTH, TYPE=null
2013-08-08 14:21:04.753 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Called for : testarch@labo.4prm.com/AQQ
2013-08-08 14:21:04.753 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: None compId matches: testarch@labo.4prm.com/AQQ, for map: {ws2s@localhost.localdomain=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, c2s@localhost.localdomain=tigase.server.xmppclient.ClientConnectionManager@ae97c4, ssend@localhost.localdomain=tigase.server.ssender.StanzaSender@347448, proxy@localhost.localdomain=tigase.socks5.Socks5ProxyComponent@12dd76, stats@localhost.localdomain=tigase.stats.StatisticsCollector@1629e71, s2s@localhost.localdomain=tigase.server.xmppserver.S2SConnectionManager@54f169, vhost-man@localhost.localdomain=tigase.vhosts.VHostManager@19fdbcb, muc@localhost.localdomain=tigase.muc.MUCComponent@1b8b3bb, message-archive@localhost.localdomain=tigase.archive.MessageArchiveComponent@f63055, sess-man@localhost.localdomain=tigase.server.xmppsession.SessionManager@c5f9fe, bosh@localhost.localdomain=tigase.server.bosh.BoshConnectionManager@12c4c57, basic-conf@localhost.localdomain=tigase.conf.Configurator@dac21, rest@localhost.localdomain=tigase.http.rest.RestMessageReceiver@a16157, srecv@localhost.localdomain=tigase.server.sreceiver.StanzaReceiver@71c5bc, monitor@localhost.localdomain=tigase.server.monitor.MonitorComponent@d5cabc}
2013-08-08 14:21:04.753 [in_6-message-router]  MessageRouter.getLocalComponent()  FINEST: Still no comp name matches: testarch@labo.4prm.com/AQQ, for map: {ssend=tigase.server.ssender.StanzaSender@347448, c2s=tigase.server.xmppclient.ClientConnectionManager@ae97c4, basic-conf=tigase.conf.Configurator@dac21, s2s=tigase.server.xmppserver.S2SConnectionManager@54f169, rest=tigase.http.rest.RestMessageReceiver@a16157, bosh=tigase.server.bosh.BoshConnectionManager@12c4c57, proxy=tigase.socks5.Socks5ProxyComponent@12dd76, vhost-man=tigase.vhosts.VHostManager@19fdbcb, sess-man=tigase.server.xmppsession.SessionManager@c5f9fe, ws2s=tigase.server.websocket.WebSocketClientConnectionManager@141cd01, message-router=tigase.server.MessageRouter@16fdac, stats=tigase.stats.StatisticsCollector@1629e71, message-archive=tigase.archive.MessageArchiveComponen

Replies (5)

Added by Wojciech Kapcia TigaseTeam over 5 years ago

  • could you provide logs with following configuration in init.properties (most importantly - debugging enabled for archive package)
--debug=server,xmpp.impl,archive
<iq type='set' id='auto1'>
  <auto save='true' xmlns='urn:xmpp:archive'/>
</iq>

Added by Maciej Bursztynowski over 5 years ago

Thanks a lot!

When I used that stanza:

<iq type='set' id='auto1'>
  <auto save='true' xmlns='urn:xmpp:archive'/>
</iq>

it worked. But I can't remember that I've done it for those old accounts. Is there any chance to force auto-archiving for all newly created users?

Added by Andrzej Wójcik IoT 1 CloudTigaseTeam over 5 years ago

According to XEP-0136 Message Archiving , archiving feature need to be enabled by user and shouldn't be enabled by default.

Avatar?id=6023&size=32x32

Added by Artur Hefczyc TigaseTeam over 5 years ago

I think it does make sense to make it a configurable default. Perhaps it would be best to make it configurable on per-vhost basis. This way we could make it a more convenient/useful for service administrators.

Maciej, if you are interested in having a default mode configurable, please submit a feature request and we will consider it for a next version: https://projects.tigase.org/projects/message-archiving/issues/new

Added by Maciej Bursztynowski over 5 years ago

Hi,

I worked it out by creating php script which adds specific rows to MySQL, when I create user.

Andrzej, I think that archiving futuche shouldn't be enabled by default if I make XMPP server for everyone, some community or sth like that, but if it is corporate chat, I think it should be archived.

Artur, I'll send request like you advised.

    (1-5/5)