Avoid reconnecting due to non-aswered ping from previous session
- Gajim git master 62253c80
- python-nbxmpp git master 0aed44470ba
What happened:
- keep alive empty packet sent
- keep alive ping sent
- some stanza received / sent / received ...
-
Error while disconnecting socket: Transport endpoint is not connected
. What is it? Am I missing additional debug flags?
.nbxmpp.smacks=.nbxmpp.client_nb=.nbxmpp.transports_nb=.nbxmpp.idlequeue=gajim.c.connection=gajim.c.resolver=gajim.plugin_system.omemo=gajim.avatar=gajim.vcard=gajim.c.m.archiving=gajim.c.logger=DEBUG
- session successfully resumed (with mismatch)
- stanzas received / sent ...
-
No reply received for keepalive ping. Reconnecting...
I guess this should be avoided. - session successfully resumed
Do pings must be answered, even if instead a useful stanza has been sent?
And I guess ping answers will not be preserved and resent after session resumption(?), thus the corresponding timer should be reset.
12/05/2018 15:44:30 (I) nbxmpp.client_nb raising event from transport: :::::DATA SENT::::
_____________
_____________
12/05/2018 15:44:36 (D) nbxmpp.idlequeue Calling <bound method NonBlockingTransport.read_timeout2 of <nbxmpp.transports_nb.NonBlockingTCP object at 0x7fd5a557e240>> for fd 41
12/05/2018 15:44:36 (I) nbxmpp.transports_nb Plugging fd 41, W:True, R:True
12/05/2018 15:44:36 (I) nbxmpp.idlequeue read timeout set for fd 41 on 120 seconds with function <bound method NonBlockingTransport.read_timeout2 of <nbxmpp.transports_nb.NonBlockingTCP object at 0x7fd5a557e240>>
12/05/2018 15:44:36 (I) nbxmpp.idlequeue read timeout removed for fd 41
12/05/2018 15:44:36 (I) nbxmpp.transports_nb pollout called, state == CONNECTED
12/05/2018 15:44:36 (I) nbxmpp.transports_nb Plugging fd 41, W:False, R:True
12/05/2018 15:44:36 (I) nbxmpp.client_nb raising event from transport: :::::DATA SENT::::
_____________
<iq xmlns="jabber:client" to="MYSERVER" type="get" id="6f21c023-82a8-44bc-aceb-1785ed85bb0d" from="MYNICK@MYSERVER/gajim.P0UTV5AE"><ping xmlns="urn:xmpp:ping" /></iq>
_____________
[... RECEIVED / SENT ...]
12/05/2018 15:44:59 (I) nbxmpp.transports_nb pollin called, state == CONNECTED
12/05/2018 15:44:59 (I) nbxmpp.idlequeue read timeout removed for fd 41
12/05/2018 15:44:59 (I) nbxmpp.idlequeue read timeout set for fd 41 on 115 seconds
12/05/2018 15:44:59 (I) nbxmpp.idlequeue read timeout set for fd 41 on 120 seconds with function <bound method NonBlockingTransport.read_timeout2 of <nbxmpp.transports_nb.NonBlockingTCP object at 0x7fd5a557e240>>
12/05/2018 15:44:59 (I) nbxmpp.client_nb raising event from transport: :::::DATA RECEIVED::::
_____________
<presence xml:lang='de' to='MYNICK@MYSERVER/gajim.P0UTV5AE' from='xmpp@chat.yax.im/Holger' id='320826237869'><c xmlns='http://jabber.org/protocol/caps' ver='uZA8Fl8bDyGEksz+u9VroOY/PXU=' hash='sha-1' node='http://mcabber.com/caps'/><x xmlns='vcard-temp:x:update'><photo>855844af7d25fdf98222b0a7bf26e07d90a4b00d</photo></x><x xmlns='http://jabber.org/protocol/muc#user'><item affiliation='member' role='participant'/></x><status>I'm available</status></presence>
_____________
12/05/2018 15:44:59 (D) nbxmpp.smacks IN, presence
12/05/2018 15:44:59 (I) nbxmpp.idlequeue read timeout removed for fd 41
12/05/2018 15:44:59 (I) nbxmpp.transports_nb pollend called, state == CONNECTED
12/05/2018 15:44:59 (I) nbxmpp.transports_nb Error while disconnecting socket: Transport endpoint is not connected
12/05/2018 15:44:59 (I) nbxmpp.client_nb Disconnecting NBClient:
12/05/2018 15:44:59 (D) nbxmpp.client_nb Client disconnected..
12/05/2018 15:44:59 (D) nbxmpp.client_nb Calling disconnect handler <bound method Connection._on_disconnect of <gajim.common.connection.Connection object at 0x7fd5b7785cc0>>
12/05/2018 15:44:59 (I) gajim.c.connection Disconnect MYSERVER, reconnect: True
12/05/2018 15:44:59 (I) gajim.c.connection Set state disconnected
12/05/2018 15:44:59 (I) gajim.c.connection Reconnect to MYSERVER in 7s
12/05/2018 15:45:06 (I) gajim.c.connection Reconnect
12/05/2018 15:45:06 (I) gajim.c.connection Connect
[...]
12/05/2018 15:45:07 (I) nbxmpp.smacks Session resumption succeeded, session-id: g2gCbQAAAA5nYWppbS5QMFVUVjVBRWgDYgAABgdiAA69aWIAKRbb
12/05/2018 15:45:07 (E) nbxmpp.smacks Mismatch detected, our h: 174, server h: 210, queue: 0
12/05/2018 15:45:07 (I) gajim.c.connection Resume successful
[... RECEIVED / SENT ...]
12/05/2018 15:46:38 (W) gajim.c.m.ping No reply received for keepalive ping. Reconnecting...
12/05/2018 15:46:38 (I) gajim.c.connection Starting to disconnect MYSERVER
12/05/2018 15:46:38 (I) nbxmpp.client_nb Disconnecting NBClient:
12/05/2018 15:46:38 (D) nbxmpp.client_nb Client disconnected..
12/05/2018 15:46:38 (D) nbxmpp.client_nb Calling disconnect handler functools.partial(<bound method Connection._on_disconnect of <gajim.common.connection.Connection object at 0x7fd5b7785cc0>>, True)
12/05/2018 15:46:38 (I) gajim.c.connection Disconnect MYSERVER, reconnect: True
12/05/2018 15:46:38 (I) gajim.c.connection Set state disconnected
12/05/2018 15:46:38 (I) gajim.c.connection Reconnect to MYSERVER in 7s
12/05/2018 15:46:40 (I) nbxmpp.idlequeue read timeout removed for fd 42
12/05/2018 15:46:45 (I) gajim.c.connection Reconnect
12/05/2018 15:46:45 (I) gajim.c.connection Connect
[...]
12/05/2018 15:46:47 (I) nbxmpp.smacks Session resumption succeeded, session-id: g2gCbQAAAA5nYWppbS5QMFVUVjVBRWgDYgAABgdiAA69aWIAKRbb
12/05/2018 15:46:47 (D) nbxmpp.smacks Validate ack, our h: 210, server h: 210, queue: 0
12/05/2018 15:46:47 (D) nbxmpp.smacks removing 0 stanzas from queue
12/05/2018 15:46:47 (I) gajim.c.connection Resume successful