List Info

Thread: "connection to router closed" problem
"connection to router closed" problem
user name
 2006-12-18 04:39:17 

  


  

    
Hi, this is Jun Lee from south korea
[problem]
suddenly, sm disconnecting to router(sm.c ioctl() nread == 0).
after 2 seconds(as c2s.xml router.delay), c2s disconneting all client
sessions.
and this procedure repeated 3 more times(router.retry)
finally all jabebrd processes are shutting down.
(client session count is from 250 to 400)


[question]
1. why colsed connection to router?
2. why occured these chain reaction?


[suggestion]
when I start jabberd w -D option, too many log! too slow!
so, it's needed log level. for example -D0 -D1 -D2 ...


I installed jabberd-2.0s11
and I compiled as fllowing:


im_home=$HOME/im
jabberd2_home=$im_home/src/jabberd-2.0s11
configure 
--enable-debug 
--prefix=$im_home 
--enable-idn 
--disable-ssl --enable-mysql 
--with-mysql=/usr/local/mysql 
--with-extra-include-path=/usr/local/mysql/include:$jabberd2_home/libidn/lib 
--with-extra-library-path=/usr/local/mysql/lib::$jabberd2_home/libidn/lib 
--sysconfdir=$im_home/bin/conf 
--localstatedir=$im_home/bin/var 
--infodir=$im_home/bin/info 
--mandir=$im_home/bin/man 
CC=gcc 
LDFLAGS="-Wl,-Bstatic -lidn -Wl,-Bdynamic -lsocket -lnsl -lm -L/usr/local/mysql/lib -lmysqlclient"



[some sm log messages w/ sm -D option]
Tue Oct 12 09:00:36 2004 pkt.c:98 duplicated packet
Tue Oct 12 09:00:36 2004 pkt.c:343 delivering pkt to router
Tue Oct 12 09:00:36 2004 mm.c:517 dispatching out-router chain
Tue Oct 12 09:00:36 2004 mm.c:526 calling module privacy
Tue Oct 12 09:00:36 2004 user.c:60 returning previously-created userdata
for 1090111000000000 at 160.101.1.61
Tue Oct 12 09:00:36 2004 mm.c:533 out-router chain returning 1
sx (chain.c:106) calling nad write chain
sx (io.c:355) queueing for write: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0' from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1100225000000000 at 160.101.1.61'
from='1090111000000000 at 160.101.1.61/enRiseME'><x xmlns='jabber:delay'
from='1090111000000000 at 160.101.1.61/enRiseME' 
stamp='20041011T23:53:54'/>&lt;status&gt;Online<;/status>;<priority>8</priority&gt;</presence><;/route>
sx (io.c:378) tag 5 event 1 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:46 want write
Tue Oct 12 09:00:36 2004 sm.c:234 write action on fd 5
sx (io.c:279) 5 ready for writing
sx (io.c:237) encoding 378 bytes for writing: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0' from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1100225000000000 at 160.101.1.61'
from='1090111000000000 at 160.101.1.61/enRiseME'><x xmlns='jabber:delay'
from='1090111000000000 at 160.101.1.61/enRiseME'>
stamp='20041011T23:53:54'/&gt;<status>Online</status><priority>8</priority></presence>;</route>
sx (chain.c:79) calling io write chain
sx (io.c:298) handing app 378 bytes to write
sx (io.c:299) tag 5 event 3 data 0x430a858
Tue Oct 12 09:00:36 2004 sm.c:83 writing to 5
Tue Oct 12 09:00:36 2004 sm.c:87 378 bytes written
sx (io.c:332) tag 5 event 0 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:41 want read
sx (io.c:380) tag 5 event 0 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:41 want read
Tue Oct 12 09:00:36 2004 pkt.c:292 freeing pkt
Tue Oct 12 09:00:36 2004 pkt.c:292 freeing pkt
Tue Oct 12 09:00:36 2004 mm.c:452 in-sess chain returning 0
Tue Oct 12 09:00:36 2004 mm.c:479 in-router chain returning 0
Tue Oct 12 09:00:36 2004 sm.c:223 read action on fd 5
sx (io.c:447) 5 state change from 4 to 6
sx (io.c:448) tag 5 event 7 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:238 close action on fd 5
Tue Oct 12 09:00:36 2004 [notice] connection to router closed
Tue Oct 12 09:00:36 2004 [notice] attempting reconnect (2 left)
Tue Oct 12 09:00:38 2004 [notice] attempting connection to router at
127.0.0.1, port=5347 :


Tue Oct 12 09:00:36 2004 pkt.c:98 duplicated packet
Tue Oct 12 09:00:36 2004 pkt.c:343 delivering pkt to router
Tue Oct 12 09:00:36 2004 mm.c:517 dispatching out-router chain
Tue Oct 12 09:00:36 2004 mm.c:526 calling module privacy
Tue Oct 12 09:00:36 2004 user.c:60 returning previously-created userdata
for 1090111000000000 at 160.101.1.61
Tue Oct 12 09:00:36 2004 mm.c:533 out-router chain returning 1
sx (chain.c:106) calling nad write chain
sx (io.c:355) queueing for write: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0'> from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1100225000000000 at 160.101.1.61'
from='1090111000000000 at 160.101.1.61/enRiseME'><x xmlns='jabber:delay'
from='1090111000000000 at 160.101.1.61/enRiseME'>
stamp='20041011T23:53:54'/&gt;<status>Online</status><priority>8</priority></presence>;</route>
sx (io.c:378) tag 5 event 1 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:46 want write
Tue Oct 12 09:00:36 2004 sm.c:234 write action on fd 5
sx (io.c:279) 5 ready for writing
sx (io.c:237) encoding 378 bytes for writing: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0'> from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1100225000000000 at 160.101.1.61'
from='1090111000000000 at 160.101.1.61/enRiseME'><x xmlns='jabber:delay'
from='1090111000000000 at 160.101.1.61/enRiseME'>
stamp='20041011T23:53:54'/&gt;<status>Online</status><priority>8</priority></presence>;</route>
sx (chain.c:79) calling io write chain
sx (io.c:298) handing app 378 bytes to write
sx (io.c:299) tag 5 event 3 data 0x430a858
Tue Oct 12 09:00:36 2004 sm.c:83 writing to 5
Tue Oct 12 09:00:36 2004 sm.c:87 378 bytes written
sx (io.c:332) tag 5 event 0 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:41 want read
sx (io.c:380) tag 5 event 0 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:41 want read
Tue Oct 12 09:00:36 2004 pkt.c:292 freeing pkt
Tue Oct 12 09:00:36 2004 pkt.c:292 freeing pkt
Tue Oct 12 09:00:36 2004 mm.c:452 in-sess chain returning 0
Tue Oct 12 09:00:36 2004 mm.c:479 in-router chain returning 0
Tue Oct 12 09:00:36 2004 sm.c:223 read action on fd 5
sx (io.c:447) 5 state change from 4 to 6
sx (io.c:448) tag 5 event 7 data 0x0
Tue Oct 12 09:00:36 2004 sm.c:238 close action on fd 5
Tue Oct 12 09:00:36 2004 [notice] connection to router closed
Tue Oct 12 09:00:36 2004 [notice] attempting reconnect (2 left)
Tue Oct 12 09:00:38 2004 [notice] attempting connection to router at
127.0.0.1, port=5347:
sx (io.c:279) 5 ready for writing
sx (io.c:237) encoding 243 bytes for writing: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0'> from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1092148000000000 at 160.101.1.61'
from='1094068000000000 at 160.101.1.61/enRiseME'
type='unavailable'/&gt;</route>
sx (chain.c:79) calling io write chain
sx (io.c:298) handing app 243 bytes to write
sx (io.c:299) tag 5 event 3 data 0x2241d08
Tue Oct 12 09:11:52 2004 sm.c:83 writing to 5
Tue Oct 12 09:11:52 2004 sm.c:87 243 bytes written
sx (io.c:332) tag 5 event 0 data 0x0
Tue Oct 12 09:11:52 2004 sm.c:41 want read
sx (io.c:380) tag 5 event 0 data 0x0
Tue Oct 12 09:11:52 2004 sm.c:41 want read
Tue Oct 12 09:11:52 2004 pkt.c:292 freeing pkt
Tue Oct 12 09:11:52 2004 pres.c:151 forwarding unavailable to
1095203000000000 at 160.101.1.61
Tue Oct 12 09:11:52 2004 pkt.c:98 duplicated packet
Tue Oct 12 09:11:52 2004 pkt.c:343 delivering pkt to router
Tue Oct 12 09:11:52 2004 mm.c:517 dispatching out-router chain
Tue Oct 12 09:11:52 2004 mm.c:526 calling module privacy
Tue Oct 12 09:11:52 2004 user.c:60 returning previously-created user data
for 1094068000000000 at 160.101.1.61
Tue Oct 12 09:11:52 2004 mm.c:533 out-router chain returning 1
sx (chain.c:106) calling nad write chain
sx (io.c:355) queueing for write: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0'> from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1095203000000000 at 160.101.1.61'
from='1094068000000000 at 160.101.1.61/enRiseME'
type='unavailable'/&gt;</route>
sx (io.c:378) tag 5 event 1 data 0x0
Tue Oct 12 09:11:52 2004 sm.c:46 want write
Tue Oct 12 09:11:52 2004 sm.c:234 write action on fd 5
sx (io.c:279) 5 ready for writing
sx (io.c:237) encoding 243 bytes for writing: <route
xmlns='http://jabberd.jabberstudio.org/ns/component/1.0'> from='160.101.1.61'
to='160.101.1.61'>&lt;presence xmlns='jabber:client'
to='1095203000000000 at 160.101.1.61'
from='1094068000000000 at 160.101.1.61/enRiseME'
type='unavailable'/&gt;</route>
sx (chain.c:79) calling io write chain
sx (io.c:298) handing app 243 bytes to write
sx (io.c:299) tag 5 event 3 data 0x2241d08
Tue Oct 12 09:11:52 2004 sm.c:83 writing to 5
Tue Oct 12 09:11:52 2004 [notice] [5] [router] write error: Broken pipe> (32)
sx (io.c:447) 5 state change from 4 to 6
sx (io.c:448) tag 5 event 7 data 0x0
Tue Oct 12 09:11:52 2004 sm.c:238 close action on fd 5
Tue Oct 12 09:11:52 2004 [notice] connection to router closed

  

  
  
   
     
    

  

    "connection to router closed"
problem
  


  

     user name

     2006-12-18 16:49:17
  


  

    
Dnia 18-12-2006, pon o godzinie 13:39 +0900, 이준
napisał(a):
> suddenly, sm disconnecting to router(sm.c ioctl() nread
== 0).
> 1. why colsed connection to router?

Please see router log for the reason it is disconnecting sm.


> 2. why occured these chain reaction?

When sm does not reconnect to router in time, c2s is
informed that this
host is gone and this causes disconnection of all clients of
the host
handled by the disconnected sm.


-- 
Tomasz Sterna
Xiaoka Grp.  http://www.xiaoka.com/

_______________________________________________
jabberd mailing list
jabberdjabberstudio.org
http:
//mail.jabber.org/mailman/listinfo/jabberd


  


  

    
  

  
  
   
     
    






 [1-2]











   
 





about | contact  Other archives ( Real Estate discussion Medical topics )