When running ExampleJaxmppTest.SimpleLoginTest, the test account cannot be removed with timeout

[bwangel]

But this test results Success.
tigase server version is 8.1.0, directly running in idea IDE. works correctly.
tigase-tts-ng version is almost the last SNAPSHOT.

the last output lines :

2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.processSuccess: Authenticated
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus << <features xmlns="https://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="https://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="https://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 node="https://tigase.net/tigase-xmpp-server" xmlns="https://jabber.org/protocol/caps" ver="xj+zgrXefWpDvz0ASruxm5WX7Tw=" hash="SHA-1"/></features>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus >> <iq xmlns="jabber:client" id="PsRat6HulTUcTaDBwqWjP5f" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus << <iq xmlns="jabber:client" type="result" to="test_user_3gvitq0001@wangjx-asus/35274740-tigase-8" id="PsRat6HulTUcTaDBwqWjP5f"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>test_user_3gvitq0001@wangjx-asus/35274740-tigase-8</jid></bind></iq>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.ResponseManager$1.process: Request id=PsRat6HulTUcTaDBwqWjP5f; Result received.
2020-07-31 18:14:41 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 >> <iq xmlns="jabber:client" id="GzakMKNDteDsmRSfAxhGKZm" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 << <iq xmlns="jabber:client" type="result" to="test_user_3gvitq0001@wangjx-asus/35274740-tigase-8" id="GzakMKNDteDsmRSfAxhGKZm"/>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.ResponseManager$1.process: Request id=GzakMKNDteDsmRSfAxhGKZm; Result received.
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 >> <iq to="wangjx-asus" id="fls7wdCGvaPKRVYk9GFFEGs" type="get"><query xmlns="https://jabber.org/protocol/disco#info"/></iq>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 << <iq xmlns="jabber:client" type="result" to="test_user_3gvitq0001@wangjx-asus/35274740-tigase-8" id="fls7wdCGvaPKRVYk9GFFEGs" from="wangjx-asus"><query xmlns="https://jabber.org/protocol/disco#info"><identity name="Tigase ver. 0.0.0" type="router" category="component"/><identity name="Tigase ver. 0.0.0" type="im" category="server"/><feature var="https://jabber.org/protocol/commands"/><feature var="urn:xmpp:carbons:2"/><feature var="https://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="https://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="https://jabber.org/protocol/disco#info"/><feature var="https://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="urn:xmpp:push: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="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="https://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>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 << <enabled xmlns="urn:xmpp:sm:3" resume="true" location="wangjx-asus" id="053cf1bf-e602-45a3-bcc9-087879f10d14" max="60"/>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 >> <iq id="JvU7hLONM09spUbzgUj0jXe" type="get"><query xmlns="jabber:iq:roster"/></iq>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.ResponseManager$1.process: Request id=fls7wdCGvaPKRVYk9GFFEGs; Result received.
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 << <iq xmlns="jabber:client" type="result" to="test_user_3gvitq0001@wangjx-asus/35274740-tigase-8" id="JvU7hLONM09spUbzgUj0jXe"><query xmlns="jabber:iq:roster"/></iq>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.processStreamManagementEnabled: Stream management is enabled. id=053cf1bf-e602-45a3-bcc9-087879f10d14; resume=true
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.ResponseManager$1.process: Request id=JvU7hLONM09spUbzgUj0jXe; Result received.
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 >> <presence><c xmlns="https://jabber.org/protocol/caps" node="https://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>
2020-07-31 18:14:41 | test_user :: test_user_3gvitq0001@wangjx-asus/35274740-tigase-8 << <presence xmlns="jabber:client" to="test_user_3gvitq0001@wangjx-asus" from="test_user_3gvitq0001@wangjx-asus/35274740-tigase-8"><c node="https://tigase.org/jaxmpp" xmlns="https://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>
2020-07-31 18:14:41 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule.process: Presence online from test_user_3gvitq0001@wangjx-asus/35274740-tigase-8


tearing down method tigase.tests.ExampleJaxmppTest.SimpleLoginTest()
2020-07-31 18:14:41 | Remove account as admin: test_user_3gvitq0001@wangjx-asus
2020-07-31 18:14:41 | admin :: admin@wangjx-asus/35274740-tigase-6 >> <iq to="sess-man@wangjx-asus" id="eDgzlY7qiJCJyt9qeXiT7yu" type="set"><command xmlns="https://jabber.org/protocol/commands" node="https://jabber.org/protocol/admin#delete-user" action="execute"><x xmlns="jabber:x:data" type="submit"><field type="hidden" var="FORM_TYPE"><value>https://jabber.org/protocol/admin</value></field><field type="jid-multi" var="accountjids"><value>test_user_3gvitq0001@wangjx-asus</value></field></x></command></iq>
2020-07-31 18:14:41 | [Mutex] waiting for: [account:removed]
2020-07-31 18:14:56 | [Mutex] timeout. Not received [account:removed]


tearing down class tigase.tests.ExampleJaxmppTest = tigase.tests.ExampleJaxmppTest@383bfa16

thanks for all of your works.

[woj-tek]

Have you modified the tests in any way? It seems so as originally it uses admin account.

Nevertheless - account removal is not part of the test itself so failure to remove the account won't trigger failure of the test (we don't test it here). Have you checked your server logs for why IQ stanza with the id eDgzlY7qiJCJyt9qeXiT7yu was not routed back to the client (jaxmpp running for tts-ng)?