Test duration: 17.669s
Passed Tests | ||
---|---|---|
tigase.tests.archive.TestMessageArchive | ||
testChangeArchiveSettings | 2.807s |
2020-08-03 00:07:25 |
2020-08-03 00:07:25 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive] 2020-08-03 00:07:25 | ------------------------------------ 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=552 thread=1] Connector state changed: connected->disconnecting 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=552 thread=1] Terminating XMPP Stream 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:25 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-08-03 00:07:25 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-08-03 00:07:25 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] Connector state changed: null->connecting 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] DNS entry stored in session object: localhost:5222 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] Preparing connection to [localhost:5222] 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] Connector state changed: connecting->connected 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=1] Whitespace ping period is setted to nullms 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=3525] Proceeding TLS 2020-08-03 00:07:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=3525] Start handshake 2020-08-03 00:07:28 | [Mutex] received everything. 2020-08-03 00:07:28 | [Mutex] isItemNotified: setArchiveSettings:8865daf8-8f31-441e-9380-99204839adc3:success :: true 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=3525] Connector state changed: connected->disconnected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=555 thread=3525] Stream terminated 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testMessageArchiving | 10.075s |
2020-08-03 00:07:28 |
2020-08-03 00:07:28 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive] 2020-08-03 00:07:28 | ------------------------------------ 2020-08-03 00:07:28 | [Mutex] waiting for: [msg:edwsq20277] 2020-08-03 00:07:28 | [Mutex] received everything. 2020-08-03 00:07:28 | [Mutex] isItemNotified: msg:edwsq20277 :: true 2020-08-03 00:07:29 | [Mutex] waiting for: [msg:vouvco0279] 2020-08-03 00:07:29 | [Mutex] received everything. 2020-08-03 00:07:29 | [Mutex] isItemNotified: msg:vouvco0279 :: true 2020-08-03 00:07:30 | [Mutex] waiting for: [msg:v7bxh70281] 2020-08-03 00:07:30 | [Mutex] received everything. 2020-08-03 00:07:30 | [Mutex] isItemNotified: msg:v7bxh70281 :: true 2020-08-03 00:07:31 | [Mutex] waiting for: [msg:1mxkzp0283] 2020-08-03 00:07:31 | [Mutex] received everything. 2020-08-03 00:07:31 | [Mutex] isItemNotified: msg:1mxkzp0283 :: true 2020-08-03 00:07:32 | [Mutex] waiting for: [msg:n3g56x0285] 2020-08-03 00:07:32 | [Mutex] received everything. 2020-08-03 00:07:32 | [Mutex] isItemNotified: msg:n3g56x0285 :: true 2020-08-03 00:07:33 | [Mutex] waiting for: [msg:qoakir0287] 2020-08-03 00:07:33 | [Mutex] received everything. 2020-08-03 00:07:33 | [Mutex] isItemNotified: msg:qoakir0287 :: true 2020-08-03 00:07:34 | [Mutex] waiting for: [msg:v3tqzz0289] 2020-08-03 00:07:34 | [Mutex] received everything. 2020-08-03 00:07:34 | [Mutex] isItemNotified: msg:v3tqzz0289 :: true 2020-08-03 00:07:35 | [Mutex] waiting for: [msg:84qrdi0291] 2020-08-03 00:07:35 | [Mutex] received everything. 2020-08-03 00:07:35 | [Mutex] isItemNotified: msg:84qrdi0291 :: true 2020-08-03 00:07:36 | [Mutex] waiting for: [msg:hlvnxv0293] 2020-08-03 00:07:36 | [Mutex] received everything. 2020-08-03 00:07:36 | [Mutex] isItemNotified: msg:hlvnxv0293 :: true 2020-08-03 00:07:37 | [Mutex] waiting for: [msg:m8puri0295] 2020-08-03 00:07:37 | [Mutex] received everything. 2020-08-03 00:07:37 | [Mutex] isItemNotified: msg:m8puri0295 :: true |
testMesssageRetrivalJidComparison | 0.020s |
2020-08-03 00:07:38 |
2020-08-03 00:07:38 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive] 2020-08-03 00:07:38 | ------------------------------------ 2020-08-03 00:07:38 | [Mutex] waiting for: [2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received, 1:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received] 2020-08-03 00:07:38 | [Mutex] waiting for: [2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received, 1:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received] 2020-08-03 00:07:38 | [Mutex] waiting for: [2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received, 1:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received] 2020-08-03 00:07:38 | [Mutex] received everything. 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:lx89io0276 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:e36040278 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:tec8hf0280 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:vx0q3u0282 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:hzflxx0284 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:44ksle0286 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:6wy0gx0288 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:qpefz50290 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:lzkf0o0292 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:3dd7097d-691f-4a43-add1-2c37c6acd608:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:seaiox0294 :: true |
testMesssageRetrivalSuccess | 0.020s |
2020-08-03 00:07:38 |
2020-08-03 00:07:38 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive] 2020-08-03 00:07:38 | ------------------------------------ 2020-08-03 00:07:38 | [Mutex] waiting for: [2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received, 1:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received] 2020-08-03 00:07:38 | [Mutex] waiting for: [2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received, 1:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:received] 2020-08-03 00:07:38 | [Mutex] received everything. 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:lx89io0276 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:e36040278 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:tec8hf0280 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:vx0q3u0282 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:hzflxx0284 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:44ksle0286 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:6wy0gx0288 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:qpefz50290 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:lzkf0o0292 :: true 2020-08-03 00:07:38 | [Mutex] isItemNotified: 2:ad36b662-fdc8-4909-b7e5-ab922fffeb19:8865daf8-8f31-441e-9380-99204839adc3:retriveCollection:success:seaiox0294 :: true |
testRemovalOnUserRemoval | 3.422s |
2020-08-03 00:07:38 |
2020-08-03 00:07:38 | null / [TestClass name=class tigase.tests.archive.TestMessageArchive] 2020-08-03 00:07:38 | ------------------------------------ 2020-08-03 00:07:38 | !!!!!!!!! MaM-_qd8cds0274@test-domain.com 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] Connector state changed: null->connecting 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] DNS entry stored in session object: localhost:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] Preparing connection to [localhost:5222] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] Connector state changed: connecting->connected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=1] Whitespace ping period is setted to nullms 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=3528] Start TLS 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=3530] Proceeding TLS 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=3530] Start handshake 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX3FkOGNkczAyNzQscj0zY1Y2b3EyT21QbG9ZUTRSNFAzdQ==</auth> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zY1Y2b3EyT21QbG9ZUTRSNFAzdU4ySDRtaTg3OHRhWHN5eEgwdHl1LHM9NUtIa1NYOGg5WVovN0E9PSxpPTQwOTY=</challenge> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M2NWNm9xMk9tUGxvWVE0UjRQM3VOMkg0bWk4Nzh0YVhzeXhIMHR5dSxwPVYrUTNPK0V1Y1k1VTRSVFpERWdFOG04eG12blF5dmcyeGVDeVNaWCtoWHc9</response> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oazNpK3VHRkVneHFScXpZOFM4ZU1vNWRTNmJ6SENNNE01TXE3Z0NpM1M0PQ==</success> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="OQKA4xn1/Dd2U5AGL+j0n+zTjNU="/></features> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <iq xmlns="jabber:client" id="Us7KXVY1rgZr6thZ49vbHs7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270" id="Us7KXVY1rgZr6thZ49vbHs7" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270</jid></bind></iq> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 >> <iq xmlns="jabber:client" id="Hve5oQIudRKADzcqWlHw7DE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270" id="Hve5oQIudRKADzcqWlHw7DE" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 >> <iq to="test-domain.com" id="kylzrWUUhzgBBADJGDBDmJF" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <enabled resume="true" id="8ee48826-b9d8-4e2b-9931-b0e8c28c6f29" location="9585556aacac" xmlns="urn:xmpp:sm:3" max="60"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 >> <iq id="tyjrgZr6thZ49vbHs7sYY0f" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <iq from="test-domain.com" to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270" id="kylzrWUUhzgBBADJGDBDmJF" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" category="component" type="router"/><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" 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="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="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> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270" id="tyjrgZr6thZ49vbHs7sYY0f" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | Remove account as admin: MaM-_qd8cds0274@test-domain.com 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-269" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270 << <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-270" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:38 | [Mutex] waiting for: [account:removed] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=3530] Connector state changed: connected->disconnected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=556 thread=3530] Stream terminated 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | [Mutex] received everything. 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2881799b 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Using XEP-0077 mode!!!! 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Connector state changed: null->connecting 2020-08-03 00:07:38 | StateChangedEvent{oldState=null, newState=connecting} 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] DNS entry stored in session object: localhost:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Preparing connection to [localhost:5222] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Connector state changed: connecting->connected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Whitespace ping period is setted to nullms 2020-08-03 00:07:38 | [Mutex] waiting for: [registration] 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@264692fb 2020-08-03 00:07:38 | StateChangedEvent{oldState=connecting, newState=connected} 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@227912eb 2020-08-03 00:07:38 | 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> 2020-08-03 00:07:38 | 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>} 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=3535] Start TLS 2020-08-03 00:07:38 | 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>] 2020-08-03 00:07:38 | MaM- :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:38 | StanzaSendingEvent{stanza=<starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>} 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=3537] Proceeding TLS 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=3537] Start handshake 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@677b98c0 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@44957815 2020-08-03 00:07:38 | 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> 2020-08-03 00:07:38 | 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>} 2020-08-03 00:07:38 | 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>] 2020-08-03 00:07:38 | MaM- :: null >> <iq to="test-domain.com" id="wYvT0hTdw3jNVU1gAcs9Ju4" type="get"><query xmlns="jabber:iq:register"/></iq> 2020-08-03 00:07:38 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="wYvT0hTdw3jNVU1gAcs9Ju4" type="get"><query xmlns="jabber:iq:register"/></iq>} 2020-08-03 00:07:38 | MaM- :: null << <iq from="test-domain.com" id="wYvT0hTdw3jNVU1gAcs9Ju4" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. 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>Choose a user name and password for use with this service. 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 var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq> 2020-08-03 00:07:38 | StanzaReceivedEvent{stanza=<iq from="test-domain.com" id="wYvT0hTdw3jNVU1gAcs9Ju4" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service. 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>Choose a user name and password for use with this service. 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 var="username" type="text-single" label="Username"><required/><value/></field><field var="password" type="text-private" label="Password"><required/><value/></field><field var="email" type="text-single" label="Email (MUST BE VALID!)"><required/><value/></field></x></query></iq>} 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5656fb36 2020-08-03 00:07:38 | MaM- :: null >> <iq to="test-domain.com" id="hLQx6i3pSMELxctl4BFyn5B" type="set"><query xmlns="jabber:iq:register"><username>MaM-_qd8cds0274</username><password>MaM-_qd8cds0274</password><email>dbadd290-ec20-4e47-9445-ac5b6d30c0e6@localhost</email></query></iq> 2020-08-03 00:07:38 | StanzaSendingEvent{stanza=<iq to="test-domain.com" id="hLQx6i3pSMELxctl4BFyn5B" type="set"><query xmlns="jabber:iq:register"><username>MaM-_qd8cds0274</username><password>MaM-_qd8cds0274</password><email>dbadd290-ec20-4e47-9445-ac5b6d30c0e6@localhost</email></query></iq>} 2020-08-03 00:07:38 | MaM- :: null << <iq from="test-domain.com" id="hLQx6i3pSMELxctl4BFyn5B" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:38 | StanzaReceivedEvent{stanza=<iq from="test-domain.com" id="hLQx6i3pSMELxctl4BFyn5B" xmlns="jabber:client" type="result"/>} 2020-08-03 00:07:38 | [Mutex] received everything. 2020-08-03 00:07:38 | [Mutex] isItemNotified: registrationSuccess :: true 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Connector state changed: connected->disconnecting 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=1] Terminating XMPP Stream 2020-08-03 00:07:38 | StateChangedEvent{oldState=connected, newState=disconnecting} 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=3537] Connector state changed: disconnecting->disconnected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=557 thread=3537] Stream terminated 2020-08-03 00:07:38 | StateChangedEvent{oldState=disconnecting, newState=disconnected} 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3c52455d 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@754678f 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@686ef2a0 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Connector state changed: null->connecting 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@9802bd0 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2756ef10 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] DNS entry stored in session object: localhost:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Preparing connection to [localhost:5222] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Connector state changed: connecting->connected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Whitespace ping period is setted to nullms 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | >> <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> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=3542] Start TLS 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=3544] Proceeding TLS 2020-08-03 00:07:38 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=3544] Start handshake 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | >> <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> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-08-03 00:07:38 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX3FkOGNkczAyNzQscj1kcUhlU3BBWG5BUWZyeWpMakRnQQ==</auth> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX3FkOGNkczAyNzQscj1kcUhlU3BBWG5BUWZyeWpMakRnQQ==</auth> 2020-08-03 00:07:38 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kcUhlU3BBWG5BUWZyeWpMakRnQVd5RU1oem9hdjZiT3htclFwRFI3LHM9Y3l2Q0s3SmluRVVCbHc9PSxpPTQwOTY=</challenge> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kcUhlU3BBWG5BUWZyeWpMakRnQVd5RU1oem9hdjZiT3htclFwRFI3LHM9Y3l2Q0s3SmluRVVCbHc9PSxpPTQwOTY=</challenge> 2020-08-03 00:07:38 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHFIZVNwQVhuQVFmcnlqTGpEZ0FXeUVNaHpvYXY2Yk94bXJRcERSNyxwPWpuRFA4bVIxMWZkTzhZYThFdlpaRnlEOVVNNnNyNnlmQkowN0tBdWFDVjA9</response> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHFIZVNwQVhuQVFmcnlqTGpEZ0FXeUVNaHpvYXY2Yk94bXJRcERSNyxwPWpuRFA4bVIxMWZkTzhZYThFdlpaRnlEOVVNNnNyNnlmQkowN0tBdWFDVjA9</response> 2020-08-03 00:07:38 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VbHN4M1ZWRGkrbVBnd0NZYldlK0pJT2ZhTUlGTXZtcU9HYnV6b3ljRXZ3PQ==</success> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VbHN4M1ZWRGkrbVBnd0NZYldlK0pJT2ZhTUlGTXZtcU9HYnV6b3ljRXZ3PQ==</success> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:38 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="OQKA4xn1/Dd2U5AGL+j0n+zTjNU="/></features> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="OQKA4xn1/Dd2U5AGL+j0n+zTjNU="/></features> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2020-08-03 00:07:38 | << <iq xmlns="jabber:client" id="3OXFLCfHzt0dEmKyl7gCHHs" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <iq xmlns="jabber:client" id="3OXFLCfHzt0dEmKyl7gCHHs" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-08-03 00:07:38 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="3OXFLCfHzt0dEmKyl7gCHHs" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271</jid></bind></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="3OXFLCfHzt0dEmKyl7gCHHs" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271</jid></bind></iq> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-08-03 00:07:38 | << <iq xmlns="jabber:client" id="3PYHPKvdBx8taoOGBDiGPXY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 >> <iq xmlns="jabber:client" id="3PYHPKvdBx8taoOGBDiGPXY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-08-03 00:07:38 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="3PYHPKvdBx8taoOGBDiGPXY" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="3PYHPKvdBx8taoOGBDiGPXY" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-08-03 00:07:38 | << <iq to="test-domain.com" id="50tsV3hTQT04ao1tY2xnOEo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 >> <iq to="test-domain.com" id="50tsV3hTQT04ao1tY2xnOEo" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-08-03 00:07:38 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-08-03 00:07:38 | >> <enabled resume="true" id="d9c8b57c-1e2b-41e5-8219-f7adc0d76cf9" location="9585556aacac" xmlns="urn:xmpp:sm:3" max="60"/> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 << <enabled resume="true" id="d9c8b57c-1e2b-41e5-8219-f7adc0d76cf9" location="9585556aacac" xmlns="urn:xmpp:sm:3" max="60"/> 2020-08-03 00:07:38 | << <iq id="hPUFmO5t02aNBkJR6FNOT7F" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 >> <iq id="hPUFmO5t02aNBkJR6FNOT7F" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | >> <iq from="test-domain.com" to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="50tsV3hTQT04ao1tY2xnOEo" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" category="component" type="router"/><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" 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="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="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> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 << <iq from="test-domain.com" to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="50tsV3hTQT04ao1tY2xnOEo" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" category="component" type="router"/><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" 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="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="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> 2020-08-03 00:07:38 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-08-03 00:07:38 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="hPUFmO5t02aNBkJR6FNOT7F" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" id="hPUFmO5t02aNBkJR6FNOT7F" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:38 | >> <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:38 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271 << <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-271" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Connector state changed: connected->disconnecting 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=1] Terminating XMPP Stream 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=3544] Connector state changed: disconnecting->disconnected 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=558 thread=3544] Stream terminated 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-08-03 00:07:38 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:38 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] Connector state changed: null->connecting 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] DNS entry stored in session object: localhost:5222 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] Preparing connection to [localhost:5222] 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] Connector state changed: connecting->connected 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=1] Whitespace ping period is setted to nullms 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:39 | >> <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> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=3542] Start TLS 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=3550] Proceeding TLS 2020-08-03 00:07:39 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=3550] Start handshake 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:39 | >> <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> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@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> 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-08-03 00:07:39 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX3FkOGNkczAyNzQscj03Y0F2aElBQURDWnlGdDNrbDJWcg==</auth> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1NYU0tX3FkOGNkczAyNzQscj03Y0F2aElBQURDWnlGdDNrbDJWcg==</auth> 2020-08-03 00:07:39 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03Y0F2aElBQURDWnlGdDNrbDJWclZzYmN1akVRWG9DaVJCMlB2bjZQLHM9Y3l2Q0s3SmluRVVCbHc9PSxpPTQwOTY=</challenge> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03Y0F2aElBQURDWnlGdDNrbDJWclZzYmN1akVRWG9DaVJCMlB2bjZQLHM9Y3l2Q0s3SmluRVVCbHc9PSxpPTQwOTY=</challenge> 2020-08-03 00:07:39 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2NBdmhJQUFEQ1p5RnQza2wyVnJWc2JjdWpFUVhvQ2lSQjJQdm42UCxwPVcrZWFQVldTVm1PQTVzYzIrK1V6RXBIWVNORVpDOXgzRFVha1A1bGVFdXc9</response> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N2NBdmhJQUFEQ1p5RnQza2wyVnJWc2JjdWpFUVhvQ2lSQjJQdm42UCxwPVcrZWFQVldTVm1PQTVzYzIrK1V6RXBIWVNORVpDOXgzRFVha1A1bGVFdXc9</response> 2020-08-03 00:07:39 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1vZVE3bWgyT3BSRklDcThkS0tPUUg1KzdIYkUrWmlqY0FzaXJ5NitwSWZrPQ==</success> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1vZVE3bWgyT3BSRklDcThkS0tPUUg1KzdIYkUrWmlqY0FzaXJ5NitwSWZrPQ==</success> 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-08-03 00:07:39 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="OQKA4xn1/Dd2U5AGL+j0n+zTjNU="/></features> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="OQKA4xn1/Dd2U5AGL+j0n+zTjNU="/></features> 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2020-08-03 00:07:39 | << <iq xmlns="jabber:client" id="zS1N18hLHJwfIu04nboSdJw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com >> <iq xmlns="jabber:client" id="zS1N18hLHJwfIu04nboSdJw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-08-03 00:07:39 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="zS1N18hLHJwfIu04nboSdJw" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272</jid></bind></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="zS1N18hLHJwfIu04nboSdJw" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272</jid></bind></iq> 2020-08-03 00:07:39 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-08-03 00:07:39 | << <iq xmlns="jabber:client" id="MGptnMELPIs0tX29HM1veJN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <iq xmlns="jabber:client" id="MGptnMELPIs0tX29HM1veJN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-08-03 00:07:39 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="MGptnMELPIs0tX29HM1veJN" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="MGptnMELPIs0tX29HM1veJN" xmlns="jabber:client" type="result"/> 2020-08-03 00:07:39 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-08-03 00:07:39 | << <iq to="test-domain.com" id="XEh6hXi3zmZj3cp1dLAnY02" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <iq to="test-domain.com" id="XEh6hXi3zmZj3cp1dLAnY02" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-08-03 00:07:39 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-08-03 00:07:39 | << <iq id="R7E16eyz9qVfSdT0hTdw3jN" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <iq id="R7E16eyz9qVfSdT0hTdw3jN" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:39 | >> <enabled resume="true" id="2021b97f-15cf-41d4-b1c4-fc28c8b3bd1b" location="9585556aacac" xmlns="urn:xmpp:sm:3" max="60"/> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <enabled resume="true" id="2021b97f-15cf-41d4-b1c4-fc28c8b3bd1b" location="9585556aacac" xmlns="urn:xmpp:sm:3" max="60"/> 2020-08-03 00:07:39 | >> <iq from="test-domain.com" to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="XEh6hXi3zmZj3cp1dLAnY02" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" category="component" type="router"/><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" 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="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="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> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <iq from="test-domain.com" to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="XEh6hXi3zmZj3cp1dLAnY02" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" category="component" type="router"/><identity name="Tigase ver. 8.2.0-SNAPSHOT-b10978/ddedac76" 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="text-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="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> 2020-08-03 00:07:39 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-08-03 00:07:39 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="R7E16eyz9qVfSdT0hTdw3jN" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="R7E16eyz9qVfSdT0hTdw3jN" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-08-03 00:07:39 | >> <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <presence from="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" to="MaM-_qd8cds0274@test-domain.com" xmlns="jabber:client"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-08-03 00:07:39 | << <iq id="tKvP2xxiR3xalTXfyjQKw6r" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <iq id="tKvP2xxiR3xalTXfyjQKw6r" type="get"><auto xmlns="urn:xmpp:archive" save="true"/></iq> 2020-08-03 00:07:39 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="tKvP2xxiR3xalTXfyjQKw6r" xmlns="jabber:client" type="result"><auto save="true" xmlns="urn:xmpp:archive"/></iq> 2020-08-03 00:07:39 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="tKvP2xxiR3xalTXfyjQKw6r" xmlns="jabber:client" type="result"><auto save="true" xmlns="urn:xmpp:archive"/></iq> 2020-08-03 00:07:41 | [Mutex] received everything. 2020-08-03 00:07:41 | [Mutex] isItemNotified: setArchiveSettings:d12fc9e6-cd2d-4172-9443-09d0238e22e4:success :: true 2020-08-03 00:07:41 | << <iq id="19G0hTdw3jNVU1gAcs9Ju4B" type="get"><retrieve xmlns="urn:xmpp:archive" with="MaM-_m5o0la0275@test-domain.com"><set xmlns="http://jabber.org/protocol/rsm"/></retrieve></iq> 2020-08-03 00:07:41 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 >> <iq id="19G0hTdw3jNVU1gAcs9Ju4B" type="get"><retrieve xmlns="urn:xmpp:archive" with="MaM-_m5o0la0275@test-domain.com"><set xmlns="http://jabber.org/protocol/rsm"/></retrieve></iq> 2020-08-03 00:07:41 | [Mutex] waiting for: [1:13e2c169-e3f7-4fe7-aca2-e654fa9c78b8:d12fc9e6-cd2d-4172-9443-09d0238e22e4:retriveCollection:count:0, 1:13e2c169-e3f7-4fe7-aca2-e654fa9c78b8:d12fc9e6-cd2d-4172-9443-09d0238e22e4:retriveCollection:received] 2020-08-03 00:07:41 | >> <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="19G0hTdw3jNVU1gAcs9Ju4B" xmlns="jabber:client" type="result"><chat xmlns="urn:xmpp:archive" with="MaM-_m5o0la0275@test-domain.com"/></iq> 2020-08-03 00:07:41 | MaM- :: MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272 << <iq to="MaM-_qd8cds0274@test-domain.com/2095755800-tigase-272" id="19G0hTdw3jNVU1gAcs9Ju4B" xmlns="jabber:client" type="result"><chat xmlns="urn:xmpp:archive" with="MaM-_m5o0la0275@test-domain.com"/></iq> 2020-08-03 00:07:41 | [Mutex] received everything. 2020-08-03 00:07:41 | [Mutex] isItemNotified: 1:13e2c169-e3f7-4fe7-aca2-e654fa9c78b8:d12fc9e6-cd2d-4172-9443-09d0238e22e4:retriveCollection:count:0 :: true 2020-08-03 00:07:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=3550] Connector state changed: connected->disconnected 2020-08-03 00:07:41 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=559 thread=3550] Stream terminated 2020-08-03 00:07:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-08-03 00:07:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |