XEP-0136 - Message Archiving - basic tests

Test duration: 13.642s

Passed Tests
tigase.tests.archive.TestMessageArchivingBasic
testChangeArchiveSettings 2.674s
2017-11-29 09:37:50 |

2017-11-29 09:37:50 | null / [TestClass name=class tigase.tests.archive.TestMessageArchivingBasic]

2017-11-29 09:37:50 | ------------------------------------

2017-11-29 09:37:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.setStage: Connector (oid=1149650230) state changed: connected->disconnecting

2017-11-29 09:37:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.terminateStream: Terminating XMPP Stream

2017-11-29 09:37:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1149650230): </stream:stream>

2017-11-29 09:37:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.terminateAllWorkers: Terminating all workers (oid=1149650230)

2017-11-29 09:37:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2017-11-29 09:37:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties!

2017-11-29 09:37:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties!

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.Jaxmpp.login: Found previous instance of Connector = {0}

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.start: Start connector (oid=1752829504).

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.setStage: Connector (oid=1752829504) state changed: null->connecting

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.start: Preparing connection to localhost:5222

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.createSocket: Opening connection to localhost/127.0.0.1:5222

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.start: Starting worker...

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.restartStream: Restarting XMPP Stream

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0'>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.setStage: Connector (oid=1752829504) state changed: connecting->connected

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.Worker.run: 205399298 Starting Thread[Socket-Worker-Thread,5,main]

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.start: Whitespace ping period is setted to nullms

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.Worker$1.xmppStreamOpened: xmppStreamOpened()

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1saHFOMEZzQWR3NnFSaU92Q245RnZUMHFZQXZkSVFhSnp1Rmo3d0pZLHM9czBLSnIwSHFuTW5RVFE9PSxpPTQwOTY=</challenge>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01eXIvU2ZGK0JXbTJGRVJ0L281RUhIMno3Q1FIS0ZoUFgzaFcxT29Lei8wPQ==</success>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.Worker$1.xmppStreamOpened: xmppStreamOpened()

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session></features>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="2wtFkP"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_4p31u70150@localhost/1686442457-tigase-253</jid></bind></iq>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="GHYRWZ"/>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq from="localhost" xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="KjMbJB"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.0.0-SNAPSHOT-b5086/2387b14d(2017-11-29/05:44:19)" type="im"/><identity category="server" name="Tigase ver. 8.0.0-SNAPSHOT-b5086/2387b14d(2017-11-29/05:44:19)" type="im"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <enabled xmlns="urn:xmpp:sm:3" max="60" resume="true" id="d25af51f-faa1-4c1b-8ec3-7ceeab03ebed" location="build.xmpp-test.net"/>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="GJ0V4f"><query xmlns="jabber:iq:roster"/></iq>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <presence from="MaM-_4p31u70150@localhost/1686442457-tigase-253" xmlns="jabber:client" to="MaM-_4p31u70150@localhost"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="GDJeU2PgGrtUeUH62yXz3492Sf0="/></presence>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <a xmlns="urn:xmpp:sm:3" h="2"/>

2017-11-29 09:37:51 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq id="czuDgB" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <iq id="czuDgB" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2017-11-29 09:37:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="czuDgB"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2017-11-29 09:37:53 | [Mutex] received everything.

2017-11-29 09:37:53 | [Mutex] isItemNotified: setArchiveSettings:fd5d3999-343a-463e-83e5-fc96e4031db3:success :: true

2017-11-29 09:37:54 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <message from="MaM-_md00hb0151@localhost/1686442457-tigase-252" xmlns="jabber:client" type="chat" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="rild7r0155"><body>nsipg50154</body></message>

2017-11-29 09:37:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <message from="MaM-_md00hb0151@localhost/1686442457-tigase-252" xmlns="jabber:client" type="chat" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="z1p2ui0159"><body>l6cbyo0158</body></message>

2017-11-29 09:37:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <a xmlns="urn:xmpp:sm:3" h="6"/>

2017-11-29 09:37:58 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <message from="MaM-_md00hb0151@localhost/1686442457-tigase-252" xmlns="jabber:client" type="chat" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="zc33s50163"><body>j9e60k0162</body></message>

2017-11-29 09:38:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <message from="MaM-_md00hb0151@localhost/1686442457-tigase-252" xmlns="jabber:client" type="chat" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="saunat0167"><body>ds0z2j0166</body></message>

2017-11-29 09:38:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <message from="MaM-_md00hb0151@localhost/1686442457-tigase-252" xmlns="jabber:client" type="chat" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="x48pxb0171"><body>r1ad150170</body></message>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="FJWP1g"><list xmlns="urn:xmpp:archive"><chat start="2017-11-29T08:37:53Z" with="MaM-_md00hb0151@localhost"/><set xmlns="http://jabber.org/protocol/rsm"><first index="0">0</first><last>0</last><count>1</count></set></list></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <a xmlns="urn:xmpp:sm:3" h="10"/>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="WpWIEy"><chat start="2017-11-29T08:37:53Z" xmlns="urn:xmpp:archive" with="MaM-_md00hb0151@localhost"><to secs="0" with="MaM-_md00hb0151@localhost"><body>4hae940152</body></to><from secs="1" with="MaM-_md00hb0151@localhost"><body>nsipg50154</body></from><to secs="2" with="MaM-_md00hb0151@localhost"><body>rntx460156</body></to><from secs="3" with="MaM-_md00hb0151@localhost"><body>l6cbyo0158</body></from><to secs="4" with="MaM-_md00hb0151@localhost"><body>sr6adg0160</body></to><from secs="5" with="MaM-_md00hb0151@localhost"><body>j9e60k0162</body></from><to secs="6" with="MaM-_md00hb0151@localhost"><body>1c18r10164</body></to><from secs="7" with="MaM-_md00hb0151@localhost"><body>ds0z2j0166</body></from><to secs="8" with="MaM-_md00hb0151@localhost"><body>5x40ab0168</body></to><from secs="9" with="MaM-_md00hb0151@localhost"><body>r1ad150170</body></from><set xmlns="http://jabber.org/protocol/rsm"><first index="0">0</first><last>9</last><count>10</count></set></chat></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <r xmlns="urn:xmpp:sm:3"/>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="uQd8x7"><list xmlns="urn:xmpp:archive"><chat start="2017-11-29T08:37:53Z" with="MaM-_md00hb0151@localhost"/><set xmlns="http://jabber.org/protocol/rsm"><first index="0">0</first><last>0</last><count>1</count></set></list></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <iq xmlns="jabber:client" type="result" to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="uReaBf"><chat start="2017-11-29T08:37:53Z" xmlns="urn:xmpp:archive" with="MaM-_md00hb0151@localhost"><to secs="0" with="MaM-_md00hb0151@localhost"><body>4hae940152</body></to><from secs="1" with="MaM-_md00hb0151@localhost"><body>nsipg50154</body></from><to secs="2" with="MaM-_md00hb0151@localhost"><body>rntx460156</body></to><from secs="3" with="MaM-_md00hb0151@localhost"><body>l6cbyo0158</body></from><to secs="4" with="MaM-_md00hb0151@localhost"><body>sr6adg0160</body></to><from secs="5" with="MaM-_md00hb0151@localhost"><body>j9e60k0162</body></from><to secs="6" with="MaM-_md00hb0151@localhost"><body>1c18r10164</body></to><from secs="7" with="MaM-_md00hb0151@localhost"><body>ds0z2j0166</body></from><to secs="8" with="MaM-_md00hb0151@localhost"><body>5x40ab0168</body></to><from secs="9" with="MaM-_md00hb0151@localhost"><body>r1ad150170</body></from><set xmlns="http://jabber.org/protocol/rsm"><first index="0">0</first><last>9</last><count>10</count></set></chat></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.processElement: Recv (oid=1752829504): <presence from="MaM-_4p31u70150@localhost/1686442457-tigase-254" xmlns="jabber:client" to="MaM-_4p31u70150@localhost"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="GDJeU2PgGrtUeUH62yXz3492Sf0="/></presence>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.run: 205399298 / Disconnecting: state=disconnecting; isInterrupted():false; buffer=-1   Thread[Socket-Worker-Thread,5,main]

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.setStage: Connector (oid=1752829504) state changed: disconnecting->disconnected

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.onStreamTerminate: Stream terminated

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.terminateAllWorkers: Terminating all workers (oid=1752829504)

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.run: Worker2 is interrupted

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.workerTerminated: Worker terminated

testMessageArchiving 10.038s
2017-11-29 09:37:53 |

2017-11-29 09:37:53 | null / [TestClass name=class tigase.tests.archive.TestMessageArchivingBasic]

2017-11-29 09:37:53 | ------------------------------------

2017-11-29 09:37:53 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="wd9jm80153" type="chat"><body>4hae940152</body></message>

2017-11-29 09:37:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="wd9jm80153" type="chat"><body>4hae940152</body></message>

2017-11-29 09:37:53 | [Mutex] waiting for: [msg:wd9jm80153]

2017-11-29 09:37:53 | [Mutex] received everything.

2017-11-29 09:37:54 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="rild7r0155" type="chat"><body>nsipg50154</body></message>

2017-11-29 09:37:54 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1874962678): <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="rild7r0155" type="chat"><body>nsipg50154</body></message>

2017-11-29 09:37:54 | [Mutex] waiting for: [msg:rild7r0155]

2017-11-29 09:37:54 | [Mutex] received everything.

2017-11-29 09:37:55 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="kvogsu0157" type="chat"><body>rntx460156</body></message>

2017-11-29 09:37:55 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="kvogsu0157" type="chat"><body>rntx460156</body></message>

2017-11-29 09:37:55 | [Mutex] waiting for: [msg:kvogsu0157]

2017-11-29 09:37:55 | [Mutex] received everything.

2017-11-29 09:37:56 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="z1p2ui0159" type="chat"><body>l6cbyo0158</body></message>

2017-11-29 09:37:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1874962678): <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="z1p2ui0159" type="chat"><body>l6cbyo0158</body></message>

2017-11-29 09:37:56 | [Mutex] waiting for: [msg:z1p2ui0159]

2017-11-29 09:37:56 | [Mutex] received everything.

2017-11-29 09:37:57 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="8k1nmq0161" type="chat"><body>sr6adg0160</body></message>

2017-11-29 09:37:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="8k1nmq0161" type="chat"><body>sr6adg0160</body></message>

2017-11-29 09:37:57 | [Mutex] waiting for: [msg:8k1nmq0161]

2017-11-29 09:37:57 | [Mutex] received everything.

2017-11-29 09:37:58 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="zc33s50163" type="chat"><body>j9e60k0162</body></message>

2017-11-29 09:37:58 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1874962678): <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="zc33s50163" type="chat"><body>j9e60k0162</body></message>

2017-11-29 09:37:58 | [Mutex] received everything.

2017-11-29 09:37:59 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="jebtws0165" type="chat"><body>1c18r10164</body></message>

2017-11-29 09:37:59 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="jebtws0165" type="chat"><body>1c18r10164</body></message>

2017-11-29 09:37:59 | [Mutex] received everything.

2017-11-29 09:38:00 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="saunat0167" type="chat"><body>ds0z2j0166</body></message>

2017-11-29 09:38:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1874962678): <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="saunat0167" type="chat"><body>ds0z2j0166</body></message>

2017-11-29 09:38:00 | [Mutex] waiting for: [msg:saunat0167]

2017-11-29 09:38:00 | [Mutex] received everything.

2017-11-29 09:38:01 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="9zpb1m0169" type="chat"><body>5x40ab0168</body></message>

2017-11-29 09:38:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <message to="MaM-_md00hb0151@localhost/1686442457-tigase-252" id="9zpb1m0169" type="chat"><body>5x40ab0168</body></message>

2017-11-29 09:38:01 | [Mutex] received everything.

2017-11-29 09:38:02 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="x48pxb0171" type="chat"><body>r1ad150170</body></message>

2017-11-29 09:38:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1874962678): <message to="MaM-_4p31u70150@localhost/1686442457-tigase-253" id="x48pxb0171" type="chat"><body>r1ad150170</body></message>

2017-11-29 09:38:02 | [Mutex] received everything.

testMesssageRetrivalJidComparison 0.060s
2017-11-29 09:38:03 |

2017-11-29 09:38:03 | null / [TestClass name=class tigase.tests.archive.TestMessageArchivingBasic]

2017-11-29 09:38:03 | ------------------------------------

2017-11-29 09:38:03 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq id="FJWP1g" type="get"><list xmlns="urn:xmpp:archive" with="mam-_md00hb0151@localhost"><set xmlns="http://jabber.org/protocol/rsm"/></list></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <iq id="FJWP1g" type="get"><list xmlns="urn:xmpp:archive" with="mam-_md00hb0151@localhost"><set xmlns="http://jabber.org/protocol/rsm"/></list></iq>

2017-11-29 09:38:03 | [Mutex] waiting for: [1:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received, 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received]

2017-11-29 09:38:03 | [Mutex] waiting for: [1:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received, 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received]

2017-11-29 09:38:03 | [Mutex] received everything.

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:4hae940152 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:nsipg50154 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:rntx460156 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:l6cbyo0158 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:sr6adg0160 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:j9e60k0162 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:1c18r10164 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:ds0z2j0166 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:5x40ab0168 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:7862ba4c-ab8c-416a-866b-623cba0aabc7:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:r1ad150170 :: true

testMesssageRetrivalSuccess 0.010s
2017-11-29 09:38:03 |

2017-11-29 09:38:03 | null / [TestClass name=class tigase.tests.archive.TestMessageArchivingBasic]

2017-11-29 09:38:03 | ------------------------------------

2017-11-29 09:38:03 | tigase.jaxmpp.core.client.JaxmppCore$DefaultPacketWriter.write: SENT: <iq id="uQd8x7" type="get"><list xmlns="urn:xmpp:archive" with="MaM-_md00hb0151@localhost"><set xmlns="http://jabber.org/protocol/rsm"/></list></iq>

2017-11-29 09:38:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.send: Send (oid=1752829504): <iq id="uQd8x7" type="get"><list xmlns="urn:xmpp:archive" with="MaM-_md00hb0151@localhost"><set xmlns="http://jabber.org/protocol/rsm"/></list></iq>

2017-11-29 09:38:03 | [Mutex] waiting for: [2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received, 1:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received]

2017-11-29 09:38:03 | [Mutex] waiting for: [2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received, 1:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:received]

2017-11-29 09:38:03 | [Mutex] received everything.

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:4hae940152 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:nsipg50154 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:rntx460156 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:l6cbyo0158 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:sr6adg0160 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:j9e60k0162 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:1c18r10164 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:ds0z2j0166 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:5x40ab0168 :: true

2017-11-29 09:38:03 | [Mutex] isItemNotified: 2:bb346995-775c-45c5-84f8-d41a10c1cd64:fd5d3999-343a-463e-83e5-fc96e4031db3:retriveCollection:success:r1ad150170 :: true