Tomcat broken after upgrade to 4

[dotslashroot]

Hello everyone. I just upgraded to version 4 today on my FC4 box that was running Zimbra 3 perfectly for months. After the upgrade I am getting the Tomcat is not running problem. I have read numerous threads regarding this and nothing has yet fixed my issue. I have chown zimbra:zimbra on redo.log and the redolog directories. I also chown root:zimbra on both of those. I have also chmod 775 those as well. I have rebooted many times after each change and so far Tomcat does not run. Any help would be greatly appreciated!

Thanks

Lucas

[jholder]

Hi-
Well, we need slightly more information

How about the zimbra logs. Can you post:
/var/log/zimbra.log
and
/opt/zimbra/log/zimbra.log
?

[marcmac]

Look for "database schema version" errors in /opt/zimbra/log/zimbra.log - if you see them, post the file /opt/zimbra/.install_history

[FunkyPenguin]

Also check to see if there are any stale PIDs, there shouldn't be after a straight upgrade but I have had issue with erronious PIDs for Tomcat.

[dotslashroot]

Here are the logs. Thanks!

Aug 31 04:02:21 mail amavis[9929]: (09929-03) Checking: HZHHA+ro-xGZ [127.0.0.1] <root@mail.dotslashroot.net> -> <root@mail.dotslashroot.net>
Aug 31 04:02:22 mail postfix/smtpd[22414]: initializing the server-side TLS engine
Aug 31 04:02:22 mail postfix/smtpd[22414]: warning: 127.0.0.1: address not listed for hostname localhost
Aug 31 04:02:22 mail postfix/smtpd[22414]: connect from unknown[127.0.0.1]
Aug 31 04:02:22 mail postfix/smtpd[22414]: 75567137728: client=unknown[127.0.0.1]
Aug 31 04:02:22 mail postfix/cleanup[22303]: 75567137728: message-id=<200608310902.k7V929Z8021951@mail.dotslashroot.net>
Aug 31 04:02:22 mail postfix/qmgr[823]: 75567137728: from=<root@mail.dotslashroot.net>, size=2975, nrcpt=1 (queue active)
Aug 31 04:02:22 mail postfix/smtpd[22414]: disconnect from unknown[127.0.0.1]
Aug 31 04:02:22 mail amavis[9929]: (09929-03) FWD via SMTP: <root@mail.dotslashroot.net> -> <root@mail.dotslashroot.net>, 250 2.6.0 Ok, id=09929-03, from MTA([127.0.0.1]:10025): 250 Ok: queued as 75567137728
Aug 31 04:02:22 mail amavis[9929]: (09929-03) Passed CLEAN, LOCAL [127.0.0.1] [127.0.0.1] <root@mail.dotslashroot.net> -> <root@mail.dotslashroot.net>, Message-ID: <200608310902.k7V929Z8021951@mail.dotslashroot.net>, mail_id: HZHHA+ro-xGZ, Hits: -3.538, 1097 ms
Aug 31 04:02:22 mail amavis[9929]: (09929-03) extra modules loaded: Net/LDAP/Bind.pm
Aug 31 04:02:22 mail postfix/smtp[22304]: 5C314137716: to=<root@mail.dotslashroot.net>, relay=127.0.0.1[127.0.0.1], delay=1, status=sent (250 2.6.0 Ok, id=09929-03, from MTA([127.0.0.1]:10025): 250 Ok: queued as 75567137728)
Aug 31 04:02:22 mail postfix/qmgr[823]: 5C314137716: removed
Aug 31 04:02:22 mail postfix/local[22415]: 75567137728: to=<root@mail.dotslashroot.net>, relay=local, delay=0, status=sent (delivered to mailbox)
Aug 31 04:02:22 mail postfix/qmgr[823]: 75567137728: removed
Aug 31 04:02:27 mail sendmail[22318]: k7V92LYh022318: from=root, size=483, class=0, nrcpts=1, msgid=<200608310902.k7V92LYh022318@mail.dotslashroot.net>, relay=root@localhost
Aug 31 04:02:27 mail postfix/smtpd[22300]: warning: 127.0.0.1: address not listed for hostname localhost
Aug 31 04:02:27 mail postfix/smtpd[22300]: connect from unknown[127.0.0.1]
Aug 31 04:02:27 mail postfix/smtpd[22300]: setting up TLS connection from unknown[127.0.0.1]
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:before/accept initialization
Aug 31 04:02:27 mail postfix/smtpd[22300]: read from 09EAB6E8 [09EB4E70] (11 bytes => -1 (0xFFFFFFFF))
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:error in SSLv2/v3 read client hello A
Aug 31 04:02:27 mail postfix/smtpd[22300]: read from 09EAB6E8 [09EB4E70] (11 bytes => 11 (0xB))
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0000 80 7c 01 03 01 00 63 00|00 00 10                 .|....c. ...
Aug 31 04:02:27 mail postfix/smtpd[22300]: read from 09EAB6E8 [09EB4E7B] (115 bytes => -1 (0xFFFFFFFF))
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:error in SSLv2/v3 read client hello B
Aug 31 04:02:27 mail postfix/smtpd[22300]: read from 09EAB6E8 [09EB4E7B] (115 bytes => 115 (0x73))
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0000 00 00 39 00 00 38 00 00|35 00 00 16 00 00 13 00  ..9..8.. 5.......
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0010 00 0a 07 00 c0 00 00 33|00 00 32 00 00 2f 03 00  .......3 ..2../..
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0020 80 00 00 66 00 00 05 00|00 04 01 00 80 08 00 80  ...f.... ........
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0030 00 00 63 00 00 62 00 00|61 00 00 15 00 00 12 00  ..c..b.. a.......
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0040 00 09 06 00 40 00 00 65|00 00 64 00 00 60 00 00  ....@..e ..d..`..
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0050 14 00 00 11 00 00 08 00|00 06 04 00 80 00 00 03  ........ ........
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0060 02 00 80 58 30 e5 91 85|59 47 e5 06 e0 35 42 6d  ...X0... YG...5Bm
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0070 fc 52 6f                                         .Ro
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:SSLv3 read client hello A
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:SSLv3 write server hello A
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:SSLv3 write certificate A
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:SSLv3 write key exchange A
Aug 31 04:02:27 mail postfix/smtpd[22300]: SSL_accept:SSLv3 write server done A
Aug 31 04:02:27 mail postfix/smtpd[22300]: write to 09EAB6E8 [09ECFC98] (1321 bytes => 1321 (0x529))
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0000 16 03 01 00 4a 02 00 00|46 03 01 44 f6 a5 a3 0e  ....J... F..D....
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0010 e4 48 91 f8 3e 83 ce b6|81 34 4b 40 83 d0 9f b9  .H..>... .4K@....
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0020 32 e0 32 44 37 4c d4 77|f5 68 fc 20 f9 d2 92 26  2.2D7L.w .h. ...&
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0030 be 9e 68 d8 4d 67 d7 fd|cf 9d d9 49 e7 b2 ad 67  ..h.Mg.. ...I...g
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0040 47 75 6d 4d be 22 f3 f9|2d 36 19 f4 00 39 00 16  GumM.".. -6...9..
Aug 31 04:02:27 mail postfix/smtpd[22300]: 0050 03 01 03 3a 0b 00 03 36|00 03 33 00 03 30 30 82  ...:...6 ..3..00.

2006-08-31 00:00:10,799 INFO  [Timer-0] [] stats - 08/31/2006 00:00:10,,,,,,8,0.75,,,,,,,,,,,,,,165.858,0,62,41,1,359,10930,,,,,0
2006-08-31 00:01:10,797 INFO  [Timer-0] [] stats - 08/31/2006 00:01:10,,,,,,8,0.88,,,,,,,,,,,,,,165.872,0,62,41,1,359,10930,,,,,0
2006-08-31 00:02:10,806 INFO  [Timer-0] [] stats - 08/31/2006 00:02:10,,,,,,8,0.75,,,,,,,,,,,,,,165.876,0,62,41,1,359,10930,,,,,0
2006-08-31 00:03:10,803 INFO  [Timer-0] [] stats - 08/31/2006 00:03:10,,,,,,8,0.88,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:04:10,795 INFO  [Timer-0] [] stats - 08/31/2006 00:04:10,,,,,,8,0.75,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:05:10,793 INFO  [Timer-0] [] stats - 08/31/2006 00:05:10,,,,,,8,0.75,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:06:10,799 INFO  [Timer-0] [] stats - 08/31/2006 00:06:10,,,,,,8,0.38,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:07:10,794 INFO  [Timer-0] [] stats - 08/31/2006 00:07:10,,,,,,8,0.88,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:08:10,797 INFO  [Timer-0] [] stats - 08/31/2006 00:08:10,,,,,,8,0.75,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:09:10,799 INFO  [Timer-0] [] stats - 08/31/2006 00:09:10,,,,,,8,0.75,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:10:11,324 INFO  [Timer-0] [] stats - 08/31/2006 00:10:10,,,,,,8,0.75,,,,,,,,,,,,,,166.200,0,62,41,1,359,10930,,,,,0
2006-08-31 00:11:10,797 INFO  [Timer-0] [] stats - 08/31/2006 00:11:10,,,,,,8,65.88,,,,,,,,,,,,,,168.903,0,62,41,1,359,10930,,,,,0
2006-08-31 00:12:10,815 INFO  [Timer-0] [] stats - 08/31/2006 00:12:10,,,,,,8,0.63,,,,,,,,,,,,,,168.917,0,62,41,1,359,10930,,,,,0
2006-08-31 00:13:10,795 INFO  [Timer-0] [] stats - 08/31/2006 00:13:10,,,,,,8,0.75,,,,,,,,,,,,,,168.917,0,62,41,1,359,10930,,,,,0
2006-08-31 00:14:10,794 INFO  [Timer-0] [] stats - 08/31/2006 00:14:10,,,,,,8,0.63,,,,,,,,,,,,,,168.917,0,62,41,1,359,10930,,,,,0
2006-08-31 00:15:10,795 INFO  [Timer-0] [] stats - 08/31/2006 00:15:10,,,,,,8,0.75,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:16:10,813 INFO  [Timer-0] [] stats - 08/31/2006 00:16:10,,,,,,8,0.75,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:17:10,796 INFO  [Timer-0] [] stats - 08/31/2006 00:17:10,,,,,,8,0.75,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:18:10,795 INFO  [Timer-0] [] stats - 08/31/2006 00:18:10,,,,,,8,0.75,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:19:10,794 INFO  [Timer-0] [] stats - 08/31/2006 00:19:10,,,,,,8,0.75,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:20:10,816 INFO  [Timer-0] [] stats - 08/31/2006 00:20:10,,,,,,8,0.63,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:21:10,809 INFO  [Timer-0] [] stats - 08/31/2006 00:21:10,,,,,,8,1.38,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:22:10,807 INFO  [Timer-0] [] stats - 08/31/2006 00:22:10,,,,,,8,0.63,,,,,,,,,,,,,,169.241,0,62,41,1,359,10930,,,,,0
2006-08-31 00:23:10,790 INFO  [Timer-0] [] stats - 08/31/2006 00:23:10,,,,,,8,0.63,,,,,,,,,,,,,,171.944,0,62,41,1,359,10930,,,,,0
2006-08-31 00:24:10,838 INFO  [Timer-0] [] stats - 08/31/2006 00:24:10,,,,,,8,0.63,,,,,,,,,,,,,,171.957,0,62,41,1,359,10930,,,,,0
2006-08-31 00:25:10,792 INFO  [Timer-0] [] stats - 08/31/2006 00:25:10,,,,,,8,0.88,,,,,,,,,,,,,,171.957,0,62,41,1,359,10930,,,,,0
2006-08-31 00:26:10,795 INFO  [Timer-0] [] stats - 08/31/2006 00:26:10,,,,,,8,0.88,,,,,,,,,,,,,,171.957,0,62,41,1,359,10930,,,,,0
2006-08-31 00:27:10,801 INFO  [Timer-0] [] stats - 08/31/2006 00:27:10,,,,,,8,0.75,,,,,,,,,,,,,,172.281,0,62,41,1,359,10930,,,,,0
2006-08-31 00:28:10,846 INFO  [Timer-0] [] stats - 08/31/2006 00:28:10,,,,,,8,1.00,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:29:10,796 INFO  [Timer-0] [] stats - 08/31/2006 00:29:10,,,,,,8,1.25,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:30:10,801 INFO  [Timer-0] [] stats - 08/31/2006 00:30:10,,,,,,8,1.00,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:31:10,802 INFO  [Timer-0] [] stats - 08/31/2006 00:31:10,,,,,,8,0.75,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:32:10,814 INFO  [Timer-0] [] stats - 08/31/2006 00:32:10,,,,,,8,0.75,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:33:10,798 INFO  [Timer-0] [] stats - 08/31/2006 00:33:10,,,,,,8,0.50,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:34:10,796 INFO  [Timer-0] [] stats - 08/31/2006 00:34:10,,,,,,8,0.63,,,,,,,,,,,,,,172.283,0,62,41,1,359,10930,,,,,0
2006-08-31 00:35:10,797 INFO  [Timer-0] [] stats - 08/31/2006 00:35:10,,,,,,8,0.63,,,,,,,,,,,,,,174.986,0,62,41,1,359,10930,,,,,0
2006-08-31 00:36:10,850 INFO  [Timer-0] [] stats - 08/31/2006 00:36:10,,,,,,8,0.63,,,,,,,,,,,,,,175.000,0,62,41,1,359,10930,,,,,0
"zimbra.log" 3708L, 294999C

[jholder]

Are you sure those are the whole logs?

[marcmac]

I asked for /opt/zimbra/log/zimbra.log, and you posted /var/log/zimbra.log

[dotslashroot]

It must not have copied it all the first time. The board made me shorten it but I see some errors so I will post what I think is relevant. Here it is.

[root@mail log]# cat zimbra.log
[ip=192.168.10.249;] SoapEngine - handler exception
com.zimbra.cs.account.AccountServiceException: authentication failed for zimbra (empty password)
at com.zimbra.cs.account.AccountServiceException.AUTH _FAILED(AccountServiceException.java:77)
at com.zimbra.cs.account.ldap.LdapProvisioning.authAc count(LdapProvisioning.java:2065)
at com.zimbra.cs.service.admin.Auth.handle(Auth.java: 82)
at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEng ine.java:255)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.jav a:163)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.jav a:84)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.jav a:228)
at javax.servlet.http.HttpServlet.service(HttpServlet .java:709)
at com.zimbra.cs.servlet.ZimbraServlet.service(Zimbra Servlet.java:154)
at javax.servlet.http.HttpServlet.service(HttpServlet .java:802)
at org.apache.catalina.core.ApplicationFilterChain.in ternalDoFilter(ApplicationFilterChain.java:252)
at org.apache.catalina.core.ApplicationFilterChain.do Filter(ApplicationFilterChain.java:173)
at org.apache.catalina.core.StandardWrapperValve.invo ke(StandardWrapperValve.java:213)
at org.apache.catalina.core.StandardContextValve.invo ke(StandardContextValve.java:178)
at org.apache.catalina.core.StandardHostValve.invoke( StandardHostValve.java:126)
at org.apache.catalina.valves.ErrorReportValve.invoke (ErrorReportValve.java:105)
at org.apache.catalina.core.StandardEngineValve.invok e(StandardEngineValve.java:107)
at org.apache.catalina.valves.AccessLogValve.invoke(A ccessLogValve.java:541)
at org.apache.catalina.connector.CoyoteAdapter.servic e(CoyoteAdapter.java:148)
at org.apache.coyote.http11.Http11Processor.process(H ttp11Processor.java:869)
at org.apache.coyote.http11.Http11BaseProtocol$Http11 ConnectionHandler.processConnection(Http11BaseProt ocol.java:667)
at org.apache.tomcat.util.net.PoolTcpEndpoint.process Socket(PoolTcpEndpoint.java:527)
at org.apache.tomcat.util.net.LeaderFollowerWorkerThr ead.runIt(LeaderFollowerWorkerThread.java:80)
at org.apache.tomcat.util.threads.ThreadPool$ControlR unnable.run(ThreadPool.java:684)
at java.lang.Thread.run(Thread.java:595)
<snip>
2006-08-31 03:00:02,555 INFO [http-7071-Processor48] [ip=192.168.10.249;] SoapEngine - handler exception
com.zimbra.cs.account.AccountServiceException: authentication failed for zimbra (empty password)
at com.zimbra.cs.account.AccountServiceException.AUTH _FAILED(AccountServiceException.java:77)
at com.zimbra.cs.account.ldap.LdapProvisioning.authAc count(LdapProvisioning.java:2065)
at com.zimbra.cs.service.admin.Auth.handle(Auth.java: 82)
at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEng ine.java:255)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.jav a:163)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.jav a:84)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.jav a:228)
at javax.servlet.http.HttpServlet.service(HttpServlet .java:709)
at com.zimbra.cs.servlet.ZimbraServlet.service(Zimbra Servlet.java:154)
at javax.servlet.http.HttpServlet.service(HttpServlet .java:802)
at org.apache.catalina.core.ApplicationFilterChain.in ternalDoFilter(ApplicationFilterChain.java:252)
at org.apache.catalina.core.ApplicationFilterChain.do Filter(ApplicationFilterChain.java:173)
at org.apache.catalina.core.StandardWrapperValve.invo ke(StandardWrapperValve.java:213)
at org.apache.catalina.core.StandardContextValve.invo ke(StandardContextValve.java:178)
at org.apache.catalina.core.StandardHostValve.invoke( StandardHostValve.java:126)
at org.apache.catalina.valves.ErrorReportValve.invoke (ErrorReportValve.java:105)
at org.apache.catalina.core.StandardEngineValve.invok e(StandardEngineValve.java:107)
at org.apache.catalina.valves.AccessLogValve.invoke(A ccessLogValve.java:541)
at org.apache.catalina.connector.CoyoteAdapter.servic e(CoyoteAdapter.java:148)
at org.apache.coyote.http11.Http11Processor.process(H ttp11Processor.java:869)
at org.apache.coyote.http11.Http11BaseProtocol$Http11 ConnectionHandler.processConnection(Http11BaseProt ocol.java:667)
at org.apache.tomcat.util.net.PoolTcpEndpoint.process Socket(PoolTcpEndpoint.java:527)
at org.apache.tomcat.util.net.LeaderFollowerWorkerThr ead.runIt(LeaderFollowerWorkerThread.java:80)
at org.apache.tomcat.util.threads.ThreadPool$ControlR unnable.run(ThreadPool.java:684)
at java.lang.Thread.run(Thread.java:595)
<snip>
2006-08-31 10:23:31,013 INFO [main] [] StatsImageServlet - Servlet StatsImageServlet shutting down
2006-08-31 10:23:31,015 INFO [main] [] soap - Servlet AdminServlet shutting down
2006-08-31 10:23:31,015 INFO [main] [] TcpServer/7025 - LmtpServer initiating shutdown
2006-08-31 10:23:31,033 INFO [LmtpServer] [] TcpServer/7025 - finished accept loop
2006-08-31 10:23:31,076 INFO [main] [] TcpServer/7025 - LmtpServer shutting down idle thread pool
2006-08-31 10:23:31,102 INFO [main] [] TcpServer/993 - ImapSSLServer initiating shutdown
2006-08-31 10:23:31,102 INFO [main] [] TcpServer/993 - ImapSSLServer shutting down idle thread pool
2006-08-31 10:23:31,102 INFO [ImapSSLServer] [] TcpServer/993 - finished accept loop
2006-08-31 10:23:31,102 INFO [main] [] SessionCache - shutdown: clearing SessionCache
2006-08-31 10:23:31,104 INFO [IndexWritersSweeper] [] MailboxIndex - IndexWritersSweeper thread exiting
2006-08-31 10:23:31,104 INFO [main] [] MailboxIndex - Flushing all open index writers
2006-08-31 10:23:31,229 INFO [main] [] RedoLogManager - Logged: 2978 items, 6.745ms/item
2006-08-31 10:23:31,230 INFO [IncomingDirectorySweeper] [] FileBlobStore - IncomingDirectorySweeper thread exiting
2006-08-31 10:23:31,230 INFO [main] [] extensions - Destroying extensions
2006-08-31 10:23:31,288 INFO [main] [] extensions - Destroyed extension clamscanner: com.zimbra.clam.ClamScanner@com.zimb...tensio n.ZimbraExtensionClassLoader@3a835d
2006-08-31 10:23:31,289 INFO [main] [] ContentServlet - Servlet ContentServlet shutting down
2006-08-31 10:23:31,290 INFO [main] [] PublicICalServlet - Servlet PublicICalServlet shutting down
2006-08-31 10:23:31,292 INFO [main] [] soap - Servlet SoapServlet shutting down
2006-08-31 10:23:31,293 INFO [main] [] account - Servlet PreAuthServlet shutting down
2006-08-31 10:23:31,294 INFO [main] [] mailbox - Servlet UserServlet shutting down
2006-08-31 10:23:31,295 INFO [main] [] FileUploadServlet - Servlet FileUploadServlet shutting down
2006-08-31 10:40:40,908 INFO [main] [] soap - Servlet SoapServlet starting up
2006-08-31 10:40:41,000 INFO [main] [] soap - Adding service AccountService to SoapServlet
2006-08-31 10:40:41,234 INFO [main] [] soap - Adding service MailService to SoapServlet
2006-08-31 10:40:41,499 INFO [main] [] soap - Adding service IMService to SoapServlet
2006-08-31 10:40:41,525 INFO [main] [] misc - version=4.0.0_GA_303.FC4 release=20060829133700 builddate=20060829-1337 buildhost=build-fc4.liquidsys.com
2006-08-31 10:40:41,529 INFO [main] [] misc - LANG environment is set to: en_US.UTF-8
2006-08-31 10:40:41,669 INFO [main] [] DbPool - Setting mysql connector property: maxActive=16
2006-08-31 10:40:47,095 FATAL [main] [] system - Config initialization failed
com.zimbra.cs.service.ServiceException: system failure: getting database connection
at com.zimbra.cs.service.ServiceException.FAILURE(Ser viceException.java:174)
at com.zimbra.cs.db.DbPool.getConnection(DbPool.java: 295)
at com.zimbra.cs.util.Config.init(Config.java:70)
at com.zimbra.cs.util.Config.initConfig(Config.java:9 7)
at com.zimbra.cs.util.Config.getString(Config.java:10 9)
at com.zimbra.cs.db.Versions.checkDBVersion(Versions. java:85)
at com.zimbra.cs.db.Versions.checkVersions(Versions.j ava:81)
at com.zimbra.cs.util.Zimbra.startup(Zimbra.java:91)
at com.zimbra.soap.SoapServlet.init(SoapServlet.java: 115)
at javax.servlet.GenericServlet.init(GenericServlet.j ava:211)
at org.apache.catalina.core.StandardWrapper.loadServl et(StandardWrapper.java:1105)
at org.apache.catalina.core.StandardWrapper.load(Stan dardWrapper.java:932)
at org.apache.catalina.core.StandardContext.loadOnSta rtup(StandardContext.java:3915)
at org.apache.catalina.core.StandardContext.start(Sta ndardContext.java:4176)
at org.apache.catalina.core.ContainerBase.addChildInt ernal(ContainerBase.java:759)
at org.apache.catalina.core.ContainerBase.addChild(Co ntainerBase.java:739)
at org.apache.catalina.core.StandardHost.addChild(Sta ndardHost.java:524)
at org.apache.catalina.startup.HostConfig.deployDirec tory(HostConfig.java:910)
at org.apache.catalina.startup.HostConfig.deployDirec tories(HostConfig.java:873)
at org.apache.catalina.startup.HostConfig.deployApps( HostConfig.java:474)
at org.apache.catalina.startup.HostConfig.start(HostC onfig.java:1118)
at org.apache.catalina.startup.HostConfig.lifecycleEv ent(HostConfig.java:310)
at org.apache.catalina.util.LifecycleSupport.fireLife cycleEvent(LifecycleSupport.java:119)
at org.apache.catalina.core.ContainerBase.start(Conta inerBase.java:1020)
at org.apache.catalina.core.StandardHost.start(Standa rdHost.java:718)
at org.apache.catalina.core.ContainerBase.start(Conta inerBase.java:1012)
at org.apache.catalina.core.StandardEngine.start(Stan dardEngine.java:442)
at org.apache.catalina.core.StandardService.start(Sta ndardService.java:450)
at org.apache.catalina.core.StandardServer.start(Stan dardServer.java:700)
at org.apache.catalina.startup.Catalina.start(Catalin a.java:551)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Native MethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(De legatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.apache.catalina.startup.Bootstrap.start(Bootst rap.java:275)
at org.apache.catalina.startup.Bootstrap.main(Bootstr ap.java:406)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Native MethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(De legatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at com.zimbra.cs.launcher.TomcatLauncher.start(Tomcat Launcher.java:52)
at com.zimbra.cs.launcher.TomcatLauncher.main(TomcatL auncher.java:74)
Caused by: java.sql.SQLException: Server connection failure during transaction. Due to underlying exception: 'java.sql.SQLException: Access denied for user 'zimbra'@'mail.dotslashroot.net' (using password: YES)'.

** BEGIN NESTED EXCEPTION **

java.sql.SQLException
MESSAGE: Access denied for user 'zimbra'@'mail.dotslashroot.net' (using password: YES)

STACKTRACE:

java.sql.SQLException: Access denied for user 'zimbra'@'mail.dotslashroot.net' (using password: YES)
at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.ja va:2928)
at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.ja va:771)
at com.mysql.jdbc.MysqlIO.secureAuth411(MysqlIO.java: 3649)
at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:11 76)
at com.mysql.jdbc.Connection.createNewIO(Connection.j ava:2683)
at com.mysql.jdbc.Connection.<init>(Connection.java:1 485)
at com.mysql.jdbc.NonRegisteringDriver.connect(NonReg isteringDriver.java:266)
at java.sql.DriverManager.getConnection(DriverManager .java:525)
at java.sql.DriverManager.getConnection(DriverManager .java:140)
at org.apache.commons.dbcp.DriverManagerConnectionFac tory.createConnection(DriverManagerConnectionFacto ry.java:97)
at org.apache.commons.dbcp.PoolableConnectionFactory. makeObject(PoolableConnectionFactory.java:300)
at org.apache.commons.pool.impl.GenericObjectPool.bor rowObject(GenericObjectPool.java:816)
at org.apache.commons.dbcp.PoolingDriver.connect(Pool ingDriver.java:171)
at java.sql.DriverManager.getConnection(DriverManager .java:525)
at java.sql.DriverManager.getConnection(DriverManager .java:193)
at com.zimbra.cs.db.DbPool.getConnection(DbPool.java: 286)
at com.zimbra.cs.util.Config.init(Config.java:70)
at com.zimbra.cs.util.Config.initConfig(Config.java:9 7)
at com.zimbra.cs.util.Config.getString(Config.java:10 9)
at com.zimbra.cs.db.Versions.checkDBVersion(Versions. java:85)
at com.zimbra.cs.db.Versions.checkVersions(Versions.j ava:81)
at com.zimbra.cs.util.Zimbra.startup(Zimbra.java:91)
at com.zimbra.soap.SoapServlet.init(SoapServlet.java: 115)
at javax.servlet.GenericServlet.init(GenericServlet.j ava:211)
at org.apache.catalina.core.StandardWrapper.loadServl et(StandardWrapper.java:1105)
at org.apache.catalina.core.StandardWrapper.load(Stan dardWrapper.java:932)
at org.apache.catalina.core.StandardContext.loadOnSta rtup(StandardContext.java:3915)
at org.apache.catalina.core.StandardContext.start(Sta ndardContext.java:4176)
at org.apache.catalina.core.ContainerBase.addChildInt ernal(ContainerBase.java:759)
at org.apache.catalina.core.ContainerBase.addChild(Co ntainerBase.java:739)
at org.apache.catalina.core.StandardHost.addChild(Sta ndardHost.java:524)
at org.apache.catalina.startup.HostConfig.deployDirec tory(HostConfig.java:910)
at org.apache.catalina.startup.HostConfig.deployDirec tories(HostConfig.java:873)
at org.apache.catalina.startup.HostConfig.deployApps( HostConfig.java:474)
at org.apache.catalina.startup.HostConfig.start(HostC onfig.java:1118)
at org.apache.catalina.startup.HostConfig.lifecycleEv ent(HostConfig.java:310)
at org.apache.catalina.util.LifecycleSupport.fireLife cycleEvent(LifecycleSupport.java:119)
at org.apache.catalina.core.ContainerBase.start(Conta inerBase.java:1020)
at org.apache.catalina.core.StandardHost.start(Standa rdHost.java:718)
at org.apache.catalina.core.ContainerBase.start(Conta inerBase.java:1012)
at org.apache.catalina.core.StandardEngine.start(Stan dardEngine.java:442)
at org.apache.catalina.core.StandardService.start(Sta ndardService.java:450)
at org.apache.catalina.core.StandardServer.start(Stan dardServer.java:700)
at org.apache.catalina.startup.Catalina.start(Catalin a.java:551)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Native MethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(De legatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at org.apache.catalina.startup.Bootstrap.start(Bootst rap.java:275)
at org.apache.catalina.startup.Bootstrap.main(Bootstr ap.java:406)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Nativ e Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Native MethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(De legatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:585)
at com.zimbra.cs.launcher.TomcatLauncher.start(Tomcat Launcher.java:52)
at com.zimbra.cs.launcher.TomcatLauncher.main(TomcatL auncher.java:74)


** END NESTED EXCEPTION **

[marcmac]

Caused by: java.sql.SQLException: Server connection failure during transaction. Due to underlying exception: 'java.sql.SQLException: Access denied for user 'zimbra'@'mail.dotslashroot.net' (using password: YES)'.

You change your hostname, or your /etc/hosts file? You'll need to make sure that the user zimbra at the host above has access to the zimbra database, do a google on the mysql grant command. password can be found via zmlocalconfig -s | grep sql

[dotslashroot]

Nothing changed..it was running great and all I did was run the upgrade. No changes otherwise. Why would the upgrade break this? I did the command you mentioned and there are a handful of lines that mention a password...which one am I looking for? All the passwords listed look like they are encrypted. What do I do with it now that I have it? Thanks for your help!