Looks like no one’s replied in a while. To start the conversation again, simply ask a new question.

iChat server suddenly stopped, now will not restart

I have a Snow Leopard Server hosting multiple email accounts and websites, file sharing, runing OD, running iCal server, and up until a few days ago running iChat server. All other functions continue to work normally, but iChat Server simply stopped one day and now won't restart. Around the same time my external Time Machine hard drive failed (ironic) and I restarted the server in an attempt investigate that failed drive. About the time of that restart, iChat server stopped working. Here is the most recent iChat Service Log from attempting to start iChat Server:


ealm=xserve.server.#####, registration disabled

Jan 21 08:48:29 xserve jabberd/c2s[63181]: [jupeman.com] configured; realm=#######.com, registration disabled

Jan 21 08:48:29 xserve jabberd/c2s[63181]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:48:29 xserve jabberd/c2s[63181]: shutting down

Jan 21 08:48:29 xserve jabberd/resolver[63177]: shutting down

Jan 21 08:48:29 xserve jabberd/s2s[63184]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:48:29 xserve jabberd/s2s[63184]: shutting down

Jan 21 08:48:29 xserve jabberd/s2s[63184]: connection to router closed

Jan 21 08:48:38 xserve org.jabber.jabberd[63176]: ERROR: sm died. Shutting down server.

Jan 21 08:48:38 xserve com.apple.launchd[1] (org.jabber.jabberd): Throttling respawn: Will start in 1 seconds

Jan 21 08:48:39 xserve jabberd/sm[63198]: starting up

Jan 21 08:48:39 xserve jabberd/sm[63198]: id: xserve.server.#####

Jan 21 08:48:39 xserve jabberd/sm[63198]: sqlite: can't open database

Jan 21 08:48:39 xserve jabberd/c2s[63201]: starting up

Jan 21 08:48:39 xserve jabberd/sm[63198]: initialisation of storage driver 'sqlite' failed

Jan 21 08:48:39 xserve jabberd/sm[63198]: failed to initialise one or more storage drivers, aborting

Jan 21 08:48:39 xserve jabberd/c2s[63201]: modules search path: /var/jabberd/modules/jabberd2

Jan 21 08:48:39 xserve jabberd/c2s[63201]: initialized auth module 'sqlite'

Jan 21 08:48:39 xserve jabberd/sm[63199]: starting up

Jan 21 08:48:39 xserve jabberd/router[63200]: starting up

Jan 21 08:48:39 xserve jabberd/resolver[63197]: starting up

Jan 21 08:48:39 xserve jabberd/sm[63199]: id: #######.com

Jan 21 08:48:39 xserve jabberd/s2s[63203]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Jan 21 08:48:39 xserve jabberd/router[63200]: loaded user table (1 users)

Jan 21 08:48:39 xserve jabberd/router[63200]: loaded filters (7 rules)

Jan 21 08:48:39 xserve jabberd/sm[63199]: sqlite: can't open database

Jan 21 08:48:39 xserve jabberd/sm[63199]: initialisation of storage driver 'sqlite' failed

Jan 21 08:48:39 xserve jabberd/sm[63199]: failed to initialise one or more storage drivers, aborting

Jan 21 08:48:39 xserve jabberd/c2s[63201]: [xserve.server.#####] configured; realm=xserve.server.#####, registration disabled

Jan 21 08:48:39 xserve jabberd/c2s[63201]: [#######.com] configured; realm=#######.com, registration disabled

Jan 21 08:48:39 xserve jabberd/resolver[63197]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:48:39 xserve jabberd/router[63200]: [127.0.0.1, port=5347] listening for incoming connections

Jan 21 08:48:39 xserve jabberd/router[63200]: [127.0.0.1, port=55886] connect

Jan 21 08:48:39 xserve jabberd/c2s[63201]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:48:39 xserve jabberd/resolver[63197]: shutting down

Jan 21 08:48:39 xserve jabberd/c2s[63201]: shutting down

Jan 21 08:48:39 xserve jabberd/router[63200]: [127.0.0.1, port=55887] connect

Jan 21 08:48:39 xserve jabberd/router[63200]: shutting down

Jan 21 08:48:39 xserve jabberd/s2s[63203]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:48:39 xserve jabberd/s2s[63203]: shutting down

Jan 21 08:48:39 xserve jabberd/s2s[63203]: connection to router closed

Jan 21 08:49:09 xserve org.jabber.jabberd[63196]: ERROR: sm died. Shutting down server.

Jan 21 08:49:09 xserve jabberd/sm[63236]: starting up

Jan 21 08:49:09 xserve jabberd/c2s[63239]: starting up

Jan 21 08:49:09 xserve jabberd/resolver[63235]: starting up

Jan 21 08:49:09 xserve jabberd/s2s[63241]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Jan 21 08:49:09 xserve jabberd/sm[63237]: starting up

Jan 21 08:49:09 xserve jabberd/router[63238]: starting up

Jan 21 08:49:09 xserve jabberd/sm[63236]: id: xserve.server.#####

Jan 21 08:49:09 xserve jabberd/c2s[63239]: modules search path: /var/jabberd/modules/jabberd2

Jan 21 08:49:09 xserve jabberd/sm[63236]: sqlite: can't open database

Jan 21 08:49:09 xserve jabberd/c2s[63239]: initialized auth module 'sqlite'

Jan 21 08:49:09 xserve jabberd/sm[63236]: initialisation of storage driver 'sqlite' failed

Jan 21 08:49:09 xserve jabberd/sm[63236]: failed to initialise one or more storage drivers, aborting

Jan 21 08:49:09 xserve jabberd/router[63238]: loaded user table (1 users)

Jan 21 08:49:09 xserve jabberd/router[63238]: loaded filters (7 rules)

Jan 21 08:49:09 xserve jabberd/sm[63237]: id: #######.com

Jan 21 08:49:09 xserve jabberd/sm[63237]: sqlite: can't open database

Jan 21 08:49:09 xserve jabberd/sm[63237]: initialisation of storage driver 'sqlite' failed

Jan 21 08:49:09 xserve jabberd/sm[63237]: failed to initialise one or more storage drivers, aborting

Jan 21 08:49:09 xserve jabberd/resolver[63235]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:09 xserve jabberd/resolver[63235]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:09 xserve jabberd/resolver[63235]: connection to router closed

Jan 21 08:49:09 xserve jabberd/resolver[63235]: attempting reconnect (3 left)

Jan 21 08:49:09 xserve jabberd/c2s[63239]: [xserve.server.#####] configured; realm=xserve.server.#####, registration disabled

Jan 21 08:49:09 xserve jabberd/c2s[63239]: [#######.com] configured; realm=#######.com, registration disabled

Jan 21 08:49:09 xserve jabberd/c2s[63239]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:09 xserve jabberd/router[63238]: [127.0.0.1, port=5347] listening for incoming connections

Jan 21 08:49:09 xserve jabberd/c2s[63239]: shutting down

Jan 21 08:49:09 xserve jabberd/router[63238]: shutting down

Jan 21 08:49:09 xserve jabberd/s2s[63241]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:09 xserve jabberd/s2s[63241]: shutting down

Jan 21 08:49:09 xserve jabberd/s2s[63241]: connection to router closed

Jan 21 08:49:11 xserve jabberd/resolver[63235]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:11 xserve jabberd/resolver[63235]: shutting down

Jan 21 08:49:18 xserve org.jabber.jabberd[63234]: ERROR: sm died. Shutting down server.

Jan 21 08:49:18 xserve com.apple.launchd[1] (org.jabber.jabberd): Throttling respawn: Will start in 1 seconds

Jan 21 08:49:19 xserve jabberd/resolver[63255]: starting up

Jan 21 08:49:19 xserve jabberd/resolver[63255]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:19 xserve jabberd/resolver[63255]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:19 xserve jabberd/resolver[63255]: connection to router closed

Jan 21 08:49:19 xserve jabberd/resolver[63255]: attempting reconnect (3 left)

Jan 21 08:49:19 xserve jabberd/sm[63256]: starting up

Jan 21 08:49:19 xserve jabberd/sm[63256]: id: xserve.server.#####

Jan 21 08:49:19 xserve jabberd/sm[63257]: starting up

Jan 21 08:49:19 xserve jabberd/sm[63256]: sqlite: can't open database

Jan 21 08:49:19 xserve jabberd/sm[63256]: initialisation of storage driver 'sqlite' failed

Jan 21 08:49:19 xserve jabberd/sm[63256]: failed to initialise one or more storage drivers, aborting

Jan 21 08:49:19 xserve jabberd/sm[63257]: id: jupeman.com

Jan 21 08:49:19 xserve jabberd/c2s[63259]: starting up

Jan 21 08:49:19 xserve jabberd/sm[63257]: sqlite: can't open database

Jan 21 08:49:19 xserve jabberd/sm[63257]: initialisation of storage driver 'sqlite' failed

Jan 21 08:49:19 xserve jabberd/c2s[63259]: modules search path: /var/jabberd/modules/jabberd2

Jan 21 08:49:19 xserve jabberd/sm[63257]: failed to initialise one or more storage drivers, aborting

Jan 21 08:49:19 xserve jabberd/c2s[63259]: initialized auth module 'sqlite'

Jan 21 08:49:19 xserve jabberd/resolver[63255]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:19 xserve jabberd/resolver[63255]: shutting down

Jan 21 08:49:19 xserve jabberd/c2s[63259]: [xserve.server.#####] configured; realm=xserve.server.boyer, registration disabled

Jan 21 08:49:19 xserve jabberd/c2s[63259]: [#######.com] configured; realm=jupeman.com, registration disabled

Jan 21 08:49:19 xserve jabberd/c2s[63259]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:19 xserve jabberd/c2s[63259]: shutting down

Jan 21 08:49:19 xserve jabberd/s2s[63261]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Jan 21 08:49:19 xserve jabberd/s2s[63261]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:19 xserve jabberd/s2s[63261]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:19 xserve jabberd/s2s[63261]: connection to router closed

Jan 21 08:49:19 xserve jabberd/s2s[63261]: attempting reconnect (3 left)

Jan 21 08:49:21 xserve jabberd/s2s[63261]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:21 xserve jabberd/s2s[63261]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:21 xserve jabberd/s2s[63261]: connection to router closed

Jan 21 08:49:21 xserve jabberd/s2s[63261]: attempting reconnect (2 left)

Jan 21 08:49:23 xserve jabberd/s2s[63261]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:23 xserve jabberd/s2s[63261]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:23 xserve jabberd/s2s[63261]: connection to router closed

Jan 21 08:49:23 xserve jabberd/s2s[63261]: attempting reconnect (1 left)

Jan 21 08:49:25 xserve jabberd/s2s[63261]: attempting connection to router at 127.0.0.1, port=5347

Jan 21 08:49:25 xserve jabberd/s2s[63261]: [4] [router] write error: Broken pipe (32)

Jan 21 08:49:25 xserve jabberd/s2s[63261]: connection to router closed

Jan 21 08:49:25 xserve jabberd/s2s[63261]: shutting down

Jan 21 08:49:25 xserve org.jabber.jabberd[63254]: ERROR: sm died. Shutting down server.

Jan 21 08:49:25 xserve com.apple.launchd[1] (org.jabber.jabberd): Throttling respawn: Will start in 4 seconds

Jan 21 08:49:29 xserve servermgrd[70]: servermgr_jabber[E]: Error -- jabberd service failed to start

Jan 21 08:49:29 xserve servermgrd[70]: servermgr_jabber[W]: some jabberd processes failed to start

Jan 21 08:49:29 xserve servermgrd[70]: servermgr_jabber[N]: waiting for jabberd to finish shutdown...

Jan 21 08:49:29 xserve servermgrd[70]: servermgr_jabber[N]: jabberd service shutdown completed.

Jan 21 08:49:29 xserve servermgrd[70]: servermgr_jabber[E]: Error -- failed to start service: jabberd



Any help would be appreciated. (I've hashed out, "#", real names)

Xserv (Early 2008), Mac OS X (10.6.8), and a few other Macs running 10.7.x

Posted on Jan 21, 2012 6:09 AM

Reply
10 replies

Jan 22, 2012 3:11 PM in response to Jupeman


Jan 21 08:49:09 xserve jabberd/sm[63236]: sqlite: can't open database

Jan 21 08:49:09 xserve jabberd/c2s[63239]: initialized auth module 'sqlite'

Jan 21 08:49:09 xserve jabberd/sm[63236]: initialisation of storage driver 'sqlite' failed

Jan 21 08:49:09 xserve jabberd/sm[63236]: failed to initialise one or more storage drivers, aborting



As a guess the database that holds all the ichat user permisson is broken or missing. It shoud be at /var/jabberd/sqlite/jabberd2.db

Jan 24, 2012 8:20 AM in response to Tim Harris

Thanks, Tim! I noticed that I did not have access permission to the directory /jabberd. As a result, I set the system admin user's permissions to read & write for that and all sub files in the directory. I then tried to restart iChat Server and here's the new error log:


Jan 24 11:15:34 xserve servermgrd[70]: servermgr_jabber[N]: waiting for jabberd to finish startup...

Jan 24 11:15:34 xserve servermgrd[70]: servermgr_jabber[N]: jabberd service startup completed.

s/jabberd2

Jan 24 11:15:36 xserve jabberd/resolver[29370]: starting up

Jan 24 11:15:36 xserve jabberd/sm[29373]: starting up

Jan 24 11:15:36 xserve jabberd/sm[29371]: starting up

Jan 24 11:15:36 xserve jabberd/s2s[29377]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Jan 24 11:15:36 xserve jabberd/sm[29373]: id: #######com

Jan 24 11:15:36 xserve jabberd/sm[29371]: id: xserve.server.#####

Jan 24 11:15:36 xserve jabberd/c2s[29375]: initialized auth module 'sqlite'

Jan 24 11:15:36 xserve jabberd/sm[29373]: sqlite: can't open database

Jan 24 11:15:36 xserve jabberd/sm[29373]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:36 xserve jabberd/sm[29373]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:36 xserve jabberd/router[29374]: loaded user table (1 users)

Jan 24 11:15:36 xserve jabberd/router[29374]: couldn't open filter file /etc/jabberd/router-filter.xml: No such file or directory

Jan 24 11:15:36 xserve jabberd/sm[29371]: sqlite: can't open database

Jan 24 11:15:36 xserve jabberd/sm[29371]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:36 xserve jabberd/sm[29371]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:36 xserve jabberd/router[29374]: [127.0.0.1, port=5347] listening for incoming connections

Jan 24 11:15:36 xserve jabberd/router[29374]: shutting down

Jan 24 11:15:36 xserve jabberd/s2s[29377]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:36 xserve jabberd/s2s[29377]: shutting down

Jan 24 11:15:36 xserve jabberd/s2s[29377]: connection to router closed

Jan 24 11:15:36 xserve jabberd/resolver[29370]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:36 xserve jabberd/resolver[29370]: shutting down

Jan 24 11:15:36 xserve jabberd/c2s[29375]: [xserve.server.#####] configured; realm=xserve.server.#####, registration disabled

Jan 24 11:15:36 xserve jabberd/c2s[29375]: [#######.com] configured; realm=jupeman.com, registration disabled

Jan 24 11:15:36 xserve jabberd/c2s[29375]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:36 xserve jabberd/c2s[29375]: shutting down

Jan 24 11:15:47 xserve org.jabber.jabberd[29367]: ERROR: sm died. Shutting down server.

Jan 24 11:15:47 xserve jabberd/sm[29573]: starting up

Jan 24 11:15:47 xserve jabberd/sm[29573]: id: xserve.server.#####

Jan 24 11:15:47 xserve jabberd/resolver[29572]: starting up

Jan 24 11:15:47 xserve jabberd/sm[29574]: starting up

Jan 24 11:15:47 xserve jabberd/sm[29574]: id: jupeman.com

Jan 24 11:15:47 xserve jabberd/sm[29573]: sqlite: can't open database

Jan 24 11:15:47 xserve jabberd/sm[29573]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:47 xserve jabberd/sm[29573]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:47 xserve jabberd/sm[29574]: sqlite: can't open database

Jan 24 11:15:47 xserve jabberd/sm[29574]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:47 xserve jabberd/sm[29574]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:47 xserve jabberd/c2s[29576]: starting up

Jan 24 11:15:47 xserve jabberd/c2s[29576]: modules search path: /var/jabberd/modules/jabberd2

Jan 24 11:15:47 xserve jabberd/c2s[29576]: initialized auth module 'sqlite'

Jan 24 11:15:47 xserve jabberd/resolver[29572]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:47 xserve jabberd/c2s[29576]: [xserve.server.#####] configured; realm=xserve.server.#####, registration disabled

Jan 24 11:15:47 xserve jabberd/resolver[29572]: shutting down

Jan 24 11:15:47 xserve jabberd/c2s[29576]: [#######.com] configured; realm=#######.com, registration disabled

Jan 24 11:15:47 xserve jabberd/c2s[29576]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:47 xserve jabberd/c2s[29576]: shutting down

Jan 24 11:15:56 xserve com.apple.launchd[1] (org.jabber.jabberd): Throttling respawn: Will start in 1 seconds

Jan 24 11:15:57 xserve jabberd/resolver[29605]: starting up

Jan 24 11:15:57 xserve jabberd/sm[29607]: starting up

Jan 24 11:15:57 xserve jabberd/sm[29606]: starting up

Jan 24 11:15:57 xserve jabberd/sm[29607]: id: #######.com

Jan 24 11:15:57 xserve jabberd/sm[29606]: id: xserve.server.#####

Jan 24 11:15:57 xserve jabberd/router[29608]: starting up

Jan 24 11:15:57 xserve jabberd/c2s[29609]: starting up

Jan 24 11:15:57 xserve jabberd/c2s[29609]: modules search path: /var/jabberd/modules/jabberd2

Jan 24 11:15:57 xserve jabberd/s2s[29611]: starting up (interval=60, queue=60, keepalive=0, idle=86400)

Jan 24 11:15:57 xserve jabberd/sm[29607]: sqlite: can't open database

Jan 24 11:15:57 xserve jabberd/sm[29607]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:57 xserve jabberd/sm[29606]: sqlite: can't open database

Jan 24 11:15:57 xserve jabberd/sm[29607]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:57 xserve jabberd/sm[29606]: initialisation of storage driver 'sqlite' failed

Jan 24 11:15:57 xserve jabberd/sm[29606]: failed to initialise one or more storage drivers, aborting

Jan 24 11:15:57 xserve jabberd/router[29608]: loaded user table (1 users)

Jan 24 11:15:57 xserve jabberd/router[29608]: couldn't open filter file /etc/jabberd/router-filter.xml: No such file or directory

Jan 24 11:15:57 xserve jabberd/c2s[29609]: initialized auth module 'sqlite'

Jan 24 11:15:57 xserve jabberd/s2s[29611]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:57 xserve jabberd/resolver[29605]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:57 xserve jabberd/router[29608]: [127.0.0.1, port=5347] listening for incoming connections

Jan 24 11:15:57 xserve jabberd/c2s[29609]: [xserve.server.boyer] configured; realm=xserve.server.#####, registration disabled

Jan 24 11:15:57 xserve jabberd/router[29608]: shutting down

Jan 24 11:15:57 xserve jabberd/s2s[29611]: shutting down

Jan 24 11:15:57 xserve jabberd/c2s[29609]: [#######.com] configured; realm=#######.com, registration disabled

Jan 24 11:15:57 xserve jabberd/s2s[29611]: connection to router closed

Jan 24 11:15:57 xserve jabberd/resolver[29605]: shutting down

Jan 24 11:15:57 xserve jabberd/c2s[29609]: attempting connection to router at 127.0.0.1, port=5347

Jan 24 11:15:57 xserve jabberd/c2s[29609]: shutting down


I see the errors related to not finding a .xml file and the failed initialization of sqlite storage driver, but I don't know how to fix these. Any ideas?

Feb 2, 2012 9:16 AM in response to Jupeman

OK - as you have masked over some details on the logs, it's have to tell what the issue is.

it seems you are hosting multiple 'host' domains for ichat?

Don't worry about the problems with errors o XML files - the iChat server will not care about them.

Take a look in the files (may be more than one) sm.xml located in etc/jabberd/ and ensure that the location for the jabberd2.db is correct. the text below is what it should look like and is about 1/3 of the way in.


<!-- SQLite driver configuration -->

<sqlite>

<!-- Database name -->

<dbname>/private/var/jabberd/sqlite/jabberd2.db</dbname>


If that is correct - the move jabberd2.db to jabberd2.dba.notherold

then restart ichat server and it should build a new DB... let me know you get on,


tim

Feb 2, 2012 5:10 PM in response to Tim Harris

hmm, in sm.xml it says:


<!-- SQLite driver configuration -->

<sqlite>

<!-- Database name -->

<dbname>/Volumes/XServe_1/ServiceData/Jabber/jabberd2.db</dbname>


There is a second sm file, sm_#####.com.xml that reads the same way.


I am only attempting to host one domain. The other hashes are just blanking out the primary zone name of my server.


Thanks for the continued help!


iChat server suddenly stopped, now will not restart

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