Page 1 of 2 12 LastLast
Results 1 to 10 of 18

Thread: postfix stops working under Mac OS X Leopard (proxymap/LDAP issue)

  1. #1
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default postfix stops working under Mac OS X Leopard (proxymap/LDAP issue)

    We have a severe problem that is actually preventing us to migrate our old Sun iPlanet 5.2 server to Zimbra 5.
    Whe had two Xserve G5 where we tested for 4 months zcs-4.5.10_GA_1575.MACOSX with Mac OS X Tiger and all things went fine, so we decided to install the new version zcs-5.0.10_GA_2609.MACOSXx86_10.5 on two Xserve Intel with two 2.8 GHz quad-core servers and 4 Gb RAM each and running Leopard 10.5.5.
    Our intent was to switch them as production servers after some weeks of testing with ZCS 5, but we are actually disappointed by the behavior of the Zimbra's postfix.
    Just to give an idea of our scenario, we actually have more than 4.000 users and our company receives 2 millions of messages per day; we luckily have a Sophos antivirus/antispam appliance as our domain's primary MX and it blocks 1.9 milliions of them as spam and unwanted connections, the remaining messages are 80-90% spam and 10-20% legal email.
    Given our number of users and mail volume we decided to install zimbra on 2 servers: one as a ldap_master, mta_main with antispam, another as a ldap_replica, mta_backup (via MX records) and mailbox server.
    So we created a few accounts and mailing lists on the zimbra servers and reconfigured the Sophos appliance to forward the filtered messages to the Zimbra servers; they properly catch the messages directed to their users and mailing lists and forward all the other mail traffic to our old iPlanet server (we modified the domain parameters zimbraMailTransport, zimbraMailCatchAllAddress, zimbraMailCatchAllForwardingAddress).
    All things seemed to work fine when all of a sudden the postfix service stopped working on both servers. We tried all: run zmfixperms, disabled TLS with zmlocalconfig -e ldap_starttls_supported=0, reinstalled the SSL certificates, checked the max number of open processes in /etc/sysctl.conf and /etc/launchd.conf, raised the max number of open files by adding ulimit -n 524288 in /etc/profile, uninstalled and reinstalled the whole zimbra stuff, but to no avail.
    What we actually see is that after a random time (maybe 10 minutes or 10 hours) postfix stops working and the only thing we can do to make it work again is to issue zmcontrol stop && zmcontrol start.
    In zimbra.log we have these error messages
    Oct 25 01:17:55 xxx.xxx.101.21 mail1 postfix/proxymap[63785]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 25 01:17:55: --- last message repeated 2 times ---
    Oct 25 01:17:55 xxx.xxx.101.21 mta postfix/trivial-rewrite[63784]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    Oct 25 01:17:55 xxx.xxx.101.21 mta postfix/proxymap[63785]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 25 01:17:55: --- last message repeated 2 times ---
    Oct 25 01:17:55 xxx.xxx.101.22 mail1 postfix/trivial-rewrite[63786]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    Oct 25 01:17:55 xxx.xxx.101.22 mail1 postfix/proxymap[63785]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 25 01:17:55: --- last message repeated 2 times ---
    Oct 25 01:17:55 xxx.xxx.101.21 mta postfix/trivial-rewrite[63787]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    Oct 25 01:17:55 xxx.xxx.101.21 mta postfix/proxymap[63785]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 25 01:17:55: --- last message repeated 2 times ---
    Oct 25 01:17:55 xxx.xxx.101.22 mail1 postfix/trivial-rewrite[63788]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    Oct 25 01:17:55 xxx.xxx.101.22 mail1 postfix/proxymap[63785]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 25 01:17:55 xxx.xxx.101.22 mail1 postfix/proxymap[63785]: fatal: too many errors - program terminated
    I noticed that just before the time we get those errors I also have these messages in the log file:
    Oct 25 01:17:43 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com sasl changed from running to stopped
    Oct 25 01:17:43 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com stats changed from running to stopped
    Oct 25 01:17:43 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com antispam changed from running to stopped
    Oct 25 01:17:44 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com mailboxd changed from running to stopped
    Oct 25 01:17:44 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com mta changed from running to stopped
    Oct 25 01:17:45 mta zimbramon[35312]: 35312:err: Service status change: mta.mycompany.com mailbox changed from running to stopped
    Oct 25 01:17:47 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com sasl changed from running to stopped
    Oct 25 01:17:48 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com stats changed from running to stopped
    Oct 25 01:17:48 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com antispam changed from running to stopped
    Oct 25 01:17:48 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com mailboxd changed from running to stopped
    Oct 25 01:17:49 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com mta changed from running to stopped
    Oct 25 01:17:49 xxx.xxx.101.22 mail1 zimbramon[25265]: 25265:err: Service status change: mail1.mycompany.com mailbox changed from running to stopped
    The ldap service continues to work fine on both servers (we can query both with ldapsearch also from a remote host) while postfix is in this errored state, so the problem is definitely in postfix/proxymap.
    As an addition, also consider that after postfix stops working I see a lot of such messages in the log:
    Oct 25 01:29:12 xxx.xxx.101.22 mail1 postfix/postdrop[14998]: warning: mail_queue_enter: create file maildrop/331796.14998: Permission denied
    Oct 25 01:29:12 xxx.xxx.101.22 mail1 postfix/postdrop[12958]: warning: mail_queue_enter: create file maildrop/335410.12958: Permission denied
    Oct 25 01:29:12 xxx.xxx.101.22 mail1 postfix/postdrop[13534]: warning: mail_queue_enter: create file maildrop/336016.13534: Permission denied
    Oct 25 01:29:12 xxx.xxx.101.22 mail1 postfix/postdrop[13338]: warning: mail_queue_enter: create file maildrop/337388.13338: Permission denied
    and I see that this happens because the zimbra postfix's postdrop process (I am sure it's the zimbra one, not the system postfix's postdrop) tries to spool some error messages in /var/spool/postfix (the system postfix's queue_directory) ... don't know if this is related with the previous proxymap/ldap issue, but why does it happen, shouldn't the simbra prostfix processes always spool their messages in the /opt/zimbra/data/postfix/spool directory, given that queue_directory is properly configured in the zimbra config?
    Before someone points me in that direction, I have read about Bug 29395, but its resolution is actually set to "Fixed". BTW I have posted a comment in bugzilla with a link to this post.

    Edit: Bug 29395 seems to be not strictly related to this problem, so I opened a new bug:
    Bug 32613: postfix and amavis randomly stop working - Can't contact LDAP server
    Last edited by fab; 10-27-2008 at 10:08 AM. Reason: new bug filed

  2. #2
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default

    Just one more thing: when the zimbra postfix complains that it can't write to the /var/spool/postfix/maildrop directory, if I set the permissions of that dir to 777 then zimbra starts putting there some error messages like this:
    CO 485 190 1 0 485T1224645973 479487Acreate_time=1224677203Arewrite_context=loca lFSystem AdministratorSroot@mta.mydomain.comMN2Received: by mta.mydomain.com (Postfix, from userid 0)N7 id 7842E61CE91; Wed, 22 Oct 2008 05:26:13 +0200 (CEST)NTo: root@mta.mydomain.comNFrom: 502@mta.mydomain.comN6Subject: *** SECURITY information for mta.mydomain.com ***N5Message-Id: <20081022120643.7842E61CE91@mta.mydomain.com>N,Dat e: Wed, 22 Oct 2008 05:26:13 +0200 (CEST)NN?mta.mydomain.com : Oct 22 05:26:13 : 502 : uid 502 does not exist in the passwd file! ; TTY=unknown ; PWD=unknown ; USER=root ; COMMAND=/opt/zimbra/libexec/zmmailboxdmgrNXOrootRroot@mta.mydomain.comE
    Last edited by fab; 10-25-2008 at 05:26 PM.

  3. #3
    quanah is offline Zimbra Employee
    Join Date
    May 2007
    Location
    Zimbra
    Posts
    1,265
    Rep Power
    10

    Default

    Several questions:

    (a) What state do you see for the various processes that Zimbra is reporting have changed from running to stopped?

    (b) What kind of load does the system report?

    (c) How many total processes does the system report are running?

    (d) How many total processes are reported running by the postfix user?

    (e) Are you using any sort of remote user settings on your mac (like nss_ldap, etc)?

    Thanks,
    Quanah
    Quanah Gibson-Mount
    Server Architect
    Zimbra, Inc
    --------------------
    Zimbra :: the leader in open source messaging and collaboration

  4. #4
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default answer to quanah - part 1

    Quote Originally Posted by quanah View Post
    Several questions:
    (a) What state do you see for the various processes that Zimbra is reporting have changed from running to stopped?

    I forgot to write that zmcontrol status always reports that all services are in "Running" state, but the mta portion obviously doesn't work.

    (b) What kind of load does the system report?

    The system is not overloaded and remains responsive, even a "top" doesn't show high load on both the CPUs neither we have an high RAM usage.

    (c) How many total processes does the system report are running?

    When postfix falls in that "errored" state we have the usual system processes plus the zimbra ones, the only eerie processes are a lot of smtpd (see below).
    Below you can find the first lines of a top issued on the mta server:
    Processes: 103 total, 5 running, 98 sleeping... 385 threads 08:32:08
    Load Avg: 0.37, 0.23, 0.18 CPU usage: 0.35% user, 0.94% sys, 98.71% idle
    SharedLibs: num = 8, resident = 60M code, 248K data, 4620K linkedit.
    MemRegions: num = 20529, resident = 796M + 15M private, 172M shared.
    PhysMem: 460M wired, 1039M active, 160M inactive, 1669M used, 2427M free.
    VM: 6255M + 371M 401781(0) pageins, 0(0) pageouts
    while this is from the mail1 server:
    Processes: 102 total, 5 running, 97 sleeping... 370 threads 08:31:40
    Load Avg: 0.16, 0.19, 0.17 CPU usage: 0.35% user, 1.17% sys, 98.48% idle
    SharedLibs: num = 7, resident = 24M code, 372K data, 2848K linkedit.
    MemRegions: num = 19812, resident = 887M + 14M private, 135M shared.
    PhysMem: 565M wired, 1071M active, 1393M inactive, 3030M used, 1066M free.
    VM: 5938M + 371M 296812(0) pageins, 43(0) pageouts
    When you read the memory usage, consider only that on Mac OS X the portion of RAM that's really used is given from wired+active

    Below you can also find a full list of the processes running on the mta server:
    USER PID PPID TIME %CPU %MEM STARTED COMMAND
    root 1 0 0:57.83 0.0 0.0 Thu03PM /sbin/launchd
    root 31 1 0:00.77 0.0 0.0 Thu03PM /usr/libexec/kextd
    root 32 1 16:46.06 0.1 0.1 Thu03PM /usr/sbin/DirectoryService
    root 33 1 0:32.62 0.0 0.0 Thu03PM /usr/sbin/notifyd
    root 34 1 14:54.61 0.0 0.0 Thu03PM /usr/sbin/syslogd
    root 35 1 3:03.36 0.0 0.0 Thu03PM /usr/sbin/configd
    daemon 36 1 0:39.37 0.0 0.0 Thu03PM /usr/sbin/distnoted
    _mdnsresponder 37 1 0:05.88 0.0 0.0 Thu03PM /usr/sbin/mDNSResponder -launchd
    root 42 1 0:15.68 0.0 0.0 Thu03PM /usr/sbin/securityd -i
    root 46 1 0:10.65 0.0 0.0 Thu03PM /usr/sbin/ntpd -n -g -p /var/run/ntpd.pid -f /var/db/ntp.drift
    root 49 1 0:00.00 0.0 0.0 Thu03PM getty serial.57600 tty.serial
    root 50 1 0:04.24 0.0 0.0 Thu03PM xsand
    root 51 1 0:03.79 0.0 0.0 Thu03PM watchdogtimerd
    root 52 1 3:56.67 0.0 0.0 Thu03PM /usr/sbin/update
    root 53 1 0:00.01 0.0 0.0 Thu03PM /sbin/SystemStarter
    root 56 1 16:43.13 0.0 1.3 Thu03PM servermgrd -x
    root 58 1 0:00.03 0.0 0.0 Thu03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/Support/RFBRegisterMDNS
    root 59 1 6:56.03 0.0 0.9 Thu03PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Support/mds
    root 61 1 0:00.00 0.0 0.0 Thu03PM /usr/sbin/KernelEventAgent
    root 63 1 29:34.51 0.1 0.1 Thu03PM hwmond
    root 64 1 0:00.01 0.0 0.0 Thu03PM /usr/libexec/hidd
    root 66 1 0:28.06 0.0 0.0 Thu03PM /System/Library/Frameworks/CoreServices.framework/Versions/A/Frameworks/CarbonCore.framework/Versions/A/Support/fseventsd
    root 68 1 1:08.44 0.0 0.0 Thu03PM /sbin/emond
    root 69 1 0:00.00 0.0 0.0 Thu03PM /sbin/dynamic_pager -F /private/var/vm/swapfile
    root 71 1 0:07.17 0.0 0.0 Thu03PM /usr/sbin/diskarbitrationd
    root 75 1 0:00.01 0.0 0.0 Thu03PM autofsd
    root 94 50 1:15.87 0.0 0.0 Thu03PM fsmpm -- -- /Library/Filesystems/Xsan/debug/fsmpm-sync.50 1800
    root 98 1 0:00.61 0.0 0.1 Thu03PM /System/Library/CoreServices/coreservicesd
    _atsserver 102 1 0:00.42 0.0 0.0 Thu03PM /System/Library/Frameworks/ApplicationServices.framework/Frameworks/ATS.framework/Support/ATSServer
    root 104 1 0:10.41 0.0 0.0 Thu03PM /usr/sbin/kdcmond -n -a
    root 118 104 0:00.02 0.0 0.0 Thu03PM /usr/sbin/krb5kdc -n -r LKDC:SHA1.CE0581B6A723FD436166BACD7A8303BD5AFF39E0
    nobody 121 1 0:23.95 0.0 0.1 Thu03PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Versions/A/Support/mdworker MDSImporterWorker com.apple.Spotlight.ImporterWorker.-2
    root 131 1 0:00.00 0.0 0.0 Thu03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/Support/VNCPrivilegeProxy
    root 133 1 0:02.01 0.0 0.0 Thu03PM /usr/sbin/serialnumberd
    root 137 1 0:23.45 0.0 0.0 Thu03PM /System/Library/PrivateFrameworks/CoreRAID.framework/Resources/CoreRAIDServer
    daemon 150 1 0:00.00 0.0 0.0 Thu03PM /usr/sbin/portmap
    root 285 1 1:21.71 0.0 0.9 Thu03PM /usr/sbin/named -f
    root 1605 1 0:00.13 0.0 0.0 Fri03PM /usr/sbin/coreaudiod
    zimbra 2804 1 0:45.60 0.0 0.2 Thu03PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Versions/A/Support/mdworker MDSImporterWorker com.apple.Spotlight.ImporterWorker.502
    _cyrus 4252 1 2:02.79 0.0 0.0 Fri03PM cyrus-quota -q
    root 4806 1 0:01.49 0.0 0.1 Fri03PM /System/Library/CoreServices/loginwindow.app/Contents/MacOS/loginwindow console
    _windowserver 4807 1 0:37.15 0.0 0.3 Fri03PM /System/Library/Frameworks/ApplicationServices.framework/Frameworks/CoreGraphics.framework/Resources/WindowServer -daemon
    nobody 4810 1 0:02.09 0.0 0.1 Fri03PM /System/Library/CoreServices/RemoteManagement/ARDAgent.app/Contents/MacOS/ARDAgent
    root 4811 1 0:00.01 0.0 0.0 Fri03PM /usr/sbin/UserEventAgent -l LoginWindow
    root 4813 4806 0:03.45 0.0 0.4 Fri03PM /System/Library/CoreServices/ManagedClient.app/Contents/MacOS/ManagedClient -s
    nobody 4814 4810 0:00.26 0.0 0.1 Fri03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/MacOS/AppleVNCServer
    root 4815 42 0:00.18 0.0 0.0 Fri03PM /System/Library/CoreServices/SecurityAgent.app/Contents/Resources/authorizationhost
    _securityagent 4817 42 16:47.33 0.2 0.4 Fri03PM /System/Library/CoreServices/SecurityAgent.app/Contents/MacOS/SecurityAgent
    root 8738 1 0:02.07 0.0 0.0 Thu03PM /usr/sbin/cron
    root 23227 1 0:05.09 0.0 0.3 Thu04PM /usr/sbin/httpd -D FOREGROUND
    zimbra 23228 23227 0:02.10 0.0 0.1 Thu04PM /usr/sbin/httpd -D FOREGROUND
    zimbra 23448 23227 0:02.12 0.0 0.1 Thu04PM /usr/sbin/httpd -D FOREGROUND
    zimbra 47369 1 0:00.01 0.0 0.0 Thu06PM /usr/bin/perl /usr/local/bin/zcs start
    _postfix 48988 67763 0:00.01 0.0 0.0 7:14AM pickup -l -t fifo -u
    _postfix 50940 67763 0:00.02 0.0 0.0 1:10AM tlsmgr -l -t unix -u
    _postfix 64127 67763 0:00.11 0.0 0.0 8:12AM showq -t unix -u
    zimbra 66554 1 1:28.76 0.0 0.7 Sun02AM /opt/zimbra/openldap/libexec/slapd -l LOCAL0 -4 -u zimbra -h ldap://mta.mydomain.com:389 -f /opt/zimbra/conf/slapd.conf
    zimbra 66899 1 0:00.02 0.0 0.0 Sun02AM /bin/sh /opt/zimbra/logger/mysql/bin/mysqld_safe --defaults-file=/opt/zimbra/conf/my.logger.cnf --external-locking --log-error=/opt/zimbra/log/logger_mysql_error.log --ledir=/opt/zimbra/logger/mysql/libexec
    zimbra 66905 1 0:00.06 0.0 0.1 Sun02AM /usr/bin/perl /opt/zimbra/libexec/logswatch --config-file=/opt/zimbra/conf/logswatchrc --use-cpan-file-tail --script-dir=/tmp -t /var/log/zimbra.log
    zimbra 66973 66899 1:31.64 0.0 0.5 Sun02AM /opt/zimbra/logger/mysql/libexec/mysqld --defaults-file=/opt/zimbra/conf/my.logger.cnf --basedir=/opt/zimbra/logger/mysql --datadir=/opt/zimbra/logger/db/data --pid-file=/opt/zimbra/logger/db/mysql.pid --port=7307 --socket=/opt/zimbra/logger/db/mysql.sock --external-locking
    zimbra 67043 1 1:46.49 0.0 0.1 Sun02AM /usr/bin/perl /opt/zimbra/libexec/zmmtaconfig
    zimbra 67053 1 0:00.02 0.0 0.0 Sun02AM /bin/sh /opt/zimbra/mysql/bin/mysqld_safe --defaults-file=/opt/zimbra/conf/my.cnf --external-locking --log-error=/opt/zimbra/log/mysql_error.log --ledir=/opt/zimbra/mysql/libexec
    zimbra 67124 67053 0:28.56 0.0 1.3 Sun02AM /opt/zimbra/mysql/libexec/mysqld --defaults-file=/opt/zimbra/conf/my.cnf --basedir=/opt/zimbra/mysql --datadir=/opt/zimbra/db/data --pid-file=/opt/zimbra/db/mysql.pid --port=7306 --socket=/opt/zimbra/db/mysql.sock --external-locking
    root 67436 1 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/libexec/zmmailboxdmgr start -Xms1515m -Xmx1515m -client -XX:NewRatio=2 -Djava.awt.headless=true -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -XX:+UseParallelGC -Xss256k
    zimbra 67437 67436 1:37.55 0.0 10.0 Sun02AM /usr/bin/java -Xms1515m -Xmx1515m -client -XX:NewRatio=2 -Djava.awt.headless=true -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -XX:+UseParallelGC -Xss256k -Djava.io.tmpdir=/opt/zimbra/mailboxd/work -Djava.library.path=/opt/zimbra/lib -Djava.endorsed.dirs=/opt/zimbra/mailboxd/common/endorsed -Dzimbra.config=/opt/zimbra/conf/localconfig.xml -Djetty.home=/opt/zimbra/mailboxd -DSTART=/opt/zimbra/mailboxd/etc/start.config -jar /opt/zimbra/mailboxd/start.jar /opt/zimbra/mailboxd/etc/jetty.properties /opt/zimbra/mailboxd/etc/jetty-setuid.xml /opt/zimbra/mailboxd/etc/jetty.xml
    zimbra 67474 1 0:01.61 0.0 0.7 Sun02AM amavisd (master)
    zimbra 67475 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67476 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67477 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67478 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67479 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67480 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67481 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67482 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67483 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67484 67474 0:00.01 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 67490 1 0:00.06 0.0 0.1 Sun02AM /usr/bin/perl /opt/zimbra/libexec/swatch --config-file=/opt/zimbra/conf/swatchrc --use-cpan-file-tail --script-dir=/tmp -t /var/log/zimbra.log
    _postfix 67602 67763 0:00.01 0.0 0.0 8:25AM qmgr -l -t fifo -u
    root 67763 1 0:09.44 0.0 0.0 Sun02AM /opt/zimbra/postfix/libexec/master
    zimbra 67781 1 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 67785 67781 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 67786 67781 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 67787 67781 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 67788 67781 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 67835 1 0:15.52 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-proc
    zimbra 67837 1 0:00.60 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-cpu
    zimbra 67839 1 0:00.62 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-vm
    zimbra 67841 1 0:00.59 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io -x
    zimbra 67843 1 0:08.49 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mysql
    zimbra 67845 1 0:03.82 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mtaqueue
    zimbra 67945 67837 0:02.16 0.0 0.0 Sun02AM /usr/sbin/iostat -d -C -K -w 30
    zimbra 67950 67841 0:02.61 0.0 0.0 Sun02AM /usr/sbin/iostat -d -K -w 30
    zimbra 67966 67839 0:00.16 0.0 0.0 Sun02AM /usr/bin/vm_stat 30
    root 68457 1 0:00.06 0.0 0.0 8:28AM /usr/sbin/sshd -i
    zimbra 84974 66905 0:05.95 0.0 0.1 3:15AM /usr/bin/perl /tmp/.swatch_script.66905
    zimbra 84977 67490 0:05.87 0.0 0.2 3:15AM /usr/bin/perl /tmp/.swatch_script.67490
    zimbra 85152 84974 0:01.09 0.0 0.1 3:15AM /usr/bin/perl /opt/zimbra/libexec/zmlogger
    root 68488 68465 0:00.00 0.0 0.0 8:29AM ps axwwo user

  5. #5
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default answer to quanah - part 2

    and on the mail1 server
    USER PID PPID TIME &#37;CPU %MEM STARTED COMMAND
    root 1 0 0:55.00 0.0 0.0 Thu03PM /sbin/launchd
    root 31 1 0:00.80 0.0 0.0 Thu03PM /usr/libexec/kextd
    root 32 1 17:18.35 0.3 0.1 Thu03PM /usr/sbin/DirectoryService
    root 33 1 0:27.69 0.0 0.0 Thu03PM /usr/sbin/notifyd
    root 34 1 8:47.19 0.0 0.0 Thu03PM /usr/sbin/syslogd
    root 35 1 3:01.67 0.0 0.0 Thu03PM /usr/sbin/configd
    daemon 36 1 0:34.98 0.0 0.0 Thu03PM /usr/sbin/distnoted
    _mdnsresponder 37 1 0:05.74 0.0 0.0 Thu03PM /usr/sbin/mDNSResponder -launchd
    root 42 1 0:15.80 0.0 0.0 Thu03PM /usr/sbin/securityd -i
    root 46 1 0:10.72 0.0 0.0 Thu03PM /usr/sbin/ntpd -n -g -p /var/run/ntpd.pid -f /var/db/ntp.drift
    root 48 1 0:00.01 0.0 0.0 Thu03PM getty serial.57600 tty.serial
    root 49 1 0:04.34 0.0 0.0 Thu03PM xsand
    root 50 1 0:03.86 0.0 0.0 Thu03PM watchdogtimerd
    root 51 1 6:06.82 0.0 0.0 Thu03PM /usr/sbin/update
    root 52 1 0:00.01 0.0 0.0 Thu03PM /sbin/SystemStarter
    root 55 1 3:16.61 0.0 1.3 Thu03PM servermgrd -x
    root 57 1 0:00.03 0.0 0.0 Thu03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/Support/RFBRegisterMDNS
    root 58 1 3:22.64 0.0 0.5 Thu03PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Support/mds
    root 59 1 0:02.11 0.0 0.1 Thu03PM /System/Library/CoreServices/loginwindow.app/Contents/MacOS/loginwindow console
    root 60 1 0:00.01 0.0 0.0 Thu03PM /usr/sbin/KernelEventAgent
    root 62 1 30:03.75 0.1 0.1 Thu03PM hwmond
    root 63 1 0:00.01 0.0 0.0 Thu03PM /usr/libexec/hidd
    root 65 1 0:19.93 0.0 0.0 Thu03PM /System/Library/Frameworks/CoreServices.framework/Versions/A/Frameworks/CarbonCore.framework/Versions/A/Support/fseventsd
    root 67 1 1:09.36 0.0 0.0 Thu03PM /sbin/emond
    root 68 1 0:00.01 0.0 0.0 Thu03PM /sbin/dynamic_pager -F /private/var/vm/swapfile
    root 70 1 0:05.46 0.0 0.0 Thu03PM /usr/sbin/diskarbitrationd
    root 74 1 0:00.01 0.0 0.0 Thu03PM autofsd
    root 82 1 0:02.21 0.0 0.1 Thu03PM /System/Library/CoreServices/coreservicesd
    root 96 49 1:15.77 0.0 0.0 Thu03PM fsmpm -- -- /Library/Filesystems/Xsan/debug/fsmpm-sync.49 1800
    root 97 1 0:10.63 0.0 0.0 Thu03PM /usr/sbin/kdcmond -n -a
    _atsserver 112 1 0:00.32 0.0 0.0 Thu03PM /System/Library/Frameworks/ApplicationServices.framework/Frameworks/ATS.framework/Support/ATSServer
    root 113 97 0:00.02 0.0 0.0 Thu03PM /usr/sbin/krb5kdc -n -r LKDC:SHA1.CE0581B6A723FD436166BACD7A8303BD5AFF39E0
    root 115 1 0:02.08 0.0 0.0 Thu03PM /usr/sbin/serialnumberd
    _windowserver 116 1 0:50.45 0.0 0.3 Thu03PM /System/Library/Frameworks/ApplicationServices.framework/Frameworks/CoreGraphics.framework/Resources/WindowServer -daemon
    nobody 117 1 0:18.75 0.0 0.1 Thu03PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Versions/A/Support/mdworker MDSImporterWorker com.apple.Spotlight.ImporterWorker.-2
    nobody 122 1 0:02.27 0.0 0.1 Thu03PM /System/Library/CoreServices/RemoteManagement/ARDAgent.app/Contents/MacOS/ARDAgent
    root 123 1 0:00.01 0.0 0.0 Thu03PM /usr/sbin/UserEventAgent -l LoginWindow
    root 125 59 0:04.82 0.0 0.5 Thu03PM /System/Library/CoreServices/ManagedClient.app/Contents/MacOS/ManagedClient -s
    nobody 126 122 0:00.20 0.0 0.1 Thu03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/MacOS/AppleVNCServer
    root 127 42 0:00.27 0.0 0.0 Thu03PM /System/Library/CoreServices/SecurityAgent.app/Contents/Resources/authorizationhost
    root 128 1 0:00.00 0.0 0.0 Thu03PM /System/Library/CoreServices/RemoteManagement/AppleVNCServer.bundle/Contents/Support/VNCPrivilegeProxy
    _securityagent 131 42 23:24.78 0.6 0.5 Thu03PM /System/Library/CoreServices/SecurityAgent.app/Contents/MacOS/SecurityAgent
    root 134 1 0:23.44 0.0 0.0 Thu03PM /System/Library/PrivateFrameworks/CoreRAID.framework/Resources/CoreRAIDServer
    daemon 137 1 0:00.00 0.0 0.0 Thu03PM /usr/sbin/portmap
    root 827 1 0:11.64 0.0 0.5 Thu04PM /usr/sbin/named -f
    zimbra 3936 1 0:02.03 0.0 0.1 Thu04PM /System/Library/Frameworks/CoreServices.framework/Frameworks/Metadata.framework/Versions/A/Support/mdworker MDSImporterWorker com.apple.Spotlight.ImporterWorker.502
    root 9633 1 0:01.90 0.0 0.0 Thu04PM /usr/sbin/cron
    _postfix 16696 79302 0:00.02 0.0 0.0 7:16AM pickup -l -t fifo -u
    _postfix 21271 79302 0:00.04 0.0 0.1 7:35AM smtpd -n smtp -t inet -u -o stress
    _postfix 21273 79302 0:00.01 0.0 0.0 7:35AM anvil -l -t unix -u
    _postfix 30455 79302 0:00.06 0.0 0.0 8:13AM showq -t unix -u
    _postfix 31913 79302 0:00.04 0.0 0.0 8:20AM showq -t unix -u
    root 34535 1 0:00.06 0.0 0.0 8:30AM /usr/sbin/sshd -i
    zimbra 36196 1 0:00.01 0.0 0.0 Thu06PM /usr/bin/perl /usr/local/bin/zcs start
    zimbra 59031 78864 0:06.30 0.0 0.2 3:15AM /usr/bin/perl /tmp/.swatch_script.78864
    zimbra 78188 1 1:28.20 0.0 0.5 Sun02AM /opt/zimbra/openldap/libexec/slapd -l LOCAL0 -4 -u zimbra -h ldap://mail1.mydomain.com:389 -f /opt/zimbra/conf/slapd.conf
    zimbra 78418 1 1:47.23 0.0 0.1 Sun02AM /usr/bin/perl /opt/zimbra/libexec/zmmtaconfig
    zimbra 78428 1 0:00.02 0.0 0.0 Sun02AM /bin/sh /opt/zimbra/mysql/bin/mysqld_safe --defaults-file=/opt/zimbra/conf/my.cnf --external-locking --log-error=/opt/zimbra/log/mysql_error.log --ledir=/opt/zimbra/mysql/libexec
    zimbra 78498 78428 0:34.67 0.0 1.2 Sun02AM /opt/zimbra/mysql/libexec/mysqld --defaults-file=/opt/zimbra/conf/my.cnf --basedir=/opt/zimbra/mysql --datadir=/opt/zimbra/db/data --pid-file=/opt/zimbra/db/mysql.pid --port=7306 --socket=/opt/zimbra/db/mysql.sock --external-locking
    root 78810 1 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/libexec/zmmailboxdmgr start -Xms1515m -Xmx1515m -client -XX:NewRatio=2 -Djava.awt.headless=true -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -XX:+UseParallelGC -Xss256k
    zimbra 78812 78810 1:50.73 0.0 10.8 Sun02AM /usr/bin/java -Xms1515m -Xmx1515m -client -XX:NewRatio=2 -Djava.awt.headless=true -XX:MaxPermSize=128m -XX:SoftRefLRUPolicyMSPerMB=1 -XX:+UseParallelGC -Xss256k -Djava.io.tmpdir=/opt/zimbra/mailboxd/work -Djava.library.path=/opt/zimbra/lib -Djava.endorsed.dirs=/opt/zimbra/mailboxd/common/endorsed -Dzimbra.config=/opt/zimbra/conf/localconfig.xml -Djetty.home=/opt/zimbra/mailboxd -DSTART=/opt/zimbra/mailboxd/etc/start.config -jar /opt/zimbra/mailboxd/start.jar /opt/zimbra/mailboxd/etc/jetty.properties /opt/zimbra/mailboxd/etc/jetty-setuid.xml /opt/zimbra/mailboxd/etc/jetty.xml
    zimbra 78848 1 0:01.67 0.0 0.7 Sun02AM amavisd (master)
    zimbra 78849 78848 0:05.02 0.0 0.8 Sun02AM amavisd (ch1-avail)
    zimbra 78850 78848 0:05.02 0.0 0.8 Sun02AM amavisd (ch1-avail)
    zimbra 78851 78848 0:05.09 0.0 0.8 Sun02AM amavisd (ch1-avail)
    zimbra 78852 78848 0:05.08 0.0 0.8 Sun02AM amavisd (ch1-avail)
    zimbra 78853 78848 0:05.06 0.0 0.8 Sun02AM amavisd (ch1-avail)

    zimbra 78854 78848 0:05.30 0.0 0.8 Sun02AM amavisd (ch1-avail)
    zimbra 78855 78848 0:00.02 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 78856 78848 0:04.76 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 78857 78848 0:04.82 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 78858 78848 0:04.87 0.0 0.1 Sun02AM amavisd (virgin child)
    zimbra 78864 1 0:00.08 0.0 0.1 Sun02AM /usr/bin/perl /opt/zimbra/libexec/swatch --config-file=/opt/zimbra/conf/swatchrc --use-cpan-file-tail --script-dir=/tmp -t /var/log/zimbra.log
    zimbra 78871 1 0:01.95 0.0 0.1 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 78877 78871 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 78878 78871 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 78879 78871 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 78880 78871 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    zimbra 78881 78871 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/httpd-2.2.8/bin/httpd -k start -f /opt/zimbra/conf/httpd.conf
    root 79302 1 0:11.73 0.0 0.0 Sun02AM /opt/zimbra/postfix/libexec/master
    zimbra 79318 1 0:05.07 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 79320 79318 0:00.00 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 79321 79318 0:05.12 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 79322 79318 0:05.05 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    zimbra 79323 79318 0:04.98 0.0 0.0 Sun02AM /opt/zimbra/cyrus-sasl-2.1.22.3z/sbin/saslauthd -r -a zimbra
    _postfix 79328 79302 0:00.27 0.0 0.0 Sun02AM qmgr -l -t fifo -u
    _postfix 79372 79302 0:00.07 0.0 0.0 Sun02AM tlsmgr -l -t unix -u
    zimbra 79389 1 0:16.00 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-proc
    zimbra 79391 1 0:00.78 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-cpu
    zimbra 79393 1 0:00.80 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-vm
    zimbra 79395 1 0:00.77 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-io -x
    zimbra 79397 1 0:09.04 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mysql
    zimbra 79399 1 0:04.15 0.0 0.1 Sun02AM /usr/bin/perl -w /opt/zimbra/libexec/zmstat-mtaqueue
    zimbra 79532 79391 0:02.18 0.0 0.0 Sun02AM /usr/sbin/iostat -d -C -K -w 30
    zimbra 79533 79393 0:00.16 0.0 0.0 Sun02AM /usr/bin/vm_stat 30
    zimbra 79539 79395 0:02.62 0.0 0.0 Sun02AM /usr/sbin/iostat -d -K -w 30
    root 35936 34543 0:00.00 0.0 0.0 8:36AM ps axwwo user
    (d) How many total processes are reported running by the postfix user?

    Now both zimbra servers are not under load because the appliance is forwarding all mail messages directly to the old iplanet server, but despite I have restarted zimbra on both Xservers yesterday we actually have the same error right now.
    See above for the actual postfix user's processes, but consider that when the mta server is in error state while still receiving messages from the Sophos appiance (it's our domain's MX) we often have a lot (30-50) of smtpd processes like this:
    _postfix 81876 23189 0:00.02 0.0 0.1 4:30PM smtpd -n smtp -t inet -u -o stress
    or this:
    _postfix 79794 79766 0:00.01 0.0 0.0 11:34PM smtp -t unix -u
    (e) Are you using any sort of remote user settings on your mac (like nss_ldap, etc)?

    No, nothing like this, and both servers have the Mac OS X's openldap service turned off.
    Last edited by fab; 10-27-2008 at 01:21 AM.

  6. #6
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default

    Some more errors from zimbra.log:
    Oct 27 09:43:14 mta postfix/proxymap[88039]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    Oct 27 09:43:14: --- last message repeated 2 times ---
    Oct 27 09:43:14 mta postfix/trivial-rewrite[88038]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    Oct 27 09:43:15 mta postfix/qmgr[86521]: warning: problem talking to service rewrite: Unknown error: 0
    Oct 27 09:43:15 mta postfix/master[67763]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 88038 exit status 1
    Oct 27 09:43:15 mta postfix/master[67763]: warning: /opt/zimbra/postfix/libexec/trivial-rewrite: bad command startup -- throttling

  7. #7
    fab
    fab is offline Active Member
    Join Date
    Oct 2008
    Posts
    38
    Rep Power
    6

    Default

    I also noticed that while in error state also the zimbra admin console stops working; the admin user's login is ok but then the admin page stucks on "Loading...".
    To make it work again I have to restart the zimbra mailbox service with
    zmstorectl stop && zmstorectl start

  8. #8
    scalper is offline Partner (VAR/HSP)
    Join Date
    Jul 2006
    Location
    KL, Malaysia
    Posts
    123
    Rep Power
    9

    Default

    I am seeing this problem too.. What are your solutions?

  9. #9
    phoenix is offline Zimbra Consultant & Moderator
    Join Date
    Sep 2005
    Location
    Vannes, France
    Posts
    23,491
    Rep Power
    56

    Default

    Quote Originally Posted by scalper View Post
    I am seeing this problem too.. What are your solutions?
    "Me too" problems don't usually get fixed in these forums and you've given no information to confirm you have the same problem.

    How about starting a new thread and describing your exact problem including any errors in the log files, update your forum profile with the output of the following command:

    Code:
    zmcontrol -v
    You should also detail any steps you've taken to try and fix this problem.
    Regards


    Bill


    Acompli: A new adventure for Co-Founder KevinH.

  10. #10
    scalper is offline Partner (VAR/HSP)
    Join Date
    Jul 2006
    Location
    KL, Malaysia
    Posts
    123
    Rep Power
    9

    Exclamation

    Thank you. Sorry for not altering my version info, but yet, I have install bases using 4.5.x , 5.0.x , with various OS. Normally, I'll let ppl know upon request on which version/os I use later on.

    Plus, I don't see any requirement for a new thread as this thread haven't been marked as solved, and yet it is idle for quite some time. I wonder if it ever been solved or not.

    Anyway, I am seeing a very similar symptom. (refer my zimbra.log below) Proxymap all over sudden is not working. LDAP is not contactable. But zmcontrol status showing everything is up and running.

    A zmcontrol stop; zmcontrol start will get things going on normal again. This event been happening out of nowhere, at a very odd timeframe. Sometimes every 10 minutes, sometimes it took 6 - 12 hours for the event to took place again.

    Release 5.0.13_GA_2791.MACOSXx86_10.5, Zimbra, Inc.MACOSXx86_10.5

    Code:
    May 26 16:17:26 zimbrasvr amavis[49684]: (49684-01) Passed CLEAN, [69.36.164.46] [210.19.157.2] <fadzly@localbasic.domain.tld> -> <asnor@server.domain.tld>, Mess
    age-ID: <200905260816.n4Q8GSev031910@localbasic.domain.tld>, mail_id: HQVFsN6fszKR, Hits: -1.451, size: 41967, queued_as: 21CB672AC02, 13008 ms
    May 26 16:17:26 zimbrasvr postfix/smtp[55035]: AF3CD72ABF5: to=<asnor@server.domain.tld>, relay=127.0.0.1[127.0.0.1]:10024, delay=15, delays=1.7/0/0.01/13, d
    sn=2.0.0, status=sent (250 2.0.0 Ok: queued as 21CB672AC02)
    May 26 16:17:26 zimbrasvr postfix/qmgr[13267]: AF3CD72ABF5: removed
    May 26 16:17:26 zimbrasvr amavis[49684]: (49684-01) extra modules loaded: /opt/zimbra/zimbramon/lib/darwin-thread-multi-2level/auto/Net/SSLeay/autosplit
    .ix, /opt/zimbra/zimbramon/lib/darwin-thread-multi-2level/auto/Net/SSLeay/randomize.al, IO/Socket/SSL.pm, Net/LDAP/Extension.pm, Net/SSLeay.pm, unicore/lib/g
    c_sc/Digit.pl, unicore/lib/gc_sc/SpacePer.pl, unicore/lib/gc_sc/Word.pl
    May 26 16:17:26 zimbrasvr postfix/lmtp[55191]: 21CB672AC02: to=<asnor@server.domain.tld>, relay=zimbrasvr.server.domain.tld[10.0.8.11]:7025, delay=0.08, dela
    ys=0.03/0/0/0.04, dsn=2.1.5, status=sent (250 2.1.5 OK)
    May 26 16:17:26 zimbrasvr postfix/qmgr[13267]: 21CB672AC02: removed
    May 26 16:17:42 zimbrasvr postfix/smtpd[54994]: connect from localbasic.domain.tld[69.36.164.46]
    May 26 16:17:44 zimbrasvr postfix/proxymap[55206]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:17:44 zimbrasvr postfix/smtpd[54994]: NOQUEUE: reject: RCPT from localbasic.domain.tld[69.36.164.46]: 451 4.3.0 <asnor@server.domain.tld>: Temporary lo
    okup failure; from=<fadzly@localbasic.domain.tld> to=<asnor@server.domain.tld> proto=ESMTP helo=<localbasic.domain.tld>
    May 26 16:17:49 zimbrasvr postfix/proxymap[55206]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:17:49: --- last message repeated 2 times ---
    May 26 16:17:49 zimbrasvr postfix/cleanup[55012]: warning: 2AC8172AC06: sender_canonical_maps map lookup problem for double-bounce@zimbrasvr.server.
    com.my
    May 26 16:17:49 zimbrasvr postfix/smtpd[54994]: disconnect from localbasic.domain.tld[69.36.164.46]
    May 26 16:18:02 zimbrasvr zmmailboxdmgr[55382]: status requested
    May 26 16:18:02 zimbrasvr zmmailboxdmgr[55382]: status OK
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: antispam: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: antivirus: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: ldap: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: logger: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: mailbox: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: mta: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: snmp: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: spell: Running
    May 26 16:18:03 zimbrasvr zimbramon[55244]: 55244:info: 2009-05-26 16:18:00, STATUS: zimbrasvr.server.domain.tld: stats: Running
    May 26 16:18:07 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld sasl changed from running to stopped
    May 26 16:18:07 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld stats changed from running to stopped
    May 26 16:18:07 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld antispam changed from running to stopped
    May 26 16:18:07 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld snmp changed from running to stopped
    May 26 16:18:07 zimbrasvr postfix/sendmail[55529]: fatal: no login name found for user ID 502
    May 26 16:18:07 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld mailboxd changed from running to stopped
    May 26 16:18:07 zimbrasvr postfix/sendmail[55548]: fatal: no login name found for user ID 502
    May 26 16:18:08 zimbrasvr postfix/postdrop[55533]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:18:08 zimbrasvr postfix/sendmail[55550]: fatal: no login name found for user ID 502
    May 26 16:18:08 zimbrasvr postfix/sendmail[55552]: fatal: no login name found for user ID 502
    May 26 16:18:08 zimbrasvr postfix/sendmail[55554]: fatal: no login name found for user ID 502
    May 26 16:18:08 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld mta changed from running to stopped
    May 26 16:18:08 zimbrasvr postfix/postdrop[55558]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:18:08 zimbrasvr postfix/sendmail[55575]: fatal: no login name found for user ID 502
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld mailbox changed from running to stopped
    May 26 16:18:09 zimbrasvr postfix/postdrop[55579]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld logger changed from running to stopped
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:err: Service status change: zimbrasvr.server.domain.tld antivirus changed from running to stopped
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Watchdog: adding antivirus to restart list
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:18:09 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:18:09 zimbrasvr postfix/sendmail[55594]: fatal: no login name found for user ID 502
    May 26 16:18:09 zimbrasvr postfix/sendmail[55596]: fatal: no login name found for user ID 502
    May 26 16:18:09 zimbrasvr postfix/sendmail[55598]: fatal: no login name found for user ID 502
    May 26 16:18:10 zimbrasvr postfix/smtpd[54994]: connect from localbasic.domain.tld[69.36.164.46]
    May 26 16:18:11 zimbrasvr postfix/proxymap[55600]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    okup failure; from=<fadzly@localbasic.domain.tld> to=<asnor@server.domain.tld> proto=ESMTP helo=<localbasic.domain.tld>
    May 26 16:18:15 zimbrasvr postfix/proxymap[55600]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:18:15 zimbrasvr postfix/cleanup[55012]: warning: DCB1372AC21: sender_canonical_maps map lookup problem for double-bounce@zimbrasvr.server.
    com.my
    May 26 16:18:15 zimbrasvr postfix/smtpd[54994]: disconnect from localbasic.domain.tld[69.36.164.46]
    May 26 16:19:16 zimbrasvr postfix/postdrop[55741]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:19:17 zimbrasvr postfix/postdrop[55758]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:19:18 zimbrasvr postfix/postdrop[55777]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:19:18 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:19:18 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:20:00 zimbrasvr zimbramon[55808]: 55808:info: 2009-05-26 16:20:00, QUEUE: 14 2
    May 26 16:20:01 zimbrasvr zimbramon[55812]: 55812:info: 2009-05-26 16:20:00, DISK: zimbrasvr.server.domain.tld: dev: /dev/disk2, mp: /, tot: 69679, avai
    l: 15794
    May 26 16:20:02 zimbrasvr zmmailboxdmgr[56029]: status requested
    May 26 16:20:02 zimbrasvr zmmailboxdmgr[56029]: status OK
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: antispam: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: antivirus: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: ldap: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: logger: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: mailbox: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: mta: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: snmp: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: spell: Running
    May 26 16:20:03 zimbrasvr zimbramon[55813]: 55813:info: 2009-05-26 16:20:00, STATUS: zimbrasvr.server.domain.tld: stats: Running
    May 26 16:20:25 zimbrasvr postfix/postdrop[56214]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:20:26 zimbrasvr postfix/postdrop[56231]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:20:26 zimbrasvr postfix/postdrop[56250]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:20:26 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:20:26 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:21:34 zimbrasvr postfix/postdrop[56415]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:21:35 zimbrasvr postfix/postdrop[56432]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:21:35 zimbrasvr postfix/postdrop[56451]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:21:35 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:21:35 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:21:35 zimbrasvr postfix/anvil[54996]: statistics: max connection rate 3/60s for (smtp:69.36.164.46) at May 26 16:17:42
    May 26 16:21:35 zimbrasvr postfix/anvil[54996]: statistics: max connection count 1 for (smtp:69.36.164.46) at May 26 16:16:54
    May 26 16:21:35 zimbrasvr postfix/anvil[54996]: statistics: max cache size 1 at May 26 16:16:54
    May 26 16:22:43 zimbrasvr postfix/postdrop[56801]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:22:44 zimbrasvr postfix/postdrop[56818]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:22:44 zimbrasvr postfix/postdrop[56838]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:22:44 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:22:44 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:23:52 zimbrasvr postfix/postdrop[57005]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:23:53 zimbrasvr postfix/postdrop[57022]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:23:53 zimbrasvr postfix/postdrop[57041]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:23:53 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:23:53 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:25:01 zimbrasvr postfix/postdrop[57405]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:25:02 zimbrasvr postfix/postdrop[57422]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:25:02 zimbrasvr postfix/postdrop[57441]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:25:02 zimbrasvr zimbramon[12479]: 12479:info: ANTIVIRUS restart initiated from zmmtaconfig
    May 26 16:25:02 zimbrasvr zimbramon[12479]: 12479:info: zmmtaconfig: Failed to restart antivirus rc=256
    May 26 16:26:01 zimbrasvr zmmailboxdmgr[57598]: status requested
    May 26 16:26:01 zimbrasvr zmmailboxdmgr[57598]: status OK
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: antispam: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: antivirus: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: ldap: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: logger: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: mailbox: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: mta: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: snmp: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: spell: Running
    May 26 16:26:02 zimbrasvr zimbramon[57464]: 57464:info: 2009-05-26 16:26:00, STATUS: zimbrasvr.server.domain.tld: stats: Running
    May 26 16:26:10 zimbrasvr postfix/postdrop[57782]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:26:11 zimbrasvr postfix/postdrop[57799]: warning: unable to look up public/pickup: No such file or directory
    May 26 16:26:11 zimbrasvr postfix/postdrop[57822]: warning: unable to look up public/pickup: No such file or directory
    --
    May 26 16:46:52 zimbrasvr postfix/trivial-rewrite[63924]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:46:52 zimbrasvr postfix/proxymap[63748]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:46:52 zimbrasvr postfix/proxymap[63748]: fatal: too many errors - program terminated
    May 26 16:46:53 zimbrasvr postfix/smtpd[61646]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/smtpd[58904]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63921 exit status 1
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: /opt/zimbra/postfix/libexec/trivial-rewrite: bad command startup -- throttling
    May 26 16:46:53 zimbrasvr postfix/smtpd[59491]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63922 exit status 1
    May 26 16:46:53 zimbrasvr postfix/smtpd[62742]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/smtpd[61661]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63923 exit status 1
    May 26 16:46:53 zimbrasvr postfix/smtpd[59098]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/smtpd[59259]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63924 exit status 1
    May 26 16:46:53 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/proxymap pid 63748 exit status 1
    May 26 16:46:54 zimbrasvr postfix/proxymap[63926]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:46:54: --- last message repeated 2 times ---
    May 26 16:46:54 zimbrasvr postfix/trivial-rewrite[63925]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:46:55 zimbrasvr postfix/smtpd[60293]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:46:55 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63925 exit status 1
    May 26 16:46:59 zimbrasvr postfix/smtpd[63930]: connect from unknown[202.138.96.75]
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:47:53: --- last message repeated 2 times ---
    May 26 16:47:53 zimbrasvr postfix/trivial-rewrite[63977]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:47:53: --- last message repeated 2 times ---
    May 26 16:47:53 zimbrasvr postfix/trivial-rewrite[63978]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:47:53: --- last message repeated 2 times ---
    May 26 16:47:53 zimbrasvr postfix/trivial-rewrite[63979]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:47:53: --- last message repeated 2 times ---
    May 26 16:47:53 zimbrasvr postfix/trivial-rewrite[63980]: fatal: proxy:ldap:/opt/zimbra/conf/ldap-vad.cf(0,lock|fold_fix): table lookup problem
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: error: dict_ldap_connect: Unable to set STARTTLS: -1: Can't contact LDAP server
    May 26 16:47:53 zimbrasvr postfix/proxymap[63931]: fatal: too many errors - program terminated
    May 26 16:47:54 zimbrasvr postfix/smtpd[58904]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:47:54 zimbrasvr postfix/smtpd[61646]: warning: problem talking to service rewrite: Unknown error: 0
    May 26 16:47:54 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63977 exit status 1
    May 26 16:47:54 zimbrasvr postfix/master[13260]: warning: process /opt/zimbra/postfix/libexec/trivial-rewrite pid 63978 exit status 1
    May 26 16:47:54 zimbrasvr postfix/master[13260]: warning: /opt/zimbra/postfix/libexec/trivial-rewrite: bad command startup -- throttling
    May 26 16:47:54 zimbrasvr postfix/smtpd[62742]: warning: problem talking to service rewrite: Unknown error: 0
    Very appreciate your input. Thank you.

Page 1 of 2 12 LastLast

Thread Information

Users Browsing this Thread

There are currently 1 users browsing this thread. (0 members and 1 guests)

Similar Threads

  1. postdrop fail to create file after upgrade to 5.0.3
    By echoadisan in forum Installation
    Replies: 23
    Last Post: 07-15-2013, 03:02 PM
  2. Snow Leopard to add Full Exchange Support to Mac OS
    By playnada in forum CalDAV / CardDAV / iSync
    Replies: 9
    Last Post: 01-26-2010, 10:36 PM
  3. CalDAV error...
    By toolcaserp in forum Administrators
    Replies: 0
    Last Post: 09-17-2008, 12:26 PM
  4. Network edition trial on Leopard (mac os x)
    By Rodi.reich@gmail.com in forum Installation
    Replies: 4
    Last Post: 03-19-2008, 10:07 PM
  5. Issue with Mac OS uninstall
    By specialagent in forum Installation
    Replies: 0
    Last Post: 03-26-2007, 07:36 AM

Posting Permissions

  • You may not post new threads
  • You may not post replies
  • You may not post attachments
  • You may not edit your posts
  •