SpectrumIM / spectrum2

Spectrum 2 IM transports
https://spectrum.im
409 stars 90 forks source link

after some uptime spectrum2 loses 95% of my buddies from an ICQ gateway. #114

Closed drook closed 2 years ago

drook commented 8 years ago

Server: openfire 3.9.3 Spectrum: 2.0.2, gateway mode IM client: psi 0.15

after some uptime spectrum2 loses 95% of my buddies from an ICQ gateway, attached with libpurple. It doesn't show them at all, neither offline nor online. Some contacts, however, are shown.

Missing buddies, however, are shown in logs, and according to logs, their status is updating.

jankaluza commented 8 years ago

Grep one of those buddies from the spectrum2.log and send the output here.

drook commented 8 years ago

Around 11:45 12:05 buddy Stormik was not showing in roster neither offline nor online.

Backend log:

# grep Stormik backend-1.log 
43072: 2016-02-23 05:38:15,791 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK
51415: 2016-02-29 11:51:12,105 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK
51415: 2016-02-29 11:54:28,248 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK
51415: 2016-02-29 12:00:05,146 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK
51415: 2016-02-29 12:05:37,035 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK
51415: 2016-02-29 12:05:51,212 INFO  backend: Buddy updated emz@jabber.norma.perm.ru 222337778 Stormik group (1)=ISP - KTK

Spectrum2 log:

2016-02-29 11:51:05,525 INFO  RosterManager: emz@jabber.norma.perm.ru: Adding cached buddy 222337778 fom database
2016-02-29 11:51:12,450 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>xa</show><x xmlns="vcard-temp:x:update"><photo></photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 11:54:28,272 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>away</show><x xmlns="vcard-temp:x:update"><photo></photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 11:54:28,272 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>away</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:00:05,164 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>xa</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:00:22,451 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru/sparkweb"><show>xa</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:05:37,137 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>away</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:05:51,213 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>dnd</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:06:29,829 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru/sparkweb" type="unavailable"><show>dnd</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:08:21,284 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>away</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:08:22,727 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>xa</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:13:33,745 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>away</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:14:14,687 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru/Psi" type="unavailable"><show>away</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:14:45,267 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru"><show>xa</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:15:58,703 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru" type="unavailable"><show>xa</show><x xmlns="vcard-temp:x:update"><photo>bbd7a08942b6bd47fa04e8828dbce0107498d68c</photo></x><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:17:12,157 INFO  Component.RAW: RAW DATA OUT <presence from="222337778@icq.jabber.norma.perm.ru/bot" to="emz@jabber.norma.perm.ru" type="unavailable"><c hash="sha-1" node="spectrum" ver="rNsVpGbRAZekSq8TAH6ztRKy09s=" xmlns="http://jabber.org/protocol/caps"/></presence>
2016-02-29 12:17:12,158 INFO  RosterManager: emz@jabber.norma.perm.ru: Adding cached buddy 222337778 fom database
jankaluza commented 8 years ago

Does it happen also in different Jabber client than the one you are using currently?

drook commented 8 years ago

I'm using one client most of the time (psi, on different OSes and machines). Can try another and report. Does it count if I reproduced (already) this issue in Sparkweb around the same time, simultaneously with psi (sparkweb is, however, way old, but it also didn't show any of the missing buddies) ?

drook commented 8 years ago

As a workaround I'm doing the following procedure: I'm stopping spectrum2 (by itself the restart doesn't help), then I start the old Kraken gateway, log onto it (kraken and spectrum2 are using the same service name), my buddies appear, then I stop the kraken gateway and start the spectrum2 back. After that I'm able to use it like for 7-10 days.

jankaluza commented 8 years ago

Hm, could you try running Pidgin on your computer with that ICQ account connected (and XMPP transport disconnected) for some time to try reproducing that issues with plain pidgin?

But it is really strange, because Spectrum 2 sends presences from that contact, I cannot see how it could disappear in both clients...

drook commented 8 years ago

Okay, will try and report.

TomTheDragon commented 8 years ago

I think this is a problem of the libpurple ICQ plugin, because the same thing happened to me on Pidgin some months ago, as i switched from an other client (Trillian) over.

drook commented 8 years ago

I'm running pidgin to prove this, but so far my uptime was compromised by the power outage. So far the issue wasn't reproduced.

drook commented 8 years ago

I was using the pidgin since my last message here, and I wasn't able to reproduce the issue with it.

drook commented 8 years ago

So. I'm still running the pidgin and I have never seen this issue with it. In the same time this issue always reproduces after some time on spectrum2. The resolving is stil working: stop spectrum2, start kreken, then stop kraken, start spectrum2.

drook commented 8 years ago

And the thing is - I lke spectrum2 more, not to mention that kraken is discontinued. Spectrum2 show ICQ buddies in all of my connected XMPP clients, and Kraken only on one (that connected first).