Generated by TestNG with ReportNG at 22:48 PDT on Sunday 18 September 2022
root@7c41cec37518 / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

XEP-0136 - Message Archive - extended tests

Suites · Log Output

Test duration : 17.036s

Passed Tests
tigase.tests.archive.TestMessageArchive
testChangeArchiveSettings 2.725s
2022-09-18 23:07:50 |

2022-09-18 23:07:50 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive]

2022-09-18 23:07:50 | ------------------------------------

2022-09-18 23:07:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=574 thread=1] Connector  state changed: connected->disconnecting

2022-09-18 23:07:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=574 thread=1] Terminating XMPP Stream

2022-09-18 23:07:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:07:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-18 23:07:50 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-18 23:07:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] Connector  state changed: null->connecting

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] DNS entry stored in session object: localhost:5222

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] Preparing connection to [localhost:5222]

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] Connector  state changed: connecting->connected

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=1] Whitespace ping period is setted to nullms

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=3661] Proceeding TLS

2022-09-18 23:07:51 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=3661] Start handshake

2022-09-18 23:07:53 | [Mutex] received everything.

2022-09-18 23:07:53 | [Mutex] isItemNotified: setArchiveSettings:774631c8-49ec-4749-9501-60953be28814:success :: true

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=3661] Connector  state changed: connected->disconnected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=577 thread=3661] Stream terminated

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testMessageArchiving 10.101s
2022-09-18 23:07:53 |

2022-09-18 23:07:53 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive]

2022-09-18 23:07:53 | ------------------------------------

2022-09-18 23:07:53 | [Mutex] waiting for: [msg:vfsvzo0286]

2022-09-18 23:07:53 | [Mutex] received everything.

2022-09-18 23:07:53 | [Mutex] isItemNotified: msg:vfsvzo0286 :: true

2022-09-18 23:07:54 | [Mutex] waiting for: [msg:nal9y40288]

2022-09-18 23:07:54 | [Mutex] received everything.

2022-09-18 23:07:54 | [Mutex] isItemNotified: msg:nal9y40288 :: true

2022-09-18 23:07:55 | [Mutex] waiting for: [msg:pnbb9y0290]

2022-09-18 23:07:55 | [Mutex] received everything.

2022-09-18 23:07:55 | [Mutex] isItemNotified: msg:pnbb9y0290 :: true

2022-09-18 23:07:56 | [Mutex] waiting for: [msg:vdoe2n0292]

2022-09-18 23:07:56 | [Mutex] received everything.

2022-09-18 23:07:56 | [Mutex] isItemNotified: msg:vdoe2n0292 :: true

2022-09-18 23:07:57 | [Mutex] waiting for: [msg:ba62oo0294]

2022-09-18 23:07:57 | [Mutex] received everything.

2022-09-18 23:07:57 | [Mutex] isItemNotified: msg:ba62oo0294 :: true

2022-09-18 23:07:58 | [Mutex] waiting for: [msg:zacpc80296]

2022-09-18 23:07:58 | [Mutex] received everything.

2022-09-18 23:07:58 | [Mutex] isItemNotified: msg:zacpc80296 :: true

2022-09-18 23:07:59 | [Mutex] waiting for: [msg:2dab40298]

2022-09-18 23:07:59 | [Mutex] received everything.

2022-09-18 23:07:59 | [Mutex] isItemNotified: msg:2dab40298 :: true

2022-09-18 23:08:00 | [Mutex] waiting for: [msg:zdqcxw0300]

2022-09-18 23:08:00 | [Mutex] received everything.

2022-09-18 23:08:00 | [Mutex] isItemNotified: msg:zdqcxw0300 :: true

2022-09-18 23:08:01 | [Mutex] waiting for: [msg:v5johx0302]

2022-09-18 23:08:01 | [Mutex] received everything.

2022-09-18 23:08:01 | [Mutex] isItemNotified: msg:v5johx0302 :: true

2022-09-18 23:08:02 | [Mutex] waiting for: [msg:45b6z50304]

2022-09-18 23:08:02 | [Mutex] received everything.

2022-09-18 23:08:02 | [Mutex] isItemNotified: msg:45b6z50304 :: true

testMesssageRetrivalJidComparison 0.014s
2022-09-18 23:08:03 |

2022-09-18 23:08:03 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive]

2022-09-18 23:08:03 | ------------------------------------

2022-09-18 23:08:03 | [Mutex] waiting for: [1:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received, 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received]

2022-09-18 23:08:03 | [Mutex] waiting for: [1:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received, 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received]

2022-09-18 23:08:03 | [Mutex] received everything.

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:tuziz20285 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:q05tiw0287 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:uqj40a0289 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:dxieg50291 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:1qy8pf0293 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:y0k9vy0295 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:zdxq9w0297 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:men3m70299 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:7bovfs0301 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:12039130-60f4-40fa-91c8-7f6782f69f11:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:uzsesf0303 :: true

testMesssageRetrivalSuccess 0.022s
2022-09-18 23:08:03 |

2022-09-18 23:08:03 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive]

2022-09-18 23:08:03 | ------------------------------------

2022-09-18 23:08:03 | [Mutex] waiting for: [1:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received, 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received]

2022-09-18 23:08:03 | [Mutex] waiting for: [1:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received, 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:received]

2022-09-18 23:08:03 | [Mutex] received everything.

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:tuziz20285 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:q05tiw0287 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:uqj40a0289 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:dxieg50291 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:1qy8pf0293 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:y0k9vy0295 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:zdxq9w0297 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:men3m70299 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:7bovfs0301 :: true

2022-09-18 23:08:03 | [Mutex] isItemNotified: 2:1e8f976d-d1a3-4975-988b-f44916091cba:774631c8-49ec-4749-9501-60953be28814:retriveCollection:success:uzsesf0303 :: true

testRemovalOnUserRemoval 3.242s
2022-09-18 23:08:03 |

2022-09-18 23:08:03 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive]

2022-09-18 23:08:03 | ------------------------------------

2022-09-18 23:08:03 | !!!!!!!!! MaM-_gttc5x0283@test-domain.com

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] Connector  state changed: null->connecting

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] DNS entry stored in session object: localhost:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] Preparing connection to [localhost:5222]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] Connector  state changed: connecting->connected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=1] Whitespace ping period is setted to nullms

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=3664] Start TLS

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=3666] Proceeding TLS

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=3666] Start handshake

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX2d0dGM1eDAyODMscj1YcEpiaXJJd1JkaTd6aWE0VXpvUg==</auth>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YcEpiaXJJd1JkaTd6aWE0VXpvUm9Ya2dkbFpzQ1Z3aG0yYVRQUUowLHM9OHhQOGx0TE5RNEFnVmc9PSxpPTQwOTY=</challenge>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHBKYmlySXdSZGk3emlhNFV6b1JvWGtnZGxac0NWd2htMmFUUFFKMCxwPWFhcjRlbnVFdnBKTi9KRVdIQ2FkVEpZT1YyZjI2R3RkNWNHQUMrNUNDdVk9</response>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1YTGovUkJraC9wYTJEY3dqWVZWNkJCZnVhWWNWUlRrU3Q4OEhrdjc2QzhzPQ==</success>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <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"/><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><c ver="ouz+rIh/YT4lWvyVnZ8MTCx5CXI=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <iq xmlns="jabber:client" id="h60BnOVjNLwufR8Hvrj248F" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-287" xmlns="jabber:client" id="h60BnOVjNLwufR8Hvrj248F" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_gttc5x0283@test-domain.com/228467168-tigase-287</jid></bind></iq>

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 >> <iq xmlns="jabber:client" id="cdjq6xbuczcHRTXUgNXk5hZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-287" xmlns="jabber:client" id="cdjq6xbuczcHRTXUgNXk5hZ" type="result"/>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 >> <iq to="test-domain.com" id="V0E7vnaLDHP48gVWT19p3k5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <enabled max="60" xmlns="urn:xmpp:sm:3" id="99a5e234-8a60-41fa-b4c5-faaccfca8676" location="7c41cec37518" resume="true"/>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 >> <iq id="2rWesjIr7lNPSbCzfCs5eLZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-287" from="test-domain.com" xmlns="jabber:client" id="V0E7vnaLDHP48gVWT19p3k5" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><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:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><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="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-287" xmlns="jabber:client" id="2rWesjIr7lNPSbCzfCs5eLZ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:03 | Remove account as admin: MaM-_gttc5x0283@test-domain.com

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-286" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-287 << <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-287" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:03 | [Mutex] waiting for: [account:removed]

2022-09-18 23:08:03 | [Mutex] received everything.

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=3666] Connector  state changed: connected->disconnected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=578 thread=3666] Stream terminated

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Using XEP-0077 mode!!!!

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Connector  state changed: null->connecting

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@72183f9d

2022-09-18 23:08:03 | StateChangedEvent{oldState=null, newState=connecting}

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] DNS entry stored in session object: localhost:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Preparing connection to [localhost:5222]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Connector  state changed: connecting->connected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Whitespace ping period is setted to nullms

2022-09-18 23:08:03 | [Mutex] waiting for: [registration]

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7cdfdfae

2022-09-18 23:08:03 | StateChangedEvent{oldState=connecting, newState=connected}

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@78e054ed

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | MaM- :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | StanzaReceivedEvent{stanza=<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>}

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=3670] Start TLS

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=3673] Proceeding TLS

2022-09-18 23:08:03 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2022-09-18 23:08:03 | MaM- :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:03 | StanzaSendingEvent{stanza=<starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>}

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=3673] Start handshake

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3de2d595

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@e35e163

2022-09-18 23:08:03 | MaM- :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | StanzaReceivedEvent{stanza=<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>}

2022-09-18 23:08:03 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2022-09-18 23:08:03 | MaM- :: null >> <iq to="test-domain.com" id="HirslWdxcCpS3zjNACvnaLD" type="get"><query xmlns="jabber:iq:register"/></iq>

2022-09-18 23:08:03 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="HirslWdxcCpS3zjNACvnaLD" type="get"><query xmlns="jabber:iq:register"/></iq>}

2022-09-18 23:08:03 | MaM- :: null << <iq from="test-domain.com" xmlns="jabber:client" id="HirslWdxcCpS3zjNACvnaLD" type="result"><query xmlns="jabber:iq:register"><instructions>Please provide the following information to sign up for an account

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Please provide the following information to sign up for an account

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>

2022-09-18 23:08:03 | StanzaReceivedEvent{stanza=<iq from="test-domain.com" xmlns="jabber:client" id="HirslWdxcCpS3zjNACvnaLD" type="result"><query xmlns="jabber:iq:register"><instructions>Please provide the following information to sign up for an account

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><x xmlns="jabber:x:data" type="form"><title>Account Registration</title><instructions>Please provide the following information to sign up for an account

Please also provide your e-mail address (must be valid!) to which we will send confirmation link.</instructions><field var="FORM_TYPE" type="hidden"><value>jabber:iq:register</value></field><field label="Username" var="username" type="text-single"><required/><value/></field><field label="Password" var="password" type="text-private"><required/><value/></field><field label="Email (MUST BE VALID!)" var="email" type="text-single"><required/><value/></field></x></query></iq>}

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@c956da4

2022-09-18 23:08:03 | MaM- :: null >> <iq to="test-domain.com" id="jfgWbPPPEKLTcPLXl6cobsV" type="set"><query xmlns="jabber:iq:register"><username>MaM-_gttc5x0283</username><password>MaM-_gttc5x0283</password><email>daff4e05-4d3f-48d0-a43c-f8de41007a39@localhost</email></query></iq>

2022-09-18 23:08:03 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="jfgWbPPPEKLTcPLXl6cobsV" type="set"><query xmlns="jabber:iq:register"><username>MaM-_gttc5x0283</username><password>MaM-_gttc5x0283</password><email>daff4e05-4d3f-48d0-a43c-f8de41007a39@localhost</email></query></iq>}

2022-09-18 23:08:03 | MaM- :: null << <iq from="test-domain.com" xmlns="jabber:client" id="jfgWbPPPEKLTcPLXl6cobsV" type="result"/>

2022-09-18 23:08:03 | StanzaReceivedEvent{stanza=<iq from="test-domain.com" xmlns="jabber:client" id="jfgWbPPPEKLTcPLXl6cobsV" type="result"/>}

2022-09-18 23:08:03 | [Mutex] received everything.

2022-09-18 23:08:03 | [Mutex] isItemNotified: registrationSuccess :: true

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Connector  state changed: connected->disconnecting

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=1] Terminating XMPP Stream

2022-09-18 23:08:03 | StateChangedEvent{oldState=connected, newState=disconnecting}

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=3673] Connector  state changed: disconnecting->disconnected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=579 thread=3673] Stream terminated

2022-09-18 23:08:03 | StateChangedEvent{oldState=disconnecting, newState=disconnected}

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@76a807e7

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@5dcd2ada

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7c52f6f9

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@5b8d4c9a

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6dacef33

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Connector  state changed: null->connecting

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] DNS entry stored in session object: localhost:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Preparing connection to [localhost:5222]

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Connector  state changed: connecting->connected

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Whitespace ping period is setted to nullms

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=3678] Start TLS

2022-09-18 23:08:03 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=3680] Proceeding TLS

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=3680] Start handshake

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-18 23:08:03 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX2d0dGM1eDAyODMscj13VHBwdmFRb0xidmNHU01xdzFkUw==</auth>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX2d0dGM1eDAyODMscj13VHBwdmFRb0xidmNHU01xdzFkUw==</auth>

2022-09-18 23:08:03 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13VHBwdmFRb0xidmNHU01xdzFkU0pKSzROcUx6UWs0QTNKTEw5c1Q2LHM9MDVkdFNWUUNqeWdLbUE9PSxpPTQwOTY=</challenge>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13VHBwdmFRb0xidmNHU01xdzFkU0pKSzROcUx6UWs0QTNKTEw5c1Q2LHM9MDVkdFNWUUNqeWdLbUE9PSxpPTQwOTY=</challenge>

2022-09-18 23:08:03 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1RwcHZhUW9MYnZjR1NNcXcxZFNKSks0TnFMelFrNEEzSkxMOXNUNixwPTNscDc5bVFQYVRKVE9zNW5VUVVROUZ3TVFndWZBM1JOTXRtWVhXbXRYMEU9</response>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1RwcHZhUW9MYnZjR1NNcXcxZFNKSks0TnFMelFrNEEzSkxMOXNUNixwPTNscDc5bVFQYVRKVE9zNW5VUVVROUZ3TVFndWZBM1JOTXRtWVhXbXRYMEU9</response>

2022-09-18 23:08:03 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1NWWY5VmZqZCtOTkRJUGhVME1LWFdsaVVwMkNVaW1vaHB6SDI3aFhRRCtZPQ==</success>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1NWWY5VmZqZCtOTkRJUGhVME1LWFdsaVVwMkNVaW1vaHB6SDI3aFhRRCtZPQ==</success>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:03 |  >> <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"/><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><c ver="ouz+rIh/YT4lWvyVnZ8MTCx5CXI=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <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"/><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><c ver="ouz+rIh/YT4lWvyVnZ8MTCx5CXI=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-09-18 23:08:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-18 23:08:03 |  << <iq xmlns="jabber:client" id="tv0NHP5Aak3cp3dxjQ7ujJA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <iq xmlns="jabber:client" id="tv0NHP5Aak3cp3dxjQ7ujJA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-18 23:08:03 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="tv0NHP5Aak3cp3dxjQ7ujJA" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_gttc5x0283@test-domain.com/228467168-tigase-288</jid></bind></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="tv0NHP5Aak3cp3dxjQ7ujJA" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_gttc5x0283@test-domain.com/228467168-tigase-288</jid></bind></iq>

2022-09-18 23:08:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-18 23:08:03 |  << <iq xmlns="jabber:client" id="rnATcPLXl6cobsV5hFzm9yr" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 >> <iq xmlns="jabber:client" id="rnATcPLXl6cobsV5hFzm9yr" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-18 23:08:03 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="rnATcPLXl6cobsV5hFzm9yr" type="result"/>

2022-09-18 23:08:03 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="rnATcPLXl6cobsV5hFzm9yr" type="result"/>

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-18 23:08:04 |  << <iq to="test-domain.com" id="6d4vfBjRWjS5hGAlKN3hJsm" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 >> <iq to="test-domain.com" id="6d4vfBjRWjS5hGAlKN3hJsm" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-18 23:08:04 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-18 23:08:04 |  >> <enabled max="60" xmlns="urn:xmpp:sm:3" id="6a6273c0-caac-48fd-8af6-0d9860af8c0a" location="7c41cec37518" resume="true"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 << <enabled max="60" xmlns="urn:xmpp:sm:3" id="6a6273c0-caac-48fd-8af6-0d9860af8c0a" location="7c41cec37518" resume="true"/>

2022-09-18 23:08:04 |  << <iq id="p8No3tm9pfVgw2t25pVX9wt" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 >> <iq id="p8No3tm9pfVgw2t25pVX9wt" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" from="test-domain.com" xmlns="jabber:client" id="6d4vfBjRWjS5hGAlKN3hJsm" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><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:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><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="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" from="test-domain.com" xmlns="jabber:client" id="6d4vfBjRWjS5hGAlKN3hJsm" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><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:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><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="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-09-18 23:08:04 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="p8No3tm9pfVgw2t25pVX9wt" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client" id="p8No3tm9pfVgw2t25pVX9wt" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Connector  state changed: connected->disconnecting

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=1] Terminating XMPP Stream

2022-09-18 23:08:04 |  >> <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-288 << <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-288" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=3680] Connector  state changed: disconnecting->disconnected

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=580 thread=3680] Stream terminated

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] Connector  state changed: null->connecting

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] DNS entry stored in session object: localhost:5222

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] Preparing connection to [localhost:5222]

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] Connector  state changed: connecting->connected

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=1] Whitespace ping period is setted to nullms

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:04 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=3678] Start TLS

2022-09-18 23:08:04 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=3686] Proceeding TLS

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=3686] Start handshake

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:04 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-18 23:08:04 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX2d0dGM1eDAyODMscj12Qm1MS3dLS3VwUUVYa2pJN1lPSA==</auth>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX2d0dGM1eDAyODMscj12Qm1MS3dLS3VwUUVYa2pJN1lPSA==</auth>

2022-09-18 23:08:04 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12Qm1MS3dLS3VwUUVYa2pJN1lPSDNNN2phejNCdG1mSTdoTDRwRWZ3LHM9MDVkdFNWUUNqeWdLbUE9PSxpPTQwOTY=</challenge>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12Qm1MS3dLS3VwUUVYa2pJN1lPSDNNN2phejNCdG1mSTdoTDRwRWZ3LHM9MDVkdFNWUUNqeWdLbUE9PSxpPTQwOTY=</challenge>

2022-09-18 23:08:04 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkJtTEt3S0t1cFFFWGtqSTdZT0gzTTdqYXozQnRtZkk3aEw0cEVmdyxwPVNUTWJzY01ZWEN1Y0JGTmszUEI1eFJqVXRCYXZkTlh5VzJLcVBEWllydWM9</response>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkJtTEt3S0t1cFFFWGtqSTdZT0gzTTdqYXozQnRtZkk3aEw0cEVmdyxwPVNUTWJzY01ZWEN1Y0JGTmszUEI1eFJqVXRCYXZkTlh5VzJLcVBEWllydWM9</response>

2022-09-18 23:08:04 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wNDlYcU5IZUZhYmNqdXl0cGdudUZMcVFVY2xnd1lnYWxKR25PQWZteU84PQ==</success>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wNDlYcU5IZUZhYmNqdXl0cGdudUZMcVFVY2xnd1lnYWxKR25PQWZteU84PQ==</success>

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-18 23:08:04 |  >> <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"/><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><c ver="ouz+rIh/YT4lWvyVnZ8MTCx5CXI=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <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"/><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><c ver="ouz+rIh/YT4lWvyVnZ8MTCx5CXI=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-18 23:08:04 |  << <iq xmlns="jabber:client" id="jkl6vt7pO4pbMZ5BDGmIPKv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com >> <iq xmlns="jabber:client" id="jkl6vt7pO4pbMZ5BDGmIPKv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="jkl6vt7pO4pbMZ5BDGmIPKv" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_gttc5x0283@test-domain.com/228467168-tigase-289</jid></bind></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="jkl6vt7pO4pbMZ5BDGmIPKv" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_gttc5x0283@test-domain.com/228467168-tigase-289</jid></bind></iq>

2022-09-18 23:08:04 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-18 23:08:04 |  << <iq xmlns="jabber:client" id="vha7FKuYlMznRPT0r8BjKIB" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <iq xmlns="jabber:client" id="vha7FKuYlMznRPT0r8BjKIB" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="vha7FKuYlMznRPT0r8BjKIB" type="result"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="vha7FKuYlMznRPT0r8BjKIB" type="result"/>

2022-09-18 23:08:04 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-18 23:08:04 |  << <iq to="test-domain.com" id="Ch8Dv7lV4zo7lOQRMRbxfuq" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <iq to="test-domain.com" id="Ch8Dv7lV4zo7lOQRMRbxfuq" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-18 23:08:04 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-18 23:08:04 |  >> <enabled max="60" xmlns="urn:xmpp:sm:3" id="9757a0c6-4941-4218-98da-5820cd164ced" location="7c41cec37518" resume="true"/>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <enabled max="60" xmlns="urn:xmpp:sm:3" id="9757a0c6-4941-4218-98da-5820cd164ced" location="7c41cec37518" resume="true"/>

2022-09-18 23:08:04 |  << <iq id="LxSdykPIJV1dqiR5ABj3xuY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <iq id="LxSdykPIJV1dqiR5ABj3xuY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" from="test-domain.com" xmlns="jabber:client" id="Ch8Dv7lV4zo7lOQRMRbxfuq" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><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:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><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="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" from="test-domain.com" xmlns="jabber:client" id="Ch8Dv7lV4zo7lOQRMRbxfuq" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12088/0e5dcbd1" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><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:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><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="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-09-18 23:08:04 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="LxSdykPIJV1dqiR5ABj3xuY" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="LxSdykPIJV1dqiR5ABj3xuY" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-09-18 23:08:04 |  << <iq id="vkddR8gwrYX9pV5odGHv8u9" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <iq id="vkddR8gwrYX9pV5odGHv8u9" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2022-09-18 23:08:04 |  >> <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <presence to="MaM-_gttc5x0283@test-domain.com" from="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence>

2022-09-18 23:08:04 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="vkddR8gwrYX9pV5odGHv8u9" type="result"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2022-09-18 23:08:04 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="vkddR8gwrYX9pV5odGHv8u9" type="result"><auto xmlns="urn:xmpp:archive" save="true"/></iq>

2022-09-18 23:08:06 | [Mutex] received everything.

2022-09-18 23:08:06 | [Mutex] isItemNotified: setArchiveSettings:826e68aa-ee69-48a9-aeef-d60246323958:success :: true

2022-09-18 23:08:06 |  << <iq id="LzUhGAlKN3hJsmZl6DnbN00" type="get"><retrieve xmlns="urn:xmpp:archive" with="MaM-_xjromy0284@test-domain.com"><set xmlns="http://jabber.org/protocol/rsm"/></retrieve></iq>

2022-09-18 23:08:06 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 >> <iq id="LzUhGAlKN3hJsmZl6DnbN00" type="get"><retrieve xmlns="urn:xmpp:archive" with="MaM-_xjromy0284@test-domain.com"><set xmlns="http://jabber.org/protocol/rsm"/></retrieve></iq>

2022-09-18 23:08:06 | [Mutex] waiting for: [1:9730c3d2-b28c-46f8-9d3e-4f293d68414b:826e68aa-ee69-48a9-aeef-d60246323958:retriveCollection:received, 1:9730c3d2-b28c-46f8-9d3e-4f293d68414b:826e68aa-ee69-48a9-aeef-d60246323958:retriveCollection:count:0]

2022-09-18 23:08:06 |  >> <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="LzUhGAlKN3hJsmZl6DnbN00" type="result"><chat with="MaM-_xjromy0284@test-domain.com" xmlns="urn:xmpp:archive"/></iq>

2022-09-18 23:08:06 | MaM- :: MaM-_gttc5x0283@test-domain.com/228467168-tigase-289 << <iq to="MaM-_gttc5x0283@test-domain.com/228467168-tigase-289" xmlns="jabber:client" id="LzUhGAlKN3hJsmZl6DnbN00" type="result"><chat with="MaM-_xjromy0284@test-domain.com" xmlns="urn:xmpp:archive"/></iq>

2022-09-18 23:08:06 | [Mutex] waiting for: [1:9730c3d2-b28c-46f8-9d3e-4f293d68414b:826e68aa-ee69-48a9-aeef-d60246323958:retriveCollection:received, 1:9730c3d2-b28c-46f8-9d3e-4f293d68414b:826e68aa-ee69-48a9-aeef-d60246323958:retriveCollection:count:0]

2022-09-18 23:08:06 | [Mutex] received everything.

2022-09-18 23:08:06 | [Mutex] isItemNotified: 1:9730c3d2-b28c-46f8-9d3e-4f293d68414b:826e68aa-ee69-48a9-aeef-d60246323958:retriveCollection:count:0 :: true

2022-09-18 23:08:06 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=3686] Connector  state changed: connected->disconnected

2022-09-18 23:08:06 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=581 thread=3686] Stream terminated

2022-09-18 23:08:06 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-18 23:08:06 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted