64bit build, reset-the-world fails on LmtpInject

[buttars]

When reset-the-world tries to inject the default mail message into user1@zimbra it spits an error and fails:

inject:
[echo] Inserting default contacts: user1@zimbra.somedomain.com
[java] ----
[java]
[java]
[java]
[java] user1
[java] test123
[java]
[java]
[java]
[java] ----
[java]
[java]
[java]
[java] 0_a91f3aff22a18a8c5bdbc67cd2d732eb977e11aa_69643d3 3363a37663963643638352d383335382d343934652d6137653 62d6233643561343833393565373b6578703d31333a3131343 03132363239343833393b
[java] 172799969
[java]
[java]
[java]
[java] ----
[java] FAIL 0001 3/4 509ms AuthRequest
[echo] Creating default search folders: user1@zimbra.somedomain.com
[java] ----
[java]
[java]
[java]
[java] user1
[java] test123
[java]
[java]
[java]
[java] ----
[java]
[java]
[java]
[java] 0_3586b20feb7af7c163daeac179cafdff1dd5804d_69643d3 3363a37663963643638352d383335382d343934652d6137653 62d6233643561343833393565373b6578703d31333a3131343 03132363239353935373b
[java] 172800000
[java]
[java]
[java]
[java] ----
[java] FAIL 0001 3/4 486ms AuthRequest
[echo] Wait for lmtp host=localhost port=7025
[echo] LmtpInject messages
[java] [] INFO: connections=1 host=localhost port=7025
[java] [] INFO: Ignoring directory /home/zimbra/Development/zimbra/CRAY/ZimbraServer/data/TestMailRaw/CVS
[java] [error] Delivery failed msg=sample-rfc822.txt rcpt=user1@zimbra.somedomain.com response=554 5.0.0 Permanent message delivery failure

[java] LmtpInject Finished
[java] submitted=0 failed=1
[java] maximum concurrent active connections: 1
[java] 0.356s, 0.0ms/msg, 0.0mps
[java] average message size = 0.0KB

BUILD FAILED
/home/zimbra/Development/zimbra/CRAY/ZimbraServer/build.xml:422: Java returned: 1


any ideas?

[buttars]

From the /opt/zimbra/log/zimbra.log:

2006-02-14 14:44:38,042 INFO [LmtpServer] [] TcpServer/7025 - starting accept loop
2006-02-14 14:44:38,043 INFO [Pop3Server] [] TcpServer/7110 - starting accept loop
2006-02-14 14:44:38,050 INFO [Pop3Server] [] TcpServer/7995 - starting accept loop
2006-02-14 14:44:38,054 INFO [ImapServer] [] TcpServer/7143 - starting accept loop
2006-02-14 14:44:38,058 INFO [ImapSSLServer] [] TcpServer/7993 - starting accept loop
2006-02-14 14:44:38,066 INFO [http-7070-Processor9] [] soap - Servlet AdminServlet starting up
2006-02-14 14:44:38,163 INFO [http-7070-Processor9] [] soap - Adding service AdminService to AdminServlet
2006-02-14 14:44:38,179 INFO [http-7070-Processor9] [] soap - Adding service AccountService to AdminServlet
2006-02-14 14:44:38,179 INFO [http-7070-Processor9] [] soap - Adding service MailService to AdminServlet
2006-02-14 14:44:38,179 INFO [http-7070-Processor9] [] soap - Adding service IMService to AdminServlet
2006-02-14 14:44:38,184 INFO [http-7070-Processor9] [] ContentServlet - Servlet ContentServlet starting up
2006-02-14 14:44:38,188 INFO [http-7070-Processor9] [] PublicICalServlet - Servlet PublicICalServlet starting up
2006-02-14 14:44:38,191 INFO [http-7070-Processor9] [] account - Servlet PreAuthServlet starting up
2006-02-14 14:44:38,211 INFO [http-7070-Processor9] [] mailbox - Servlet UserServlet starting up
2006-02-14 14:44:38,219 INFO [http-7070-Processor9] [] FileUploadServlet - Servlet FileUploadServlet starting up
2006-02-14 14:44:38,223 INFO [http-7070-Processor9] [] StatsImageServlet - Servlet StatsImageServlet starting up
2006-02-14 14:44:54,936 INFO [http-7070-Processor8] [ip=127.0.0.1;] mailbox - Creating database mailbox-65533
2006-02-14 14:44:55,051 INFO [http-7070-Processor8] [ip=127.0.0.1;] mailbox - Dropping database mailbox-65533
2006-02-14 14:44:55,959 INFO [http-7070-Processor9] [ip=127.0.0.1;] mailbox - Creating database mailbox1
2006-02-14 14:44:56,315 INFO [http-7070-Processor9] [ip=127.0.0.1;] mailbox - Dropping database mailbox1
2006-02-14 14:44:56,459 INFO [LmtpServer-1] [] LmtpHandler - [127.0.0.1] connected
2006-02-14 14:44:56,467 INFO [LmtpServer-1] [] LmtpHandler - [127.0.0.1] disconnected without quit
2006-02-14 14:44:56,468 INFO [LmtpServer-1] [] ProtocolHandler - Handler exiting normally
2006-02-14 14:44:57,056 INFO [LmtpServer-2] [] LmtpHandler - [127.0.0.1] connected
2006-02-14 14:44:57,086 INFO [LmtpServer-2] [] mailbox - Creating database mailbox1
2006-02-14 14:44:57,401 INFO [LmtpServer-2] [] mailbox - Dropping database mailbox1
2006-02-14 14:44:57,426 WARN [LmtpServer-2] [] mailbox - Unrecoverable exception getting mailbox for user1@zimbra.somedomain.com
com.zimbra.cs.mailbox.MailServiceException: no such mailbox: 1
at com.zimbra.cs.mailbox.MailServiceException.NO_SUCH _MBOX(MailServiceException.java:128)
at com.zimbra.cs.db.DbMailbox.getMailboxVolumeInfo(Db Mailbox.java:328)
at com.zimbra.cs.mailbox.Mailbox.createMailbox(Mailbo x.java:1198)
at com.zimbra.cs.mailbox.Mailbox.getMailboxByAccountI d(Mailbox.java:988)
at com.zimbra.cs.mailbox.Mailbox.getMailboxByAccountI d(Mailbox.java:947)
at com.zimbra.cs.mailbox.Mailbox.getMailboxByAccount( Mailbox.java:932)
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver MessageToLocalMailboxes(ZimbraLmtpBackend.java:164 )
at com.zimbra.cs.lmtpserver.ZimbraLmtpBackend.deliver (ZimbraLmtpBackend.java:109)
at com.zimbra.cs.lmtpserver.LmtpHandler.doDATA(LmtpHa ndler.java:420)
at com.zimbra.cs.lmtpserver.LmtpHandler.processComman d(LmtpHandler.java:197)
at com.zimbra.cs.tcpserver.ProtocolHandler.processCon nection(ProtocolHandler.java:231)
at com.zimbra.cs.tcpserver.ProtocolHandler.run(Protoc olHandler.java:198)
at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Wo rker.run(Unknown Source)
at java.lang.Thread.run(Thread.java:595)
2006-02-14 14:44:57,429 INFO [LmtpServer-2] [] ZimbraLmtpBackend - rejecting message user1@zimbra.pykyo.com: account or mailbox not found
2006-02-14 14:44:57,429 INFO [LmtpServer-2] [] LmtpHandler - [127.0.0.1] 554 5.0.0 Permanent message delivery failure (DATA)
2006-02-14 14:44:57,540 INFO [LmtpServer-2] [] LmtpHandler - [127.0.0.1] quit from client
2006-02-14 14:44:57,540 INFO [LmtpServer-2] [] ProtocolHandler - Handler exiting normally

[KevinH]

Doesn't look like MySQL is happy. Did you create a zimbra//zimbra user and it's running on port 7306?

[buttars]

mysql is up and running fine on port 7306.
there is a mysql user 'zimbra'
there are no users name 'zimbra//zimbra'?

A quick look at the MySQL user table:

mysql> select user,host from user;
+--------+-----------------------+
| user | host |
+--------+-----------------------+
| zimbra | % |
| | localhost |
| root | localhost |
| zimbra | localhost |
| root | localhost.localdomain |
| zimbra | localhost.localdomain |
| | zimbra.pykyo.com |
| root | zimbra.pykyo.com |
| zimbra | zimbra.pykyo.com |
+--------+-----------------------+


And the mailbox table in the zimbra database is empty.

MySQL seems to be running fine, not so sure if everything is configured right.
Any other ideas?

[KevinH]

Sorry zimbra//zimbra meant a user called zimbra with a password zimbra.

[buttars]

there is a zimbra user with password zimbra. check.

We've been suspecting saslauthd, could that be the case? Postfix will come up but saslauthd does not. zmmtactl start gives an error message:

saslauthd[6212] :set_auth_mech : unknown authentication mechanism: zimbra

When I use the command:
zmprov ms zimbra.pykyo.com zimbraMtaAuthURL zimbra.pykyo.com
I get:
ERROR: service.INVALID_REQUEST (invalid request: zimbramtaauthurl is immutable)

Is this related?

[KevinH]

Nope. lmtp inject hits Zimbra (tomcat) directly postfix and sasl are not involved. Need to see why MySQL can't connect and create the database.