Help! jabberd out of control

We have a Snow Leopard Server installation - currently running 10.6.8


We don't use, and have not enabled iChat. Nonetheless recently we've seen the server CPU running at 50% load, and upon investigating found the cause was the jabberd process continually starting and dying and restarting - and writing everything into the logs (and it was the syslogd process that was hitting the cpu most visibly).


Try as we might, we cannot find a way to stop the server thrashing away with jabberd - a pointless activity.


We've tried enabling and then disabling iChat, deleting the jabber database, and multiple restarts and so on. Nothing seems to help.


Can anyone advise on how to stop iChat / jabberd from running?

Mac mini, Mac OS X (10.6.8), OS X Server

Posted on Nov 1, 2011 11:38 AM

Reply
17 replies

Nov 1, 2011 2:35 PM in response to MrHoffman

Both Push Notifications and iChat are set to off in Server Admin.


Here is the output from the checkhostname


www:~ administrator$ sudo changeip -checkhostname


Primary address = 46.33.146.45


Current HostName = www.2gc.org

DNS HostName = www.2gc.org


The names match. There is nothing to change.

dirserv:success = "success"

www:~ administrator$


The server sits on the fixed IP 2gc.org, which is aliased to www.2gc.org


The server used to be called sls.2gc.org, but got changed some time ago. Server admin still reports it as sls.2gc.org in the UI, but the machine name has been changed in LDAP etc. so not sure where it is getting it from.


It is hard to find the specific failure from the log, as there is so much crud being thrown out by the processes. But here is what looks like one complete cycle...


Nov 1 20:44:25 www jabberd/router[2780]: starting up

Nov 1 20:44:25 www jabberd/c2s[2783]: starting up

Nov 1 20:44:25 www jabberd/c2s[2783]: modules search path: /var/jabberd/modules/jabberd2

Nov 1 20:44:25 www jabberd/c2s[2783]: initialized auth module 'sqlite'

Nov 1 20:44:25 www jabberd/c2s[2783]: [www.2gc.org] configured; realm=www.2gc.org, registration disabled

Nov 1 20:44:25 www jabberd/c2s[2783]: attempting connection to router at 46.33.146.45, port=5347

Nov 1 20:44:25 www jabberd/c2s[2783]: [4] [router] write error: Broken pipe (32)

Nov 1 20:44:25 www jabberd/c2s[2783]: connection to router closed

Nov 1 20:44:25 www jabberd/c2s[2783]: attempting reconnect (3 left)

Nov 1 20:44:25 www jabberd/router[2780]: loaded user table (1 users)

Nov 1 20:44:25 www jabberd/router[2780]: loaded filters (7 rules)

Nov 1 20:44:25 www jabberd/s2s[2784]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Nov 1 20:44:25 www jabberd/router[2780]: [46.33.146.45, port=5347] listening for incoming connections

Nov 1 20:44:25 www jabberd/s2s[2784]: attempting connection to router at 46.33.146.45, port=5347

Nov 1 20:44:25 www jabberd/router[2780]: [46.33.146.45, port=49728] connect

Nov 1 20:44:25 www jabberd/router[2780]: [46.33.146.45, port=49728] authenticated as jabberd

Nov 1 20:44:25 www jabberd/s2s[2784]: connection to router established

Nov 1 20:44:25 www jabberd/router[2780]: [s2s] set as default route

Nov 1 20:44:25 www jabberd/router[2780]: [s2s] online (bound to 46.33.146.45, port 49728)

Nov 1 20:44:25 www jabberd/s2s[2784]: ready for connections

Nov 1 20:44:26 www jabberd/router[2780]: [46.33.146.45, port=49729] connect

Nov 1 20:44:26 www jabberd/router[2780]: [46.33.146.45, port=49729] authenticated as conference.www.2gc.org

Nov 1 20:44:26 www jabberd/router[2780]: [conference.www.2gc.org] online (bound to 46.33.146.45, port 49729)

Nov 1 20:44:27 www jabberd/resolver[2773]: attempting connection to router at 46.33.146.45, port=5347

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49730] connect

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49730] authenticated as jabberd

Nov 1 20:44:27 www jabberd/sm[2775]: attempting connection to router at 46.33.146.45, port=5347

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49731] connect

Nov 1 20:44:27 www jabberd/resolver[2773]: connection to router established

Nov 1 20:44:27 www jabberd/router[2780]: [resolver] online (bound to 46.33.146.45, port 49730)

Nov 1 20:44:27 www jabberd/resolver[2773]: ready to resolve

Nov 1 20:44:27 www jabberd/c2s[2783]: attempting connection to router at 46.33.146.45, port=5347

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49731] authenticated as jabberd

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49732] connect

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49732] authenticated as jabberd

Nov 1 20:44:27 www jabberd/sm[2775]: connection to router established

Nov 1 20:44:27 www jabberd/router[2780]: [www.2gc.org] online (bound to 46.33.146.45, port 49731)

Nov 1 20:44:27 www jabberd/sm[2775]: ready for sessions

Nov 1 20:44:27 www jabberd/c2s[2783]: connection to router established

Nov 1 20:44:27 www jabberd/router[2780]: [c2s] online (bound to 46.33.146.45, port 49732)

Nov 1 20:44:27 www jabberd/c2s[2783]: [::, port=5222] failed to listen

Nov 1 20:44:27 www jabberd/c2s[2783]: [::, port=5223] failed to listen

Nov 1 20:44:27 www jabberd/c2s[2783]: both normal and SSL ports are disabled, nothing to do!

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49732] disconnect

Nov 1 20:44:27 www jabberd/router[2780]: [c2s] offline

Nov 1 20:44:27 www jabberd/router[2780]: shutting down

Nov 1 20:44:27 www jabberd/router[2780]: [46.33.146.45, port=49728] disconnect

Nov 1 20:44:27 www jabberd/router[2780]: [s2s] default route offline

Nov 1 20:44:27 www jabberd/router[2780]: [s2s] offline

Nov 1 20:44:27 www jabberd/resolver[2773]: shutting down

Nov 1 20:44:27 www jabberd/sm[2775]: shutting down

Nov 1 20:44:27 www jabberd/s2s[2784]: shutting down

Nov 1 20:44:27 www jabberd/s2s[2784]: connection to router closed

Nov 1 20:44:27 www com.apple.launchd[1] (com.apple.aslmanager): Throttling respawn: Will start in 10 seconds

Nov 1 20:44:28 www jabberd/router[2780]: [46.33.146.45, port=49729] disconnect

Nov 1 20:44:28 www jabberd/router[2780]: [conference.www.2gc.org] offline

Nov 1 20:44:29 www jabberd/router[2780]: [46.33.146.45, port=49730] disconnect

Nov 1 20:44:29 www jabberd/router[2780]: [resolver] offline

Nov 1 20:44:29 www jabberd/router[2780]: [46.33.146.45, port=49731] disconnect

Nov 1 20:44:29 www jabberd/router[2780]: [www.2gc.org] offline

Nov 1 20:44:32 www org.jabber.jabberd[2772]: ERROR: c2s died. Shutting down server.

Nov 1 20:44:32 www com.apple.launchd[1] (org.jabber.jabberd): Throttling respawn: Will start in 3 seconds


We recently changed the fixed IP associated with www.2gc.org (moved to a new data connection with different fixed IP block assigned). But to begin with there was no problem with jabber / CPU thrashing. But today something unknown has kicked into play again.


Grateful for any suggestions either about how to fix problem, or how to kill jabber. It is killing the server currently - using over 50% cpu capacity, and the system log is updating slower than real time due to volume of crud being thrown out by jabber processes (currently the reported time in system.log viewed in console is 45 minutes behind actual time) which makes syslog not much good for any other purpose.

Nov 1, 2011 4:17 PM in response to Gavin Lawrie

Hi - just a bit of an update.


I've found out how to fix the reported name of the server in Server Administration - click on the cog below list of servers, choose 'connect' while the server is selected, and then rename the server to the 'www.2gc.org' name and log back in. This fixes the name of the server in the side bar - and then updates the window title bar when you next switch to this server.


So now, as far as I can tell, everything lines up behind the FQDN of the machine of www.2gc.org - but still getting 100% cpu usage (50% of total as dual core server) due to syslogd struggling to keep up with crud being thrown out by jabberd and its component parts.


As mentioned above, I'd like to fix it 'properly' if I can, but if not fixable, I'd just like to learn how to stop jabberd completely - as far as I can tell it is serving no useful purpose on our system.


Thanks in advance for whatever help avail etc.

Nov 1, 2011 6:12 PM in response to Gavin Lawrie

And a bit more intel.


About 15 minutes ago the server load dropped sharply. Upon investigating, it seems now that jabberd is doing a portscan of the server... here is a clip of the system.log: now it seems to be settling for declaring that the host is non-existing, even though quite clearly it does (vis the checkhostname output give above). But maybe it is a clue...


Anyone got any idea what is going on / how I can stop it?


Thanks in advance!


Nov 2 01:08:56 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53443] connect

Nov 2 01:08:56 www jabberd/c2s[729]: SASL callback for non-existing host: www.2gc.org

Nov 2 01:08:56 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53443] disconnect jid=unbound, packets: 0

Nov 2 01:08:59 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53446] connect

Nov 2 01:08:59 www jabberd/c2s[729]: SASL callback for non-existing host: www.2gc.org

Nov 2 01:08:59 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53446] disconnect jid=unbound, packets: 0

Nov 2 01:09:02 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53449] connect

Nov 2 01:09:02 www jabberd/c2s[729]: SASL callback for non-existing host: www.2gc.org

Nov 2 01:09:02 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53449] disconnect jid=unbound, packets: 0

Nov 2 01:09:05 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53450] connect

Nov 2 01:09:05 www jabberd/c2s[729]: SASL callback for non-existing host: www.2gc.org

Nov 2 01:09:05 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53450] disconnect jid=unbound, packets: 0

Nov 2 01:09:08 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53452] connect

Nov 2 01:09:08 www jabberd/c2s[729]: SASL callback for non-existing host: www.2gc.org

Nov 2 01:09:08 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53452] disconnect jid=unbound, packets: 0

Nov 2 01:09:11 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53454] connect

Nov 2 01:09:11 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:14 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53459] connect

Nov 2 01:09:14 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:17 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53461] connect

Nov 2 01:09:17 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:20 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53462] connect

Nov 2 01:09:20 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:23 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53464] connect

Nov 2 01:09:23 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:25 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53465] connect

Nov 2 01:09:25 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:29 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53467] connect

Nov 2 01:09:29 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:31 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53468] connect

Nov 2 01:09:31 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:34 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53470] connect

Nov 2 01:09:34 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:36 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53471] connect

Nov 2 01:09:36 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:39 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53472] connect

Nov 2 01:09:39 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:42 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53474] connect

Nov 2 01:09:42 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45] is being rate limited

Nov 2 01:09:45 www jabberd/c2s[729]: [8] [::ffff:46.33.146.45, port=53476] connect

Nov 2, 2011 9:33 AM in response to MrHoffman

The server is sitting on a direct connection to the the router that holds up our PPoE DSL connection to our ISP. It has a manually assigned fixed IP within the block assigned to us by the ISP. The server has no direct connections onto our LAN, and performs no DHCP or DNS services. The server has the standard OS X Server firewall installed and operational, but with all the default ports for iChat and Push Notification opened (even though we are not using them).


Here is the result of the command:


www:~ administrator$ sudo serveradmin fullstatus jabber

Password:

jabber:state = "STOPPED"

jabber:readWriteSettingsVersion = 1

jabber:logPaths:PROXY_LOG = "/private/var/jabberd/log/proxy65.log"

jabber:logPaths:MUC_STD_LOG = "/var/jabberd/log/mu-conference.log"

jabber:logPaths:JABBER_LOG = "/var/log/system.log"

jabber:proxyState = "RUNNING"

jabber:currentConnections = "0"

jabber:currentConnectionsPort1 = "0"

jabber:currentConnectionsPort2 = "0"

jabber:pluginVersion = "100.2"

jabber:serviceMode = "NOTIFICATION"

jabber:domainName = "Server.local"

jabber:mucState = "RUNNING"

jabber:servicePortsAreRestricted = "NO"

jabber:servicePortsRestrictionInfo = _empty_array

jabber:hosts:_array_index:0 = "Server.local"

jabber:setStateVersion = 1

jabber:startedTime = "2011-11-02 16:28:55 +0000"

jabber:jabberdState = "RUNNING"

www:~ administrator$

Nov 4, 2011 3:09 AM in response to Gavin Lawrie

Anyone got any ideas? The problem is still there - I still can't understand why it is not possible to simply turn off Jabberd since none of its services are being used for anything.


It got into port scanning again today, so I killed the c2s process in activity monitor, and this is the trace of what happened when it restarted (as the thing won't stay killed). Not sure it is meaningful, but this one contains statements about conference.server.local not being found. Any clues there?


As always, any help most gratefully received


Nov 4 09:59:43 www jabberd/router[89779]: starting up

Nov 4 09:59:43 www jabberd/sm[89778]: starting up

Nov 4 09:59:43 www jabberd/resolver[89777]: starting up

Nov 4 09:59:43 www jabberd/s2s[89782]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Nov 4 09:59:43 www jabberd/c2s[89781]: starting up

Nov 4 09:59:43 www jabberd/sm[89778]: id: www.2gc.org

Nov 4 09:59:43 www jabberd/c2s[89781]: modules search path: /var/jabberd/modules/jabberd2

Nov 4 09:59:43 www jabberd/sm[89778]: initialised storage driver 'sqlite'

Nov 4 09:59:43 www jabberd/sm[89778]: modules search path: /var/jabberd/modules/jabberd2

Nov 4 09:59:43 www jabberd/router[89779]: loaded user table (1 users)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-last' added to chain 'sess-end' (order 0 index 0 seq 0)

Nov 4 09:59:43 www jabberd/router[89779]: loaded filters (7 rules)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'validate' added to chain 'in-sess' (order 0 index 1 seq 0)

Nov 4 09:59:43 www jabberd/c2s[89781]: initialized auth module 'sqlite'

Nov 4 09:59:43 www jabberd/sm[89778]: module 'privacy' added to chain 'in-sess' (order 1 index 2 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'roster' added to chain 'in-sess' (order 2 index 3 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'vacation' added to chain 'in-sess' (order 3 index 4 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-vcard' added to chain 'in-sess' (order 4 index 5 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-ping' added to chain 'in-sess' (order 5 index 6 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-private' added to chain 'in-sess' (order 6 index 7 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco' added to chain 'in-sess' (order 7 index 8 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'amp' added to chain 'in-sess' (order 8 index 9 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'offline' added to chain 'in-sess' (order 9 index 10 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'announce' added to chain 'in-sess' (order 10 index 11 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'presence' added to chain 'in-sess' (order 11 index 12 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'deliver' added to chain 'in-sess' (order 12 index 13 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'session' added to chain 'in-router' (order 0 index 14 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'validate' added to chain 'in-router' (order 1 index 1 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'presence' added to chain 'in-router' (order 2 index 12 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'privacy' added to chain 'in-router' (order 3 index 2 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'privacy' added to chain 'out-router' (order 0 index 2 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-last' added to chain 'pkt-sm' (order 0 index 0 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-ping' added to chain 'pkt-sm' (order 1 index 6 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-time' added to chain 'pkt-sm' (order 2 index 15 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-version' added to chain 'pkt-sm' (order 3 index 16 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'amp' added to chain 'pkt-sm' (order 4 index 9 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco' added to chain 'pkt-sm' (order 5 index 8 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'announce' added to chain 'pkt-sm' (order 6 index 11 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'help' added to chain 'pkt-sm' (order 7 index 17 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'echo' added to chain 'pkt-sm' (order 8 index 18 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'roster' added to chain 'pkt-user' (order 0 index 3 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'presence' added to chain 'pkt-user' (order 1 index 12 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-vcard' added to chain 'pkt-user' (order 2 index 5 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'amp' added to chain 'pkt-user' (order 3 index 9 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'deliver' added to chain 'pkt-user' (order 4 index 13 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'vacation' added to chain 'pkt-user' (order 5 index 4 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'offline' added to chain 'pkt-user' (order 6 index 10 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco-publish' added to chain 'pkt-user' (order 7 index 19 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-last' added to chain 'pkt-user' (order 8 index 0 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'session' added to chain 'pkt-router' (order 0 index 14 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco' added to chain 'pkt-router' (order 1 index 8 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'active' added to chain 'user-load' (order 0 index 20 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'roster' added to chain 'user-load' (order 1 index 3 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'roster-publish' added to chain 'user-load' (order 2 index 21 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'privacy' added to chain 'user-load' (order 3 index 2 seq 3)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco-publish' added to chain 'user-load' (order 4 index 19 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'vacation' added to chain 'user-load' (order 5 index 4 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'active' added to chain 'user-create' (order 0 index 20 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'template-roster' added to chain 'user-create' (order 1 index 22 seq 0)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'active' added to chain 'user-delete' (order 0 index 20 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'announce' added to chain 'user-delete' (order 1 index 11 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'disco-publish' added to chain 'user-delete' (order 2 index 19 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'offline' added to chain 'user-delete' (order 3 index 10 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'privacy' added to chain 'user-delete' (order 4 index 2 seq 4)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'roster' added to chain 'user-delete' (order 5 index 3 seq 3)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'vacation' added to chain 'user-delete' (order 6 index 4 seq 3)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-last' added to chain 'user-delete' (order 7 index 0 seq 3)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-private' added to chain 'user-delete' (order 8 index 7 seq 1)

Nov 4 09:59:43 www jabberd/sm[89778]: module 'iq-vcard' added to chain 'user-delete' (order 9 index 5 seq 2)

Nov 4 09:59:43 www jabberd/sm[89778]: version: jabberd sm 2.1.24.1-326.6

Nov 4 09:59:44 www jabberd/s2s[89782]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:44 www jabberd/s2s[89782]: [4] [router] write error: Broken pipe (32)

Nov 4 09:59:44 www jabberd/resolver[89777]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:44 www jabberd/s2s[89782]: connection to router closed

Nov 4 09:59:44 www jabberd/s2s[89782]: attempting reconnect (3 left)

Nov 4 09:59:44 www jabberd/resolver[89777]: [4] [router] write error: Broken pipe (32)

Nov 4 09:59:44 www jabberd/resolver[89777]: connection to router closed

Nov 4 09:59:44 www jabberd/resolver[89777]: attempting reconnect (3 left)

Nov 4 09:59:44 www jabberd/sm[89778]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:44 www jabberd/sm[89778]: [5] [router] write error: Broken pipe (32)

Nov 4 09:59:44 www jabberd/sm[89778]: connection to router closed

Nov 4 09:59:44 www jabberd/router[89779]: [46.33.146.45, port=5347] listening for incoming connections

Nov 4 09:59:44 www jabberd/sm[89778]: attempting reconnect (3 left)

Nov 4 09:59:44 www jabberd/c2s[89781]: [server.local] configured; realm=server.local, registration disabled

Nov 4 09:59:44 www jabberd/c2s[89781]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:44 www jabberd/router[89779]: [46.33.146.45, port=62594] connect

Nov 4 09:59:44 www jabberd/router[89779]: [46.33.146.45, port=62594] authenticated as jabberd

Nov 4 09:59:44 www jabberd/router[89779]: [46.33.146.45, port=62595] connect

Nov 4 09:59:44 www jabberd/router[89779]: [46.33.146.45, port=62595] authenticated as conference.Server.local

Nov 4 09:59:44 www jabberd/router[89779]: [conference.Server.local] online (bound to 46.33.146.45, port 62595)

Nov 4 09:59:46 www jabberd/s2s[89782]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62596] connect

Nov 4 09:59:46 www jabberd/resolver[89777]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62597] connect

Nov 4 09:59:46 www jabberd/sm[89778]: attempting connection to router at 46.33.146.45, port=5347

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62598] connect

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62597] authenticated as jabberd

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62596] authenticated as jabberd

Nov 4 09:59:46 www jabberd/router[89779]: [46.33.146.45, port=62598] authenticated as jabberd

Nov 4 09:59:49 www jabberd/c2s[89781]: connection to router established

Nov 4 09:59:49 www jabberd/router[89779]: [c2s] online (bound to 46.33.146.45, port 62594)

Nov 4 09:59:49 www jabberd/c2s[89781]: [::, port=5222] failed to listen

Nov 4 09:59:49 www jabberd/c2s[89781]: [::, port=5223] failed to listen

Nov 4 09:59:49 www jabberd/c2s[89781]: both normal and SSL ports are disabled, nothing to do!

Nov 4 09:59:51 www jabberd/s2s[89782]: connection to router established

Nov 4 09:59:51 www jabberd/sm[89778]: connection to router established

Nov 4 09:59:51 www jabberd/resolver[89777]: connection to router established

Nov 4 09:59:51 www jabberd/router[89779]: [s2s] set as default route

Nov 4 09:59:51 www jabberd/router[89779]: [s2s] online (bound to 46.33.146.45, port 62596)

Nov 4 09:59:51 www jabberd/router[89779]: [www.2gc.org] online (bound to 46.33.146.45, port 62598)

Nov 4 09:59:51 www jabberd/router[89779]: [resolver] online (bound to 46.33.146.45, port 62597)

Nov 4 09:59:51 www jabberd/resolver[89777]: ready to resolve

Nov 4 09:59:51 www jabberd/s2s[89782]: ready for connections

Nov 4 09:59:51 www jabberd/sm[89778]: ready for sessions

Nov 4 09:59:51 www jabberd/resolver[89777]: [conference.server.local] could not be resolved

Nov 4 09:59:51 www jabberd/s2s[89782]: dns lookup for conference.server.local failed

Nov 4, 2011 8:42 AM in response to MrHoffman

Hi. Well I've reset everything to either localhost or 127.0.0.1 or 0.0.0.0 as per guide comments in jabberd conifg xml files. But crud generation still happening. Amongst the noise it is complaining that it can't find a specific DNS location:


Nov 4 15:35:23 www jabberd/router[1265]: [127.0.0.1, port=49603] authenticated as conference.Server.local

Nov 4 15:35:23 www jabberd/router[1265]: [conference.Server.local] online (bound to 127.0.0.1, port 49603)

Nov 4 15:35:23 www jabberd/resolver[1263]: [conference.server.local] could not be resolved

Nov 4 15:35:23 www jabberd/s2s[1268]: dns lookup for conference.server.local failed


There are other errors too - but this one looks fairly straightforward. Do I need to put an entry into the local DNS for the conference.server.local location? If so, where should it be pointing?


Thanks alot again for your help.

Nov 4, 2011 10:25 AM in response to MrHoffman

See my first reply to your message on 1 November where I posted the output for the checkhostname command. I've just done it again, and (unsurprisingly) the output is identical to that posted previously.


As for the second point (about .local DNS top-level domain) I have no idea what that means, or how to check... sorry. But based on what I can glean from googling the words, I can report that the server is called "Server" and can be found via bonjour as "Server.local" - and that these do not appear in the DNS entries for the machine (which is focused solely on the fixed IP / name match for its FQDN). But maybe I've misunderstood what you are asking - if I've got it wrong, apologies, grateful if you could clarify.


Thanks again for helping.

Nov 4, 2011 12:09 PM in response to Gavin Lawrie

There's Unicast or traditional or DNS, and not in the .local TLD.


There's also Multicast or mDNS or Bonjour or the .local TLD.


Using the .local TLD with DNS causes issues.


I see .local entries all over the place, and not unicast DNS.


What I don't understand is why your stuff is refering to mDNS entries.


If I was guessing, the name change didn't take, as this:


Nov 4 15:35:23 www jabberd/router[1265]: [127.0.0.1, port=49603] authenticated as conference.Server.local

Nov 4 15:35:23 www jabberd/router[1265]: [conference.Server.local] online (bound to 127.0.0.1, port 49603)

Nov 4 15:35:23 www jabberd/resolver[1263]: [conference.server.local] could not be resolved

Nov 4 15:35:23 www jabberd/s2s[1268]: dns lookup for conference.server.local failed


looks wrong.


And looking back at your Jabber settings dump, your host name looks wrong, too.


Here's a Jabber server, with working DNS:


Password:

jabber:state = "RUNNING"

jabber:readWriteSettingsVersion = 1

jabber:logPaths:PROXY_LOG = "/private/var/jabberd/log/proxy65.log"

jabber:logPaths:MUC_STD_LOG = "/var/jabberd/log/mu-conference.log"

jabber:logPaths:JABBER_LOG = "/var/log/system.log"

jabber:proxyState = "RUNNING"

jabber:currentConnections = "1"

jabber:currentConnectionsPort1 = "0"

jabber:currentConnectionsPort2 = "1"

jabber:pluginVersion = "100.2"

jabber:serviceMode = "CHATSERVER"

jabber:domainName = "xyzzy.example.net"

jabber:mucState = "RUNNING"

jabber:servicePortsAreRestricted = "NO"

jabber:servicePortsRestrictionInfo = _empty_array

jabber:hosts:_array_index:0 = "xyzzy.example.net"

jabber:hosts:_array_index:1 = "plugh.example.com"

jabber:setStateVersion = 1

jabber:startedTime = "2011-10-31 08:17:46 -0700"

jabber:jabberdState = "RUNNING"


This particular host has two names, it has its "native" name "xyzzy.example.net" for itself - which would be www.2gc.org in your case, and (in this case) also has an alias name "plugh.example.com"

Nov 17, 2011 6:14 AM in response to Carl Ketterling

I'm sorry to hear you have same problem.


To be candid, none of the steps outlined above actually seemed to do any good, but they hopefully eliminated possible causes.


I've not seen either here or elsewhere any sensible explanation about what might be going on, or that reliably gives any answers about my two questions (which were 'how to stop' and / or 'how to fix').


Currently jabberd is still flooding the systemlog with crud, and appears to still be in an endless loop of non-useful activity. That said,*something* that was done (but don't know what) has reduced the scale of the problem: it isn't triggering full scale crash log reports each time it restarts, so server workload is much lower than it was when this was first noticed.


I'm sure jabberd has some utility, but given that both push and ichat are turned off on the server, and jabberd doesn't seem to be able to settle down, I'm not sure why it needs to be run - but presumably OS X Server needs it for something (as it is clearly not turned off when you disable push / iChat).


I don't know where to go from here. I simply didn't understand what I was supposed to do in light of Mrhoffman's last posting sadly, and maybe that's the problem - I'm just not clever enough. But since (temporarily) we've stopped the crashlog writing the issue is less pressing, so perhaps we can live with the behaviour until a solution is found and / or we upgrade to Lion (perhaps it might go away) or the problem returns (we'll know because all the fans will go off again... ).


Of course, if you find out how to stop this I'd be very interested to know.

Nov 21, 2011 4:30 AM in response to Gavin Lawrie

Hi


Just try this:


1) stop push notification

2) enable the ical

3) enable the chat

4) re enable the push notification

5) add push notification server in ical

6) add push notification server in ichat

7) In ichat settings you have xxx.yourdomain.xxx ..... Just add yourdomain.xxx , do not remove xxx.yourdomain.xxx

8) restart the push notification server

9) restart ichat and ical

This thread has been closed by the system or the community team. You may vote for any posts you find helpful, or search the Community for additional answers.

Help! jabberd out of control

Welcome to Apple Support Community
A forum where Apple customers help each other with their products. Get started with your Apple Account.