[jadmin] ERROR: sm died
xyon
xyon at indigorobot.com
Tue Nov 20 12:37:57 CST 2007
Try:
mkdir -p /usr/local/jabber2/var/jabberd/pid/
chown jabberd /usr/local/jabber2/var/jabberd/pid/
Renzo Alejandro Clavijo Romero wrote:
> Hi all ...
>
> I got this error when trying to start my jabberd2 sever:
>
> [jabber at priapo bin]$ ./jabberd
> ERROR: sm died. Shutting down server.
>
> When I use ./jabber -D, the log says:
> ROUT: sx (io.c:231) tag 6 event 1 data 0x0
> ERROR: sm died. Shutting down server.
> JBRD: Got a signal... pass it on.
> JBRD: It was a TERM. Shut it all down!
>
> Im running jabberd2 on a MySQL database engine.
>
> The complete log is as follows:
>
> *******************************************************************************************
> JBRD: debug on
> JBRD: version(2.1.18)
> JBRD: config_dir(/usr/local/jabber2/etc)
> JBRD: LaunchJob: router -> /usr/local/jabber2/bin/router -c
> /usr/local/jabber2/etc/router.xml -D
> JBRD: LaunchJob: resolver -> /usr/local/jabber2/bin/resolver -c
> /usr/local/jabber2/etc/resolver.xml -D
> JBRD: LaunchJob: sm -> /usr/local/jabber2/bin/sm -c
> /usr/local/jabber2/etc/sm.xml -D
> JBRD: LaunchJob: s2s -> /usr/local/jabber2/bin/s2s -c
> /usr/local/jabber2/etc/s2s.xml -D
> JBRD: LaunchJob: c2s -> /usr/local/jabber2/bin/c2s -c
> /usr/local/jabber2/etc/c2s.xml -D
> ROUT: Fri Nov 16 16:23:14 2007 [notice] starting up
> RSLV: Fri Nov 16 16:23:14 2007 [notice] starting up
> ROUT: Fri Nov 16 16:23:14 2007 user.c:34 loading user table
> RSLV: sx (sasl_cyrus.c:1041) initialising sasl plugin
> ROUT: Fri Nov 16 16:23:14 2007 [error] couldn't open
> /usr/local/jabber2/var/jabberd/pid/router.pid for writing: No such file
> or directory
> RSLV: Fri Nov 16 16:23:14 2007 [error] couldn't open
> /usr/local/jabber2/var/jabberd/pid/resolver.pid for writing: No such
> file or directory
> ROUT: Fri Nov 16 16:23:14 2007 user.c:89 remembering user 'jabberd'
> SM : Fri Nov 16 16:23:14 2007 [notice] starting up
> RSLV: sx (sasl_cyrus.c:1099) sasl context initialised; appname=xmpp
> SM : Fri Nov 16 16:23:14 2007 storage.c:95 adding arbitrary types to
> driver 'mysql'
> ROUT: Fri Nov 16 16:23:14 2007 [notice] loaded user table (1 users)
> RSLV: Fri Nov 16 16:23:14 2007 [notice] attempting connection to router
> at 127.0.0.1 <http://127.0.0.1>, port=5347
> ROUT: Fri Nov 16 16:23:14 2007 aci.c:37 loading aci
> RSLV: sx (env.c:77) plugin initialised (index 0)
> ROUT: Fri Nov 16 16:23:14 2007 [notice] loaded filters (0 rules)
> RSLV: Fri Nov 16 16:23:14 2007 [notice] connection to router established
> ROUT: Fri Nov 16 16:23:14 2007 aci.c:56 building list for 'all'
> RSLV: sx (sx.c:55) allocated new sx for 5
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [0.0.0.0 <http://0.0.0.0>,
> port=5347] listening for incoming connections
> ROUT: Fri Nov 16 16:23:14 2007 aci.c:78 added 'jabberd'
> SM : Fri Nov 16 16:23:14 2007 [notice] id: priapo.anditel.com.co
> <http://priapo.anditel.com.co>
> RSLV: sx (client.c:122) doing client init for sx 5
> S2S : Fri Nov 16 16:23:14 2007 [notice] starting up (interval=60,
> queue=60, keepalive=0, idle=86400)
> SM : Fri Nov 16 16:23:14 2007 storage.c:118 driver not loaded, trying
> to init
> C2S : Fri Nov 16 16:23:14 2007 [notice] starting up
> S2S : sx (sasl_cyrus.c:1041) initialising sasl plugin
> ROUT: Fri Nov 16 16:23:14 2007 filter.c:51 loading filter
> SM : Fri Nov 16 16:23:14 2007 [error] couldn't open
> /usr/local/jabber2/var/jabberd/pid/sm.pid for writing: No such file or
> directory
> RSLV: sx (client.c:138) stream request: ns (null) to (null) from (null)
> version 1.0
> SM : Fri Nov 16 16:23:14 2007 storage.c:140 preloaded module 'mysql'
> (not initialized yet)
> C2S : Fri Nov 16 16:23:14 2007 [error] couldn't open
> /usr/local/jabber2/var/jabberd/pid/c2s.pid for writing: No such file or
> directory
> C2S : Fri Nov 16 16:23:14 2007 authreg.c:73 preloaded module 'mysql'
> (not initialized yet)
> ROUT: Fri Nov 16 16:23:14 2007 filter.c:96 building filter list
> SM : Fri Nov 16 16:23:14 2007 [info] loading 'mysql' storage module
> RSLV: sx (client.c:168) prepared stream header: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'>
> S2S : Fri Nov 16 16:23:14 2007 [error] couldn't open
> /usr/local/jabber2/var/jabberd/pid/s2s.pid for writing: No such file or
> directory
> SM : Fri Nov 16 16:23:14 2007 storage.c:160 calling driver initializer
> C2S : Fri Nov 16 16:23:14 2007 [notice] modules search path:
> /usr/local/jabber2/lib/jabberd
> S2S : sx (sasl_cyrus.c:1099) sasl context initialised; appname=xmpp
> C2S : Fri Nov 16 16:23:14 2007 authreg_mysql.c:380 SQL to create
> account: INSERT INTO `authreg` ( `username`, `realm` ) VALUES ( '%s',
> '%s' )
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47504] connect
> ROUT: sx (sasl_cyrus.c:1041) initialising sasl plugin
> SM : Fri Nov 16 16:23:14 2007 [notice] initialised storage driver 'mysql'
> RSLV: sx (client.c:175) tag 5 event 1 data 0x0
> S2S : Fri Nov 16 16:23:14 2007 [notice] attempting connection to router
> at 127.0.0.1 <http://127.0.0.1>, port=5347
> SM : Fri Nov 16 16:23:14 2007 aci.c:37 loading aci
> S2S : sx (env.c:77) plugin initialised (index 0)
> C2S : Fri Nov 16 16:23:14 2007 authreg_mysql.c:381 SQL to query user
> information: SELECT `password` FROM `authreg` WHERE `username` = '%s'
> AND `realm` = '%s'
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47504] authenticated as jabberd
> RSLV: Fri Nov 16 16:23:14 2007 [notice] ready to resolve
> ROUT: sx (sasl_cyrus.c:1099) sasl context initialised;
> appname=jabberd-router
> SM : Fri Nov 16 16:23:14 2007 [notice] modules search path:
> /usr/local/jabber2/lib/jabberd
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:138 want write
> SM : Fri Nov 16 16:23:14 2007 aci.c:57 building list for 'all'
> C2S : Fri Nov 16 16:23:14 2007 [info] loading 'mysql' authreg module
> S2S : Fri Nov 16 16:23:14 2007 db.c:56 initialising dialback sx plugin
> C2S : Fri Nov 16 16:23:14 2007 authreg_mysql.c:382 SQL to set password:
> UPDATE `authreg` SET `password` = '%s' WHERE `username` = '%s' AND
> `realm` = '%s'
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [resolver] online (bound to
> 127.0.0.1 <http://127.0.0.1>, port 47504)
> ROUT: sx (env.c:77) plugin initialised (index 0)
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'status' added to chain
> 'sess-start' (order 0 index 0 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:464 write action on fd 5
> S2S : Fri Nov 16 16:23:14 2007 [notice] connection to router established
> SM : Fri Nov 16 16:23:14 2007 aci.c:67 added 'admin at localhost'
> C2S : Fri Nov 16 16:23:14 2007 [notice] initialized auth module 'mysql'
> S2S : sx (env.c:77) plugin initialised (index 1)
> C2S : Fri Nov 16 16:23:14 2007 authreg_mysql.c:383 SQL to delete
> account: DELETE FROM `authreg` WHERE `username` = '%s' AND `realm` = '%s'
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47505] connect
> ROUT: Fri Nov 16 16:23:14 2007 router.c:907 accept action on fd 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'status' added to chain
> 'sess-end' (order 0 index 0 seq 1)
> RSLV: sx (io.c:303) 5 ready for writing
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature iq
> C2S : Fri Nov 16 16:23:14 2007 [notice] [localhost] configured;
> realm=localhost, registration enabled
> S2S : sx (sx.c:55) allocated new sx for 5
> C2S : Fri Nov 16 16:23:14 2007 authreg_mysql.c:401 mysql connecting as
> 'jabberd2' to database 'jabberd2' on localhost:3306
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [ 127.0.0.1 <http://127.0.0.1>,
> port=47506] connect
> ROUT: sx (sx.c:55) allocated new sx for 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-last' added to chain
> 'sess-end' (order 1 index 1 seq 0)
> RSLV: sx (io.c:261) encoding 98 bytes for writing: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'>
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'sess-start'
> C2S : Fri Nov 16 16:23:14 2007 [notice] attempting connection to router
> at 127.0.0.1 <http://127.0.0.1> , port=5347
> S2S : sx (client.c:122) doing client init for sx 5
> C2S : sx (sasl_cyrus.c:1041) initialising sasl plugin
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47505] authenticated as jabberd
> ROUT: sx (server.c:236) doing server init for sx 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'validate' added to chain
> 'in-sess' (order 0 index 2 seq 0)
> RSLV: sx (chain.c:79) calling io write chain
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'status' to
> chain 'sess-start' (not added yet)
> C2S : Fri Nov 16 16:23:14 2007 [notice] connection to router established
> S2S : sx (client.c :138) stream request: ns (null) to (null) from (null)
> version 1.0
> C2S : sx (sasl_cyrus.c:1099) sasl context initialised; appname=xmpp
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [s2s] set as default route
> ROUT: sx (server.c :251) waiting for stream header
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'status' added to chain
> 'in-sess' (order 1 index 0 seq 2)
> RSLV: sx (io.c:324) handing app 98 bytes to write
> S2S : Fri Nov 16 16:23:14 2007 [notice] [ 0.0.0.0 <http://0.0.0.0>,
> port=5269] listening for connections
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'sess-end'
> S2S : sx (client.c:168) prepared stream header: <?xml version='
> 1.0'?><stream:stream xmlns:stream='http://etherx.jabber.org/streams'
> version='1.0'>
> C2S : sx (env.c:77) plugin initialised (index 0)
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [s2s] online (bound to 127.0.0.1
> <http://127.0.0.1>, port 47505)
> ROUT: sx (server.c:254) tag 6 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'privacy' added to chain
> 'in-sess' (order 2 index 3 seq 0)
> RSLV: sx (io.c:325) tag 5 event 3 data 0x8372518
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-last' to
> chain 'sess-end' (not added yet)
> S2S : sx (client.c:175) tag 5 event 1 data 0x0
> C2S : Fri Nov 16 16:23:14 2007 bind.c:70 initialising resource bind sx
> plugin
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47506] authenticated as jabberd
> ROUT: Fri Nov 16 16:23:14 2007 router.c:516 want read
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'roster' added to chain
> 'in-sess' (order 3 index 4 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:175 writing to 5
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:last
> C2S : Fri Nov 16 16:23:14 2007 [notice] [0.0.0.0 <http://0.0.0.0>,
> port=5222] listening for connections
> S2S : Fri Nov 16 16:23:14 2007 router.c:39 want write
> C2S : sx (env.c:77) plugin initialised (index 1)
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [priapo.anditel.com.co
> <http://priapo.anditel.com.co>] online (bound to 127.0.0.1
> <http://127.0.0.1>, port 47506)
> ROUT: Fri Nov 16 16:23:14 2007 main.c:446 running time checks
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'vacation' added to chain
> 'in-sess' (order 4 index 5 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:179 98 bytes written
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain 'in-sess'
> S2S : Fri Nov 16 16:23:14 2007 router.c:301 write action on fd 5
> C2S : sx (sx.c:55) allocated new sx for 6
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47507] connect
> ROUT: Fri Nov 16 16:23:14 2007 main.c:451 next time check at 1195248254
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-vcard' added to chain
> 'in-sess' (order 5 index 6 seq 0)
> RSLV: sx (client.c:103) 5 state change from 0 to 2
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'validate' to
> chain 'in-sess' (not added yet)
> S2S : sx (io.c:303) 5 ready for writing
> C2S : sx (client.c:122) doing client init for sx 6
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47507] authenticated as jabberd
> ROUT: Fri Nov 16 16:23:14 2007 router.c:858 read action on fd 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-ping' added to chain
> 'in-sess' (order 6 index 7 seq 0)
> RSLV: sx (client.c:105) stream header sent, waiting for reply
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'privacy' to
> chain 'in-sess' (not added yet)
> S2S : sx (io.c:261) encoding 98 bytes for writing: <?xml
> version='1.0'?><stream:stream xmlns:stream='
> http://etherx.jabber.org/streams' version='1.0'>
> C2S : sx (client.c:138) stream request: ns (null) to (null) from (null)
> version 1.0
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [ 127.0.0.1 <http://127.0.0.1>,
> port=47507] tried to bind 'priapo.anditel.com.co
> <http://priapo.anditel.com.co>', but it's already bound
> ROUT: sx (io.c:169) 6 ready for reading
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-private' added to
> chain 'in-sess' (order 7 index 8 seq 0)
> RSLV: sx (io.c:358) tag 5 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:privacy
> S2S : sx (chain.c:79) calling io write chain
> C2S : sx (client.c:168) prepared stream header: <?xml version='
> 1.0'?><stream:stream xmlns:stream='http://etherx.jabber.org/streams'
> version='1.0'>
> ROUT: sx (io.c:175) tag 6 event 2 data 0x89256d0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco' added to chain
> 'in-sess' (order 8 index 9 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:133 want read
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> urn:xmpp:blocking
> S2S : sx (io.c:324) handing app 98 bytes to write
> C2S : sx (client.c:175) tag 6 event 1 data 0x0
> ROUT: Fri Nov 16 16:23:14 2007 [notice] [127.0.0.1 <http://127.0.0.1>,
> port=47507] disconnect
> ROUT: Fri Nov 16 16:23:14 2007 router.c:526 reading from 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'amp' added to chain
> 'in-sess' (order 9 index 10 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:460 read action on fd 5
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'roster' to
> chain 'in-sess' (not added yet)
> S2S : sx (io.c:325) tag 5 event 3 data 0x8a18f00
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:663 want write
> ROUT: Fri Nov 16 16:23:14 2007 router.c:584 read 98 bytes
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'offline' added to chain
> 'in-sess' (order 10 index 11 seq 0)
> RSLV: sx (io.c:169) 5 ready for reading
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:roster
> S2S : Fri Nov 16 16:23:14 2007 router.c:76 writing to 5
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:1197 write action on fd 6
> ROUT: sx (io.c:191) passed 98 read bytes
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'announce' added to chain
> 'in-sess' (order 11 index 12 seq 0)
> RSLV: sx (io.c :175) tag 5 event 2 data 0x8372518
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'vacation' to
> chain 'in-sess' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 router.c:80 98 bytes written
> C2S : sx (io.c:303) 6 ready for writing
> ROUT: sx (chain.c:93) calling io read chain
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'presence' added to chain
> 'in-sess' (order 12 index 13 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:143 reading from 5
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> http://jabber.org/protocol/vacation
> S2S : sx (client.c:103) 5 state change from 0 to 2
> C2S : sx (io.c:261) encoding 98 bytes for writing: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'>
> ROUT: sx (io.c:215) decoded read data (98 bytes): <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'deliver' added to chain
> 'in-sess' (order 13 index 14 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:168 read 326 bytes
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-vcard' to
> chain 'in-sess' (not added yet)
> S2S : sx (client.c:105) stream header sent, waiting for reply
> C2S : sx (chain.c:79) calling io write chain
> ROUT: sx (server.c :118) stream request: to (null) from (null) version 1.0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'session' added to chain
> 'in-router' (order 0 index 15 seq 0)
> RSLV: sx (io.c:191) passed 326 read bytes
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature vcard-temp
> S2S : sx (io.c:358) tag 5 event 0 data 0x0
> C2S : sx (io.c:324) handing app 98 bytes to write
> ROUT: sx (server.c:133) 6 state change from 0 to 1
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'validate' added to chain
> 'in-router' (order 1 index 2 seq 1)
> RSLV: sx (chain.c:93) calling io read chain
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-ping' to
> chain 'in-sess' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 router.c:34 want read
> C2S : sx (io.c:325) tag 6 event 3 data 0x939d7d8
> ROUT: sx (server.c:151) stream id is
> hhgaf0v45oj123cuz0iwf642y84et7gbpwl4xh82
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'presence' added to chain
> 'in-router' (order 2 index 13 seq 1)
> RSLV: sx (io.c:215) decoded read data (326 bytes): <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'
> id='hhgaf0v45oj123cuz0iwf642y84et7gbpwl4xh82'><stream:features
> xmlns:stream='http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
>
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> urn:xmpp:ping
> S2S : Fri Nov 16 16:23:14 2007 main.c:575 running time checks
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:700 writing to 6
> ROUT: sx (server.c :181) prepared stream response: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version='1.0'
> id='hhgaf0v45oj123cuz0iwf642y84et7gbpwl4xh82'>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'privacy' added to chain
> 'in-router' (order 3 index 3 seq 1)
> RSLV: sx (client.c:70) stream response: to (null) from (null) version
> 1.0 id hhgaf0v45oj123cuz0iwf642y84et7gbpwl4xh82
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-private' to
> chain 'in-sess' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 main.c:580 next time check at 1195248254
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:704 98 bytes written
> ROUT: sx (io.c:231) tag 6 event 1 data 0x0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'privacy' added to chain
> 'out-router' (order 0 index 3 seq 2)
> RSLV: sx (client.c :85) 5 state change from 2 to 3
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:private
> S2S : Fri Nov 16 16:23:14 2007 router.c:290 read action on fd 5
> C2S : sx (client.c:103) 6 state change from 0 to 2
> ROUT: Fri Nov 16 16:23:14 2007 router.c:521 want write
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-last' added to chain
> 'pkt-sm' (order 0 index 1 seq 1)
> RSLV: sx (client.c:86) tag 5 event 4 data 0x0
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'disco' to
> chain 'in-sess' (not added yet)
> S2S : sx (io.c:169) 5 ready for reading
> C2S : sx (client.c:105) stream header sent, waiting for reply
> ROUT: Fri Nov 16 16:23:14 2007 router.c:872 write action on fd 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-ping' added to chain
> 'pkt-sm' (order 1 index 7 seq 1)
> RSLV: sx (io.c:70) completed nad: <stream:features xmlns:stream='
> http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
>
> SM : Fri Nov 16 16:23:14 2007 mod_disco.c:636 disco module init
> S2S : sx (io.c:175) tag 5 event 2 data 0x8a18f00
> C2S : sx (io.c:358) tag 6 event 0 data 0x0
> ROUT: sx (io.c:303) 6 ready for writing
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-time' added to chain
> 'pkt-sm' (order 2 index 16 seq 0)
> RSLV: sx (chain.c:119) calling nad read chain
> SM : Fri Nov 16 16:23:14 2007 mod_disco.c:661 agents compat enabled
> S2S : Fri Nov 16 16:23:14 2007 router.c:44 reading from 5
> C2S : Fri Nov 16 16:23:14 2007 c2s.c :658 want read
> ROUT: sx (io.c:261) encoding 144 bytes for writing: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'
> id='hhgaf0v45oj123cuz0iwf642y84et7gbpwl4xh82'>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-version' added to
> chain 'pkt-sm' (order 3 index 17 seq 0)
> RSLV: sx (io.c:134) tag 5 event 6 data 0x8373290
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> http://jabber.org/protocol/disco
> S2S : Fri Nov 16 16:23:14 2007 router.c:69 read 326 bytes
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:1186 read action on fd 6
> ROUT: sx (chain.c:79) calling io write chain
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'amp' added to chain
> 'pkt-sm' (order 4 index 10 seq 1)
> RSLV: sx (sasl_cyrus.c:1288) sending auth request to server, mech
> 'DIGEST-MD5':
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:agents
> S2S : sx (io.c:191) passed 326 read bytes
> C2S : sx (io.c:169) 6 ready for reading
> ROUT: sx (io.c:324) handing app 144 bytes to write
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco' added to chain
> 'pkt-sm' (order 5 index 9 seq 1)
> RSLV: sx (chain.c:106) calling nad write chain
> SM : Fri Nov 16 16:23:14 2007 mod_disco.c:94 unifying lists
> S2S : sx (chain.c:93) calling io read chain
> C2S : sx (io.c:175) tag 6 event 2 data 0x939d7d8
> ROUT: sx (io.c:325) tag 6 event 3 data 0x8925af0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'announce' added to chain
> 'pkt-sm' (order 6 index 12 seq 1)
> RSLV: sx (io.c:381) queueing for write: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'amp' to chain
> 'in-sess' (not added yet)
> S2S : sx (io.c:215) decoded read data (326 bytes): <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'
> id='gng7jexoi1numxu4szj5c1ohoghrbdas0qzk5x9o'><stream:features
> xmlns:stream='http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
>
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:668 reading from 6
> ROUT: Fri Nov 16 16:23:14 2007 router.c:591 writing to 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'help' added to chain
> 'pkt-sm' (order 7 index 18 seq 0)
> RSLV: sx (io.c:404) tag 5 event 1 data 0x0
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> http://jabber.org/protocol/amp
> S2S : sx (client.c:70) stream response: to (null) from (null) version
> 1.0 id gng7jexoi1numxu4szj5c1ohoghrbdas0qzk5x9o
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:693 read 144 bytes
> ROUT: Fri Nov 16 16:23:14 2007 router.c:595 144 bytes written
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'echo' added to chain
> 'pkt-sm' (order 8 index 19 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:138 want write
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'offline' to
> chain 'in-sess' (not added yet)
> S2S : sx (client.c:85) 5 state change from 2 to 3
> C2S : sx (io.c:191) passed 144 read bytes
> ROUT: sx (server.c:29) stream established
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'status' added to chain
> 'pkt-sm' (order 9 index 0 seq 3)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:464 write action on fd 5
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature msgoffline
> S2S : sx (client.c:86) tag 5 event 4 data 0x0
> C2S : sx (chain.c:93) calling io read chain
> ROUT: sx (sasl_cyrus.c:489) setting up sasl for this server conn
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'roster' added to chain
> 'pkt-user' (order 0 index 4 seq 1)
> RSLV: sx (io.c:303) 5 ready for writing
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'announce' to
> chain 'in-sess' (not added yet)
> S2S : sx (io.c:70) completed nad: <stream:features
> xmlns:stream='http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
>
> C2S : sx (io.c:215) decoded read data (144 bytes): <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'
> id='zwimtdqmdarpbg7zxpr82103s0nyyxnxt5jnia9w'>
> ROUT: sx (sasl_cyrus.c:563) sasl context initialised for 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'presence' added to chain
> 'pkt-user' (order 1 index 13 seq 2)
> RSLV: sx (io.c:261) encoding 71 bytes for writing: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'presence' to
> chain 'in-sess' (not added yet)
> S2S : sx (chain.c:119) calling nad read chain
> C2S : sx (client.c:70) stream response: to (null) from (null) version
> 1.0 id zwimtdqmdarpbg7zxpr82103s0nyyxnxt5jnia9w
> ROUT: sx (server.c:39) 6 state change from 1 to 3
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-vcard' added to chain
> 'pkt-user' (order 2 index 6 seq 1)
> RSLV: sx (chain.c:79) calling io write chain
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature presence
> S2S : sx (io.c:134) tag 5 event 6 data 0x8a19c78
> C2S : sx (client.c:85) 6 state change from 2 to 3
> ROUT: sx (server.c:40) tag 6 event 4 data 0x0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'amp' added to chain
> 'pkt-user' (order 3 index 10 seq 2)
> RSLV: sx (io.c:324) handing app 71 bytes to write
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'deliver' to
> chain 'in-sess' (not added yet)
> S2S : sx (sasl_cyrus.c:1288) sending auth request to server, mech
> 'DIGEST-MD5':
> C2S : sx (client.c:86) tag 6 event 4 data 0x0
> ROUT: sx (server.c:45) building features nad
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'deliver' added to chain
> 'pkt-user' (order 4 index 14 seq 1)
> RSLV: sx (io.c:325) tag 5 event 3 data 0x83758c8
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature message
> S2S : sx (chain.c:106) calling nad write chain
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:1186 read action on fd 6
> ROUT: sx (sasl_cyrus.c:609) offering sasl mechanisms
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'vacation' added to chain
> 'pkt-user' (order 5 index 5 seq 1)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c :175 writing to 5
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'out-sess'
> S2S : sx (io.c:381) queueing for write: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> C2S : sx (io.c:169) 6 ready for reading
> ROUT: sx (sasl_cyrus.c:636) offering mechanism: DIGEST-MD5
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'offline' added to chain
> 'pkt-user' (order 6 index 11 seq 1)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:179 71 bytes written
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'in-router'
> S2S : sx (io.c:404) tag 5 event 1 data 0x0
> C2S : sx (io.c:175) tag 6 event 2 data 0x939d728
> ROUT: sx (io.c:358) tag 6 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco-publish' added to
> chain 'pkt-user' (order 7 index 20 seq 0)
> RSLV: sx (io.c:358) tag 5 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'session' to
> chain 'in-router' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 router.c:39 want write
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:668 reading from 6
> ROUT: Fri Nov 16 16:23:14 2007 router.c:516 want read
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-last' added to chain
> 'pkt-user' (order 8 index 1 seq 2)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c :133 want read
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'out-router'
> S2S : Fri Nov 16 16:23:14 2007 router.c:301 write action on fd 5
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:693 read 182 bytes
> ROUT: Fri Nov 16 16:23:14 2007 router.c:872 write action on fd 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'session' added to chain
> 'pkt-router' (order 0 index 15 seq 1)
> RSLV: sx (io.c:406) tag 5 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain 'pkt-sm'
> S2S : sx (io.c:303) 5 ready for writing
> C2S : sx (io.c:191) passed 182 read bytes
> ROUT: sx (io.c:303) 6 ready for writing
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco' added to chain
> 'pkt-router' (order 1 index 9 seq 2)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:133 want read
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-time' to
> chain 'pkt-sm' (not added yet)
> S2S : sx (io.c:261) encoding 71 bytes for writing: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> C2S : sx (chain.c:93) calling io read chain
> ROUT: sx (io.c:261) encoding 182 bytes for writing: <stream:features
> xmlns:stream=' http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'active' added to chain
> 'user-load' (order 0 index 21 seq 0)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:460 read action on fd 5
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:time
> S2S : sx (chain.c:79) calling io write chain
> C2S : sx (io.c:215) decoded read data (182 bytes): <stream:features
> xmlns:stream=' http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
> ROUT: sx (chain.c :79) calling io write chain
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'roster' added to chain
> 'user-load' (order 1 index 4 seq 2)
> RSLV: sx (io.c:169) 5 ready for reading
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> urn:xmpp:time
> S2S : sx (io.c:324) handing app 71 bytes to write
> C2S : sx (io.c:70) completed nad: <stream:features xmlns:stream='
> http://etherx.jabber.org/streams'
> <http://etherx.jabber.org/streams'>><mechanisms
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
> ROUT: sx (io.c:324) handing app 182 bytes to write
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'privacy' added to chain
> 'user-load' (order 2 index 3 seq 3)
> RSLV: sx (io.c:175) tag 5 event 2 data 0x83758c8
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'iq-version' to
> chain 'pkt-sm' (not added yet)
> S2S : sx (io.c:325) tag 5 event 3 data 0x8a1c2b0
> C2S : sx (chain.c:119) calling nad read chain
> ROUT: sx (io.c:325) tag 6 event 3 data 0x8925af0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco-publish' added to
> chain 'user-load' (order 3 index 20 seq 1)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:143 reading from 5
> SM : Fri Nov 16 16:23:14 2007 feature.c:39 registering feature
> jabber:iq:version
> S2S : Fri Nov 16 16:23:14 2007 router.c:76 writing to 5
> C2S : sx ( io.c:134) tag 6 event 6 data 0x939e4d8
> ROUT: Fri Nov 16 16:23:14 2007 router.c:591 writing to 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'vacation' added to chain
> 'user-load' (order 4 index 5 seq 2)
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:168 read 312 bytes
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'help' to chain
> 'pkt-sm' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 router.c :80 71 bytes written
> C2S : sx (sasl_cyrus.c:1288) sending auth request to server, mech
> 'DIGEST-MD5':
> ROUT: Fri Nov 16 16:23:14 2007 router.c:595 182 bytes written
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'active' added to chain
> 'user-create' (order 0 index 21 seq 1)
> RSLV: sx (io.c:191) passed 312 read bytes
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'echo' to chain
> 'pkt-sm' (not added yet)
> S2S : sx (io.c:358) tag 5 event 0 data 0x0
> C2S : sx ( chain.c:106) calling nad write chain
> ROUT: sx (io.c:358) tag 6 event 0 data 0x0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'template-roster' added
> to chain 'user-create' (order 1 index 22 seq 0)
> RSLV: sx (chain.c:93) calling io read chain
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'pkt-user'
> S2S : Fri Nov 16 16:23:14 2007 router.c:34 want read
> C2S : sx (io.c:381) queueing for write: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> ROUT: Fri Nov 16 16:23:14 2007 router.c:516 want read
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'active' added to chain
> 'user-delete' (order 0 index 21 seq 2)
> RSLV: sx (io.c:215) decoded read data (312 bytes): <challenge
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9InFUcDU1d3ZDd0VIRW91eTVTMmc2bUdzd21Nc2NsekJvZnZIckZMcmxlSWs9IixyZWFsbT0iamFiYmVyZC1yb3V0ZXIiLHFvcD0iYXV0aCxhdXRoLWludCxhdXRoLWNvbmYiLGNpcGhlcj0icmM0LTQwLHJjNC01NixyYzQsZGVzLDNkZXMiLG1heGJ1Zj0xMDI0LGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
>
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'disco-publish'
> to chain 'pkt-user' (not added yet)
> S2S : sx (io.c:406) tag 5 event 0 data 0x0
> C2S : sx (io.c:404) tag 6 event 1 data 0x0
> ROUT: Fri Nov 16 16:23:14 2007 router.c:858 read action on fd 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'announce' added to chain
> 'user-delete' (order 1 index 12 seq 2)
> RSLV: sx (io.c:70) completed nad: <challenge
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9InFUcDU1d3ZDd0VIRW91eTVTMmc2bUdzd21Nc2NsekJvZnZIckZMcmxlSWs9IixyZWFsbT0iamFiYmVyZC1yb3V0ZXIiLHFvcD0iYXV0aCxhdXRoLWludCxhdXRoLWNvbmYiLGNpcGhlcj0icmM0LTQwLHJjNC01NixyYzQsZGVzLDNkZXMiLG1heGJ1Zj0xMDI0LGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
>
> SM : Fri Nov 16 16:23:14 2007 mod_disco_publish.c:305 disco publish
> module init
> S2S : Fri Nov 16 16:23:14 2007 router.c:34 want read
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:663 want write
> ROUT: sx (io.c:169) 6 ready for reading
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'disco-publish' added to
> chain 'user-delete' (order 2 index 20 seq 2)
> RSLV: sx (chain.c:119) calling nad read chain
> SM : Fri Nov 16 16:23:14 2007 mm.c :80 processing config for chain
> 'pkt-router'
> S2S : Fri Nov 16 16:23:14 2007 router.c:290 read action on fd 5
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:1197 write action on fd 6
> ROUT: sx (io.c:175) tag 6 event 2 data 0x8925af0
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'offline' added to chain
> 'user-delete' (order 3 index 11 seq 2)
> RSLV: sx (sasl_cyrus.c:823) challenge from client
> SM : Fri Nov 16 16:23:14 2007 mm.c :80 processing config for chain
> 'user-load'
> S2S : sx (io.c:169) 5 ready for reading
> C2S : sx (io.c:303) 6 ready for writing
> ROUT: Fri Nov 16 16:23:14 2007 router.c:526 reading from 6
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'privacy' added to chain
> 'user-delete' (order 4 index 3 seq 4)
> RSLV: sx (sasl_cyrus.c:1121) in _sx_sasl_cb_get_simple (id 0x4002)
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module 'active' to
> chain 'user-load' (not added yet)
> S2S : sx (io.c:175) tag 5 event 2 data 0x8a1c2b0
> C2S : sx (io.c:261) encoding 71 bytes for writing: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> ROUT: Fri Nov 16 16:23:14 2007 router.c:584 read 71 bytes
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'roster' added to chain
> 'user-delete' (order 5 index 4 seq 3)
> RSLV: sx (sasl_cyrus.c:1121) in _sx_sasl_cb_get_simple (id 0x4001)
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'user-create'
> S2S : Fri Nov 16 16:23:14 2007 router.c:44 reading from 5
> C2S : sx (chain.c:79) calling io write chain
> ROUT: sx (io.c:191) passed 71 read bytes
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'vacation' added to chain
> 'user-delete' (order 6 index 5 seq 3)
> RSLV: sx (sasl_cyrus.c:1134) in _sx_sasl_cb_get_secret (id 0x4004)
> SM : Fri Nov 16 16:23:14 2007 mm.c:199 preloaded module
> 'template-roster' to chain 'user-create' (not added yet)
> S2S : Fri Nov 16 16:23:14 2007 router.c:69 read 312 bytes
> C2S : sx (io.c:324) handing app 71 bytes to write
> ROUT: sx (chain.c:93) calling io read chain
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'status' added to chain
> 'user-delete' (order 7 index 0 seq 4)
> RSLV: sx (sasl_cyrus.c:834) sasl handshake in progress (response:
> username="jabberd",realm="jabberd-router",nonce="qTp55wvCwEHEouy5S2g6mGswmMsclzBofvHrFLrleIk=",cnonce="wNAD2hkZkRLpo2Y4kNT/ueJmDYl0Ap5/dskosGeYvUM=",nc=00000001,qop=auth-conf,cipher=rc4,maxbuf=1024,digest-uri="jabberd-router/",response=ae5b5c82c617d4c5c955addffea036f5)
>
> SM : Fri Nov 16 16:23:14 2007 mm.c:80 processing config for chain
> 'user-delete'
> S2S : sx (io.c:191) passed 312 read bytes
> C2S : sx (io.c:325) tag 6 event 3 data 0x93a0bd8
> ROUT: sx (io.c:215) decoded read data (71 bytes): <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-last' added to chain
> 'user-delete' (order 8 index 1 seq 3)
> RSLV: sx (chain.c:106) calling nad write chain
> SM : sx (sasl_cyrus.c:1041) initialising sasl plugin
> S2S : sx (chain.c:93) calling io read chain
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:700 writing to 6
> ROUT: sx (io.c:70) completed nad: <auth
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl' mechanism='DIGEST-MD5'/>
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-private' added to
> chain 'user-delete' (order 9 index 8 seq 1)
> RSLV: sx (io.c:381) queueing for write: <response
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>dXNlcm5hbWU9ImphYmJlcmQiLHJlYWxtPSJqYWJiZXJkLXJvdXRlciIsbm9uY2U9InFUcDU1d3ZDd0VIRW91eTVTMmc2bUdzd21Nc2NsekJvZnZIckZMcmxlSWs9Iixjbm9uY2U9IndOQUQyaGtaa1JMcG8yWTRrTlQvdWVKbURZbDBBcDUvZHNrb3NHZVl2VU09IixuYz0wMDAwMDAwMSxxb3A9YXV0aC1jb25mLGNpcGhlcj1yYzQsbWF4YnVmPTEwMjQsZGlnZXN0LXVyaT0iamFiYmVyZC1yb3V0ZXIvIixyZXNwb25zZT1hZTViNWM4MmM2MTdkNGM1Yzk1NWFkZGZmZWEwMzZmNQ==</response>
>
> SM : sx (sasl_cyrus.c:1099) sasl context initialised; appname=xmpp
> S2S : sx (io.c:215) decoded read data (312 bytes): <challenge
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IkNFRnoxRC9hd2VrM3paVFoyVTkySFZ6ajVYdmw0TXkwYW02SSt3N2liRGs9IixyZWFsbT0iamFiYmVyZC1yb3V0ZXIiLHFvcD0iYXV0aCxhdXRoLWludCxhdXRoLWNvbmYiLGNpcGhlcj0icmM0LTQwLHJjNC01NixyYzQsZGVzLDNkZXMiLG1heGJ1Zj0xMDI0LGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
>
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:704 71 bytes written
> ROUT: sx (chain.c:119) calling nad read chain
> SM : Fri Nov 16 16:23:14 2007 [notice] module 'iq-vcard' added to chain
> 'user-delete' (order 10 index 6 seq 2)
> RSLV: sx (io.c:231) tag 5 event 1 data 0x0
> SM : sx (env.c:77) plugin initialised (index 0)
> S2S : sx (io.c:70) completed nad: <challenge
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9IkNFRnoxRC9hd2VrM3paVFoyVTkySFZ6ajVYdmw0TXkwYW02SSt3N2liRGs9IixyZWFsbT0iamFiYmVyZC1yb3V0ZXIiLHFvcD0iYXV0aCxhdXRoLWludCxhdXRoLWNvbmYiLGNpcGhlcj0icmM0LTQwLHJjNC01NixyYzQsZGVzLDNkZXMiLG1heGJ1Zj0xMDI0LGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
>
> C2S : sx (io.c:358) tag 6 event 0 data 0x0
> ROUT: sx (sasl_cyrus.c:758) auth request from client (mechanism=DIGEST-MD5)
> SM : Fri Nov 16 16:23:14 2007 [notice] version: jabberd sm 2.1.18
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:138 want write
> SM : sx (sx.c:55) allocated new sx for 6
> S2S : sx (chain.c:119) calling nad read chain
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:658 want read
> ROUT: sx (sasl_cyrus.c:794) sasl handshake in progress (challenge:
> nonce="qTp55wvCwEHEouy5S2g6mGswmMsclzBofvHrFLrleIk=",realm="jabberd-router",qop="auth,auth-int,auth-conf",cipher="rc4-40,rc4-56,rc4,des,3des",maxbuf=1024,charset=utf-8,algorithm=md5-sess)
>
> SM : Fri Nov 16 16:23:14 2007 [notice] attempting connection to router
> at 127.0.0.1 <http://127.0.0.1>, port=5347
> RSLV: Fri Nov 16 16:23:14 2007 resolver.c:464 write action on fd 5
> SM : sx (client.c :122) doing client init for sx 6
> S2S : sx (sasl_cyrus.c:823) challenge from client
> C2S : sx (io.c:406) tag 6 event 0 data 0x0
> ROUT: sx (chain.c:106) calling nad write chain
> SM : Fri Nov 16 16:23:14 2007 [notice] connection to router established
> RSLV: sx (io.c:303) 5 ready for writing
> SM : sx (client.c:138) stream request: ns (null) to (null) from (null)
> version 1.0
> S2S : sx (sasl_cyrus.c:1121) in _sx_sasl_cb_get_simple (id 0x4002)
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:658 want read
> ROUT: sx (io.c:381) queueing for write: <challenge
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>bm9uY2U9InFUcDU1d3ZDd0VIRW91eTVTMmc2bUdzd21Nc2NsekJvZnZIckZMcmxlSWs9IixyZWFsbT0iamFiYmVyZC1yb3V0ZXIiLHFvcD0iYXV0aCxhdXRoLWludCxhdXRoLWNvbmYiLGNpcGhlcj0icmM0LTQwLHJjNC01NixyYzQsZGVzLDNkZXMiLG1heGJ1Zj0xMDI0LGNoYXJzZXQ9dXRmLTgsYWxnb3JpdGhtPW1kNS1zZXNz</challenge>
>
> SM : Fri Nov 16 16:23:14 2007 [notice] router refused bind request (409)
> RSLV: sx (io.c:261) encoding 422 bytes for writing: <response
> xmlns='urn:ietf:params:xml:ns:xmpp-sasl'>dXNlcm5hbWU9ImphYmJlcmQiLHJlYWxtPSJqYWJiZXJkLXJvdXRlciIsbm9uY2U9InFUcDU1d3ZDd0VIRW91eTVTMmc2bUdzd21Nc2NsekJvZnZIckZMcmxlSWs9Iixjbm9uY2U9IndOQUQyaGtaa1JMcG8yWTRrTlQvdWVKbURZbDBBcDUvZHNrb3NHZVl2VU09IixuYz0wMDAwMDAwMSxxb3A9YXV0aC1jb25mLGNpcGhlcj1yYzQsbWF4YnVmPTEwMjQsZGlnZXN0LXVyaT0iamFiYmVyZC1yb3V0ZXIvIixyZXNwb25zZT1hZTViNWM4MmM2MTdkNGM1Yzk1NWFkZGZmZWEwMzZmNQ==</response>
>
> SM : sx (client.c:168) prepared stream header: <?xml
> version='1.0'?><stream:stream
> xmlns:stream='http://etherx.jabber.org/streams' version=' 1.0'>
> S2S : sx (sasl_cyrus.c:1121) in _sx_sasl_cb_get_simple (id 0x4001)
> C2S : Fri Nov 16 16:23:14 2007 c2s.c:1186 read action on fd 6
> ROUT: sx (io.c:231) tag 6 event 1 data 0x0
> ERROR: sm died. Shutting down server.
> JBRD: Got a signal... pass it on.
> JBRD: It was a TERM. Shut it all down!
> *********************************************************************
>
>
>
>
> Any help would be really appreciated.
>
>
>
> Thanks a lot.
>
>
>
>
>
>
> --
> RENZO ALEJANDRO CLAVIJO ROMERO
> Ingeniero Electrónico - Universidad Nacional de Colombia
> Fijo: (57) (1) 6107555, ext. 130
> Móvil: 311-5963436
> Correo electrónico: raclavijor at gmail.com <mailto:raclavijor at gmail.com>
> MSN: renzoun at hotmail.com <mailto:renzoun at hotmail.com>
> ***************************************************
> El fracaso derrota a los perdedores, pero inspira a los ganadores.
> (Robert Kiyosaki)
>
>
> ------------------------------------------------------------------------
>
> _______________________________________________
> JAdmin mailing list
> JAdmin at jabber.org
> http://mail.jabber.org/mailman/listinfo/jadmin
> FAQ: http://www.jabber.org/about/jadminfaq.shtml
> _______________________________________________
More information about the JAdmin
mailing list