| Welcome to the Zimbra :: Forums! | |
Welcome, if you would like to post a comment please register.
We also encourage you to explore all things Zimbra with our team and members of the community.
|
 | | 
03-04-2009, 10:44 AM
| | Intermediate Member | |
Posts: 17
| |  no web access...
I rebooted, stopped zimbra and killed this reoccuring errant process and then restarted zimbra:
$ ps aux | grep zimbra
zimbra 4173 0.0 0.2 8544 4696 ? S 11:21 0:00 /usr/bin/perl /opt/zimbra/libexec/zmlogger
zimbra 9361 0.0 0.0 3700 1196 tty1 S 11:34 0:00 su - zimbra
zimbra 9362 0.0 0.1 4548 2184 tty1 S 11:34 0:00 -su
zimbra 9885 0.0 0.0 2196 876 tty1 R+ 11:37 0:00 ps aux
zimbra 9886 0.0 0.0 1628 492 tty1 S+ 11:37 0:00 grep zimbra
$ kill 4173
$ ps aux | grep zimbra
zimbra 9361 0.0 0.0 3700 1196 tty1 S 11:34 0:00 su - zimbra
zimbra 9362 0.0 0.1 4548 2192 tty1 S 11:34 0:00 -su
zimbra 10083 0.0 0.0 2196 872 tty1 R+ 11:38 0:00 ps aux
zimbra 10084 0.0 0.0 1624 488 tty1 S+ 11:38 0:00 grep zimbra
I have been killing that same process about 50 times a day...
I tried the usual port 80, http://mail2.leetackle.com and got: Then I tried the SSL port 443...after firefox had me confirm that I accept the self-signed cert it gave me the usual: I tried accessing pop3 and imap thru thunderbird and it keeps timing out...
Nmap reports that the ports are open:
PORT STATE SERVICE VERSION
25/tcp open smtp Postfix smtpd
80/tcp open http?
110/tcp open pop3?
143/tcp open imap?
389/tcp open ldap OpenLDAP 2.2.X
443/tcp open ssl/unknown
465/tcp open ssl/smtp Postfix smtpd
The admin port 7071 is not listed under nmap, but when I connect it gives me the usual: Here is a trimmed version of /var/log/zimbra: Quote:
Mar 4 11:21:22 mail2 su[3800]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 4 11:21:25 mail2 zimbramon[3804]: 3804:info: Starting services
Mar 4 11:21:26 mail2 slapd[3843]: @(#) $OpenLDAP: slapd 2.3.41 (Feb 27 2008 16:13:23) $ ^Iroot@build13.re.zimbra.com:/home/build/p4/main/ThirdParty/openldap/openldap-2.3.41.6z/servers/slapd
Mar 4 11:21:27 mail2 slapd[3844]: slapd starting
Mar 4 11:21:34 mail2 zimbramon[3804]: 3804:info: Rewriting configs antispam amavis antivirus amavis webxml mailbox amavis antispam antivirus mta sasl
Mar 4 11:21:45 mail2 zimbramon[3804]: 3804:info: Starting logger
Mar 4 11:21:45 mail2 zimbramon[3804]: 3804:info: Starting mailbox
Mar 4 11:21:46 mail2 zimbramon[4154]: 4154:info: zmmtaconfig: zmmtaconfig started on mail2.leetackle.com with loglevel=3 pid=4154
Mar 4 11:22:01 mail2 CRON[4540]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 4 11:22:04 mail2 zmmailboxdmgr[4612]: status requested
Mar 4 11:22:04 mail2 zmmailboxdmgr[4612]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Mar 4 11:22:04 mail2 zmmailboxdmgr[4612]: assuming no other instance is running
Mar 4 11:22:04 mail2 zmmailboxdmgr[4612]: no manager process is running
Mar 4 11:22:04 mail2 zmmailboxdmgr[4625]: start requested
Mar 4 11:22:04 mail2 zmmailboxdmgr[4625]: checking if another instance of manager is already running
Mar 4 11:22:04 mail2 zmmailboxdmgr[4625]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Mar 4 11:22:04 mail2 zmmailboxdmgr[4625]: assuming no other instance is running
Mar 4 11:22:04 mail2 zmmailboxdmgr[4626]: wrote manager pid 4626 to /opt/zimbra/log/zmmailboxd.pid
Mar 4 11:22:04 mail2 zmmailboxdmgr[4626]: manager started mailboxd/JVM with pid 4627
Mar 4 11:22:04 mail2 zimbramon[3804]: 3804:info: Starting antispam
Mar 4 11:22:05 mail2 zmmailboxdmgr[4712]: status requested
Mar 4 11:22:05 mail2 zmmailboxdmgr[4712]: status OK
Mar 4 11:22:05 mail2 zimbramon[4641]: 4641:info: zmmtaconfig: zmmtaconfig already running at 4154
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: antispam: Stopped
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: antivirus: Stopped
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: ldap: Running
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: logger: Running
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: mailbox: Running
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: mta: Stopped
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: snmp: Stopped
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: spell: Stopped
Mar 4 11:22:06 mail2 zimbramon[4541]: 4541:info: 2009-03-04 11:22:01, STATUS: mail2.leetackle.com: stats: Stopped
Mar 4 11:22:06 mail2 CRON[4540]: (pam_unix) session closed for user zimbra
Mar 4 11:22:08 mail2 amavis[4735]: starting. /opt/zimbra/amavisd/sbin/amavisd at mail2.leetackle.com amavisd-new-2.5.2 (20070627), Unicode aware, LANG="C"
Mar 4 11:22:08 mail2 amavis[4735]: user=1001, EUID: 1001 (1001); group=, EGID: 1001 1002 1001 5 4 (1001 1002 1001 5 4)
Mar 4 11:22:08 mail2 amavis[4735]: Perl version 5.008007
Mar 4 11:22:11 mail2 amavis[4735]: SpamControl: init_pre_chroot done
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: Process Backgrounded
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: 2009/03/04-11:22:11 Amavis (type Net::Server::PreForkSimple) starting! pid(4805)
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: Binding to UNIX socket file /opt/zimbra/data/amavisd/amavisd.sock using SOCK_STREAM
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: Group Not Defined. Defaulting to EGID '1001 1002 1001 5 4'
Mar 4 11:22:11 mail2 amavis[4805]: Net::Server: User Not Defined. Defaulting to EUID '1001'
Mar 4 11:22:11 mail2 amavis[4805]: Module Amavis::Conf 2.091
Mar 4 11:22:11 mail2 amavis[4805]: Module Archive::Zip 1.23
Mar 4 11:22:11 mail2 amavis[4805]: Module Compress::Zlib 1.42
Mar 4 11:22:11 mail2 amavis[4805]: Module Convert::TNEF 0.17
Mar 4 11:22:11 mail2 amavis[4805]: Module Convert::UUlib 1.09
Mar 4 11:22:11 mail2 amavis[4805]: Module DBD::mysql 4.006
Mar 4 11:22:11 mail2 amavis[4805]: Module DBI 1.602
Mar 4 11:22:11 mail2 amavis[4805]: Module DB_File 1.816
Mar 4 11:22:11 mail2 amavis[4805]: Module Digest::MD5 2.33
Mar 4 11:22:11 mail2 amavis[4805]: Module Digest::SHA1 2.11
Mar 4 11:22:11 mail2 amavis[4805]: Module MIME::Entity 5.423
Mar 4 11:22:11 mail2 amavis[4805]: Module MIME::Parser 5.423
Mar 4 11:22:11 mail2 amavis[4805]: Module MIME::Tools 5.423
Mar 4 11:22:11 mail2 amavis[4805]: Module Mail::Header 2.02
Mar 4 11:22:11 mail2 amavis[4805]: Module Mail::Internet 2.02
Mar 4 11:22:11 mail2 amavis[4805]: Module Mail::SpamAssassin 3.002004
Mar 4 11:22:11 mail2 amavis[4805]: Module Net: NS 0.63
Mar 4 11:22:11 mail2 amavis[4805]: Module Net::LDAP 0.34
Mar 4 11:22:11 mail2 amavis[4805]: Module Net::Server 0.97
Mar 4 11:22:11 mail2 amavis[4805]: Module Time::HiRes 1.9712
Mar 4 11:22:11 mail2 amavis[4805]: Module URI 1.35
Mar 4 11:22:11 mail2 amavis[4805]: Module Unix::Syslog 1.0
Mar 4 11:22:11 mail2 amavis[4805]: Amavis:B code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: Amavis::Cache code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: SQL base code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: SQL::Log code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: SQL::Quarantine NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: Lookup::SQL code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: Lookup::LDAP code loaded
Mar 4 11:22:11 mail2 amavis[4805]: AM.PDP-in proto code loaded
Mar 4 11:22:11 mail2 amavis[4805]: SMTP-in proto code loaded
Mar 4 11:22:11 mail2 amavis[4805]: Courier proto code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: SMTP-out proto code loaded
Mar 4 11:22:11 mail2 amavis[4805]: Pipe-out proto code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: BSMTP-out proto code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: Local-out proto code loaded
Mar 4 11:22:11 mail2 amavis[4805]: OS_Fingerprint code NOT loaded
Mar 4 11:22:11 mail2 amavis[4805]: ANTI-VIRUS code loaded
Mar 4 11:22:11 mail2 amavis[4805]: ANTI-SPAM code loaded
Mar 4 11:22:11 mail2 amavis[4805]: ANTI-SPAM-SA code loaded
Mar 4 11:22:11 mail2 amavis[4805]: Unpackers code loaded
Mar 4 11:22:11 mail2 amavis[4805]: Found $file at /usr/bin/file
Mar 4 11:22:11 mail2 amavis[4805]: No $dspam, not using it
Mar 4 11:22:11 mail2 amavis[4805]: No $altermime, not using it
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .mail
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .asc
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .uue
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .hqx
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .ync
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .F tried: unfreeze, freeze -d, melt, fcat
Mar 4 11:22:11 mail2 amavis[4805]: Found decoder for .Z at /bin/uncompress
Mar 4 11:22:11 mail2 amavis[4805]: Found decoder for .gz at /bin/gzip -d
Mar 4 11:22:11 mail2 amavis[4805]: Found decoder for .bz2 at /usr/bin/bzip2 -d
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .lzo tried: lzop -d
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .rpm tried: rpm2cpio.pl, rpm2cpio
Mar 4 11:22:11 mail2 amavis[4805]: Found decoder for .cpio at /bin/cpio
Mar 4 11:22:11 mail2 amavis[4805]: Found decoder for .tar at /bin/cpio
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .deb tried: ar
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .zip
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .7z tried: 7zr, 7za, 7z
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .rar tried: rar, unrar
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .arj tried: arj, unarj
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .arc tried: nomarch, arc
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .zoo tried: zoo, unzoo
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .lha tried: lha
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .cab tried: cabextract
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .tnef tried: tnef
Mar 4 11:22:11 mail2 amavis[4805]: Internal decoder for .tnef
Mar 4 11:22:11 mail2 amavis[4805]: No decoder for .exe tried: rar, unrar; lha; arj, unarj
Mar 4 11:22:11 mail2 amavis[4805]: Using primary internal av scanner code for ClamAV-clamd
Mar 4 11:22:11 mail2 amavis[4805]: SpamControl: initializing Mail::SpamAssassin
Mar 4 11:22:13 mail2 amavis[4805]: SpamControl: init_pre_fork done
Mar 4 11:22:15 mail2 zimbramon[3804]: 3804:info: Starting antivirus
Mar 4 11:22:15 mail2 zimbramon[4824]: 4824:info: zmmtaconfig: zmmtaconfig already running at 4154
Mar 4 11:22:16 mail2 clamd[4862]: clamd daemon 0.92.1 (OS: linux-gnu, ARCH: i386, CPU: i686)
Mar 4 11:22:16 mail2 clamd[4862]: Log file size limited to 20971520 bytes.
Mar 4 11:22:16 mail2 clamd[4862]: Reading databases from /opt/zimbra/data/clamav/db
Mar 4 11:22:16 mail2 clamd[4862]: Not loading PUA signatures.
Mar 4 11:22:29 mail2 clamd[4862]: Loaded 689639 signatures.
Mar 4 11:22:29 mail2 clamd[4862]: Bound to tcp port 3310
Mar 4 11:22:29 mail2 clamd[4862]: Setting connection queue length to 15
Mar 4 11:22:29 mail2 clamd[4862]: Archive: Archived file size limit set to 104857600 bytes.
Mar 4 11:22:29 mail2 clamd[4862]: Archive: Recursion level limit set to 8.
Mar 4 11:22:29 mail2 clamd[4862]: Archive: Files limit set to 1000.
Mar 4 11:22:29 mail2 clamd[4862]: Archive: Compression ratio limit set to 250.
Mar 4 11:22:29 mail2 clamd[4862]: Archive support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: Algorithmic detection enabled.
Mar 4 11:22:29 mail2 clamd[4862]: Portable Executable support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: ELF support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: Mail files support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: Mail: Recursion level limit set to 64.
Mar 4 11:22:29 mail2 clamd[4862]: OLE2 support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: PDF support disabled.
Mar 4 11:22:29 mail2 clamd[4862]: HTML support enabled.
Mar 4 11:22:29 mail2 clamd[4862]: Self checking every 1800 seconds.
Mar 4 11:22:30 mail2 zimbramon[3804]: 3804:info: Starting snmp
Mar 4 11:22:30 mail2 zimbramon[3804]: 3804:info: Starting spell
Mar 4 11:22:31 mail2 zimbramon[3804]: 3804:info: Starting mta
Mar 4 11:22:31 mail2 zimbramon[4899]: 4899:info: zmmtaconfig: zmmtaconfig already running at 4154
Mar 4 11:22:33 mail2 postfix/postfix-script[4977]: warning: not owned by root: /opt/zimbra/postfix-2.4.3.4z/conf/main.cf
Mar 4 11:22:33 mail2 postfix/postfix-script[4990]: starting the Postfix mail system
Mar 4 11:22:33 mail2 postfix/master[4991]: daemon started -- version 2.4.3, configuration /opt/zimbra/postfix-2.4.3.4z/conf
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 178D32004E8: from=, size=2848, nrcpt=5 (queue active)
Mar 4 11:22:33 mail2 saslauthd[5006]: detach_tty : master pid is: 5006
Mar 4 11:22:33 mail2 saslauthd[5006]: ipc_init : listening on socket: /opt/zimbra/cyrus-sasl-2.1.22.3z/state/mux
Mar 4 11:22:33 mail2 zimbramon[3804]: 3804:info: Starting stats
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 1B0372006D1: from=, size=63124, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 1E59720061A: from=, size=2770, nrcpt=8 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 12FA9200777: from=, size=5938, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 139B820077A: from=, size=29311, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 1C314200782: from=, size=5940, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 19A662007C6: from=, size=2638, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 1D3D5200823: from=, size=2028, nrcpt=2 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 24ECC200474: from=, size=4685, nrcpt=1 (queue active)
Mar 4 11:22:33 mail2 postfix/qmgr[5003]: 2097320033B: from=, size=109234, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 2CF8E200313: from=, size=3795, nrcpt=2 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 27BFB20087F: from=, size=4871, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 296432003FD: from=, size=37497, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 2D5E320069F: from=, size=4339, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 3EC6E2005C1: from=<21-22143261-leetackle.com?steve@hhvvrec.dwnsouth.com>, size=7374, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 36C0620057F: from=, size=167605, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 37F4C2006F2: from=, size=2040, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 046C420026A: from=, size=11838, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 4832620030F: from=, size=3760, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 45C82200400: from=, size=2909, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 0337020022D: from=, size=6837, nrcpt=1 (queue active)
Mar 4 11:22:34 mail2 postfix/smtpd[5031]: connect from mail1.nwfnews.com[199.1.145.54]
Mar 4 11:22:34 mail2 postfix/qmgr[5003]: 45C0D2006CD: from=, size=1863, nrcpt=1 (queue active)
| I had to trim all the incoming email in the zimbra.log file....it's like happy hour at my mail server... Quote: |
Mar 4 11:25:34 mail2 amavis[4806]: (04806-03) Blocked SPAM, [70.167.206.183] [70.167.206.183] -> , Message-ID: <979720287.24833939075205@brainin.com>, mail_id: DiW4koUIyltc, Hits: 21.516, size: 957, 5091 ms
| Looks like spamassassin is doing its thing... Quote:
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: antispam: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: antivirus: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: ldap: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: logger: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: mailbox: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: mta: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: snmp: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: spell: Running
Mar 4 11:26:05 mail2 zimbramon[6261]: 6261:info: 2009-03-04 11:26:01, STATUS: mail2.leetackle.com: stats: Running
Mar 4 11:26:05 mail2 CRON[6260]: (pam_unix) session closed for user zimbra
| Seems happy...  |
03-04-2009, 11:16 AM
| | Intermediate Member | |
Posts: 17
| | not so happy after all...
and then everything starts to get grumpy... Quote:
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6C027200621: to=, relay=none, delay=42787, delays=42488/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6300E20067A: to=, relay=none, delay=34538, delays=34239/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6336A2004DB: to=, relay=none, delay=55094, delays=54795/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 63B67200592: to=, relay=none, delay=50535, delays=50236/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6F5B92004F2: to=, relay=none, delay=59289, delays=58990/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6F5B92004F2: to=, relay=none, delay=59289, delays=58990/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 67BD520067D: to=, relay=none, delay=34269, delays=33970/299/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 6C493200776: to=, relay=none, delay=13200, delays=12901/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7DCCD200230: to=, relay=none, delay=76939, delays=76640/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7B7B720025D: to=, relay=none, delay=76197, delays=75899/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7801F2002AC: to=, relay=none, delay=74776, delays=74478/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7B50820061B: to=, relay=none, delay=43012, delays=42714/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 76A9520040F: to=, relay=none, delay=67329, delays=67031/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 76A9520040F: to=, relay=none, delay=67329, delays=67031/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7E758200580: to=, relay=none, delay=51322, delays=51024/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:40 mail2 postfix/qmgr[5003]: 7E758200580: to=, relay=none, delay=51322, delays=51024/298/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
| After a while it gets happy again: Quote:
Mar 4 11:27:44 mail2 postfix/qmgr[5003]: EF61A20088C: to=, relay=none, delay=2200, delays=2188/11/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:44 mail2 postfix/qmgr[5003]: F322F20082C: to=, relay=none, delay=5648, delays=5636/11/0/0, dsn=4.3.0, status=deferred (mail transport unavailable)
Mar 4 11:27:49 mail2 zmmailboxdmgr[7161]: status requested
Mar 4 11:27:49 mail2 zmmailboxdmgr[7161]: status OK
Mar 4 11:27:50 mail2 zmmailboxdmgr[7205]: status requested
Mar 4 11:27:50 mail2 zmmailboxdmgr[7205]: status OK
Mar 4 11:27:51 mail2 postfix/smtpd[5031]: timeout after CONNECT from unknown[189.24.129.142]
Mar 4 11:27:51 mail2 postfix/smtpd[5031]: disconnect from unknown[189.24.129.142]
Mar 4 11:27:58 mail2 postfix/smtpd[5070]: connect from unknown[92.46.225.5]
Mar 4 11:27:59 mail2 postfix/smtpd[6234]: connect from ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:27:59 mail2 postfix/smtpd[6234]: 5DF992008C8: client=ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:27:59 mail2 postfix/cleanup[7244]: 5DF992008C8: message-id=<1102488510340.1101069158744.54493.5.710303B@schedu ler>
Mar 4 11:27:59 mail2 postfix/smtpd[5070]: NOQUEUE: reject: RCPT from unknown[92.46.225.5]: 550 5.1.1 : Recipient address rejected: leetackle.com; from= to= proto=SMTP helo=
Mar 4 11:27:59 mail2 postfix/smtpd[6234]: disconnect from ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:27:59 mail2 postfix/qmgr[5003]: 5DF992008C8: from=, size=10457, nrcpt=1 (queue active)
Mar 4 11:27:59 mail2 amavis[4814]: (04814-02) ESMTP::10024 /opt/zimbra/data/amavisd/tmp/amavis-20090304T112302-04814: -> SIZE=10457 Received: from mail2.leetackle.com ([127.0.0.1]) by localhost (mail2.leetackle.com [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for ; Wed, 4 Mar 2009 11:27:59 -0500 (EST)
Mar 4 11:27:59 mail2 amavis[4814]: (04814-02) Checking: c-qjzA2F3o-V [63.251.135.74] ->
Mar 4 11:27:59 mail2 postfix/smtpd[5070]: lost connection after RCPT from unknown[92.46.225.5]
Mar 4 11:27:59 mail2 postfix/smtpd[5070]: disconnect from unknown[92.46.225.5]
Mar 4 11:27:59 mail2 postfix/smtpd[5031]: connect from ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:28:00 mail2 postfix/smtpd[5031]: 0BD1E2008C9: client=ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:28:00 mail2 postfix/cleanup[7244]: 0BD1E2008C9: message-id=<1102488510340.1101069158744.54494.5.710303B@schedu ler>
Mar 4 11:28:00 mail2 postfix/qmgr[5003]: 0BD1E2008C9: from=, size=10431, nrcpt=1 (queue active)
Mar 4 11:28:00 mail2 postfix/smtpd[5031]: disconnect from ccm01.constantcontact.com[63.251.135.74]
Mar 4 11:28:00 mail2 amavis[4806]: (04806-05) ESMTP::10024 /opt/zimbra/data/amavisd/tmp/amavis-20090304T112238-04806: -> SIZE=10431 Received: from mail2.leetackle.com ([127.0.0.1]) by localhost (mail2.leetackle.com [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for ; Wed, 4 Mar 2009 11:28:00 -0500 (EST)
Mar 4 11:28:00 mail2 amavis[4806]: (04806-05) Checking: N1qbjdOAmVRe [63.251.135.74] ->
Mar 4 11:28:00 mail2 postfix/smtpd[5056]: lost connection after CONNECT from unknown[41.248.224.238]
Mar 4 11:28:00 mail2 postfix/smtpd[5056]: disconnect from unknown[41.248.224.238]
Mar 4 11:28:01 mail2 CRON[7258]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 4 11:28:05 mail2 postfix/smtpd[7296]: connect from localhost.localdomain[127.0.0.1]
Mar 4 11:28:05 mail2 postfix/smtpd[7296]: 25A882008CA: client=localhost.localdomain[127.0.0.1]
Mar 4 11:28:05 mail2 postfix/cleanup[7244]: 25A882008CA: message-id=<1102488510340.1101069158744.54493.5.710303B@schedu ler>
Mar 4 11:28:05 mail2 postfix/qmgr[5003]: 25A882008CA: from=, size=11163, nrcpt=1 (queue active)
Mar 4 11:28:05 mail2 amavis[4814]: (04814-02) FWD via SMTP: -> ,BODY=7BIT 250 2.6.0 Ok, id=04814-02, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 25A882008CA
Mar 4 11:28:05 mail2 amavis[4814]: (04814-02) Passed CLEAN, [63.251.135.74] [63.251.135.74] -> , Message-ID: <1102488510340.1101069158744.54493.5.710303B@schedu ler>, mail_id: c-qjzA2F3o-V, Hits: -2.324, size: 10437, queued_as: 25A882008CA, 5586 ms
Mar 4 11:28:05 mail2 postfix/smtp[7245]: 5DF992008C8: to=, relay=127.0.0.1[127.0.0.1]:10024, delay=6, delays=0.33/0.02/0.02/5.6, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 25A882008CA)
|
Now the postfix main.cf warning(highlighted in bold from my last post): Quote: | Mar 4 11:22:33 mail2 postfix/postfix-script[4977]: warning: not owned by root: /opt/zimbra/postfix-2.4.3.4z/conf/main.cf | was solved by running zmfixperms:
$ ls -l /opt/zimbra/postfix/conf
total 228
-rw-r--r-- 1 root postfix 11942 Mar 11 2008 LICENSE
-rw-r--r-- 1 root postfix 1629 Mar 11 2008 TLS_LICENSE
-rw-r--r-- 1 root postfix 17869 Mar 11 2008 access
-rw-r--r-- 1 root postfix 8829 Mar 11 2008 aliases
-rw-r--r-- 1 root postfix 3548 Mar 11 2008 bounce.cf.default
-rw-r--r-- 1 root postfix 11681 Mar 11 2008 canonical
-rw-r--r-- 1 root postfix 9904 Mar 11 2008 generic
-rw-r--r-- 1 root postfix 17439 Mar 11 2008 header_checks
-rw-r--r-- 1 zimbra zimbra 1757 Mar 4 11:43 main.cf
-rw-r--r-- 1 root postfix 18397 Mar 11 2008 main.cf.default
-rw-r--r-- 1 root postfix 3391 Mar 11 2008 makedefs.out
-rw-r--r-- 1 root postfix 5116 Mar 21 2008 master.cf
-rwxr-xr-x 1 root postfix 22197 Mar 11 2008 post-install
-rw-r--r-- 1 root postfix 17588 Mar 11 2008 postfix-files
-rwxr-xr-x 1 root postfix 6647 Mar 11 2008 postfix-script
-rw-r--r-- 1 root postfix 1024 Mar 4 11:44 prng_exch
-rw-r--r-- 1 root postfix 6816 Mar 11 2008 relocated
-rw-r--r-- 1 root postfix 12357 Mar 11 2008 transport
-rw-r--r-- 1 root postfix 12494 Mar 11 2008 virtual
# /opt/zimbra/libexec/zmfixperms
$ ls -l /opt/zimbra/postfix/conf
total 228
-rw-r--r-- 1 root postfix 11942 Mar 11 2008 LICENSE
-rw-r--r-- 1 root postfix 1629 Mar 11 2008 TLS_LICENSE
-rw-r--r-- 1 root postfix 17869 Mar 11 2008 access
-rw-r--r-- 1 root postfix 8829 Mar 11 2008 aliases
-rw-r--r-- 1 root postfix 3548 Mar 11 2008 bounce.cf.default
-rw-r--r-- 1 root postfix 11681 Mar 11 2008 canonical
-rw-r--r-- 1 root postfix 9904 Mar 11 2008 generic
-rw-r--r-- 1 root postfix 17439 Mar 11 2008 header_checks
-rw-r--r-- 1 root postfix 1757 Mar 4 11:43 main.cf
-rw-r--r-- 1 root postfix 18397 Mar 11 2008 main.cf.default
-rw-r--r-- 1 root postfix 3391 Mar 11 2008 makedefs.out
-rw-r--r-- 1 root postfix 5116 Mar 21 2008 master.cf
-rwxr-xr-x 1 root postfix 22197 Mar 11 2008 post-install
-rw-r--r-- 1 root postfix 17588 Mar 11 2008 postfix-files
-rwxr-xr-x 1 root postfix 6647 Mar 11 2008 postfix-script
-rw-r--r-- 1 root postfix 1024 Mar 4 11:44 prng_exch
-rw-r--r-- 1 root postfix 6816 Mar 11 2008 relocated
-rw-r--r-- 1 root postfix 12357 Mar 11 2008 transport
-rw-r--r-- 1 root postfix 12494 Mar 11 2008 virtual |
03-04-2009, 12:03 PM
| | Intermediate Member | |
Posts: 17
| | postfix/main.cf reverts ownership
after restarting zimbra, the postfix/main.cf reverted its permissions to zimbra:
# ls -l /opt/zimbra/postfix/conf
total 228
-rw-r--r-- 1 root postfix 11942 Mar 11 2008 LICENSE
-rw-r--r-- 1 root postfix 1629 Mar 11 2008 TLS_LICENSE
-rw-r--r-- 1 root postfix 17869 Mar 11 2008 access
-rw-r--r-- 1 root postfix 8829 Mar 11 2008 aliases
-rw-r--r-- 1 root postfix 3548 Mar 11 2008 bounce.cf.default
-rw-r--r-- 1 root postfix 11681 Mar 11 2008 canonical
-rw-r--r-- 1 root postfix 9904 Mar 11 2008 generic
-rw-r--r-- 1 root postfix 17439 Mar 11 2008 header_checks
-rw-r--r-- 1 zimbra zimbra 1757 Mar 4 12:42 main.cf
-rw-r--r-- 1 root postfix 18397 Mar 11 2008 main.cf.default
-rw-r--r-- 1 root postfix 3391 Mar 11 2008 makedefs.out
-rw-r--r-- 1 root postfix 5116 Mar 21 2008 master.cf
-rwxr-xr-x 1 root postfix 22197 Mar 11 2008 post-install
-rw-r--r-- 1 root postfix 17588 Mar 11 2008 postfix-files
-rwxr-xr-x 1 root postfix 6647 Mar 11 2008 postfix-script
-rw-r--r-- 1 root postfix 1024 Mar 4 12:43 prng_exch
-rw-r--r-- 1 root postfix 6816 Mar 11 2008 relocated
-rw-r--r-- 1 root postfix 12357 Mar 11 2008 transport
-rw-r--r-- 1 root postfix 12494 Mar 11 2008 virtual
and its reflected in the zimbra.log after restart: Quote:
Mar 4 12:41:21 mail2 zimbramon[9881]: 9881:info: Stopping services
Mar 4 12:41:21 mail2 zimbramon[9881]: 9881:info: Stopping stats
Mar 4 12:41:21 mail2 zimbramon[9881]: 9881:info: Stopping mta
Mar 4 12:41:22 mail2 postfix/postfix-script[9934]: stopping the Postfix mail system
Mar 4 12:41:22 mail2 postfix/master[7765]: terminating on signal 15
Mar 4 12:41:22 mail2 saslauthd[7781]: server_exit : master exited: 7781
Mar 4 12:41:22 mail2 zimbramon[9881]: 9881:info: Stopping spell
Mar 4 12:41:22 mail2 zimbramon[9881]: 9881:info: Stopping snmp
Mar 4 12:41:22 mail2 zimbramon[9881]: 9881:info: Stopping archiving
Mar 4 12:41:22 mail2 amavis[7580]: Net::Server: 2009/03/04-12:41:22 Server closing!
Mar 4 12:41:27 mail2 zimbramon[9881]: 9881:info: Stopping antivirus
Mar 4 12:41:27 mail2 zimbramon[9881]: 9881:info: Stopping antispam
Mar 4 12:41:27 mail2 zimbramon[9881]: 9881:info: Stopping imapproxy
Mar 4 12:41:27 mail2 zimbramon[9881]: 9881:info: Stopping mailbox
Mar 4 12:41:27 mail2 zmmailboxdmgr[10030]: threaddump requested
Mar 4 12:41:27 mail2 zmmailboxdmgr[7523]: sending SIQUIT to mailboxd/JVM process 7524
Mar 4 12:41:28 mail2 clamd[7636]: Pid file removed.
Mar 4 12:41:28 mail2 clamd[7636]: --- Stopped at Wed Mar 4 12:41:28 2009
Mar 4 12:41:29 mail2 zmmailboxdmgr[10037]: stop requested
Mar 4 12:41:29 mail2 zmmailboxdmgr[7523]: shutdown requested, sending TERM signal to 7524
Mar 4 12:41:29 mail2 zmmailboxdmgr[10037]: waiting for manager process 7523 to die
Mar 4 12:41:31 mail2 zmmailboxdmgr[7523]: mailboxd/JVM process exited (waitpid expected 7524 got 7524)
Mar 4 12:41:31 mail2 zmmailboxdmgr[7523]: manager woke up from wait on mailboxd/JVM with pid 7524
Mar 4 12:41:32 mail2 zmmailboxdmgr[10037]: manager process 7523 died, shutdown completed
Mar 4 12:41:36 mail2 zimbramon[9881]: 9881:info: Stopping logger
Mar 4 12:41:38 mail2 zimbramon[9881]: 9881:info: Stopping ldap
Mar 4 12:41:38 mail2 slapd[6783]: daemon: shutdown requested and initiated.
Mar 4 12:41:38 mail2 slapd[6783]: slapd shutdown: waiting for 0 threads to terminate
Mar 4 12:41:38 mail2 slapd[6783]: slapd stopped.
Mar 4 12:41:45 mail2 su[6508]: (pam_unix) session closed for user zimbra
Mar 4 12:41:52 mail2 su[10380]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 4 12:41:59 mail2 zimbramon[10391]: 10391:info: Starting services
Mar 4 12:41:59 mail2 slapd[10430]: @(#) $OpenLDAP: slapd 2.3.41 (Feb 27 2008 16:13:23) $ ^Iroot@build13.re.zimbra.com:/home/build/p4/main/ThirdParty/openldap/openldap-2.3.41.6z/servers/slapd
Mar 4 12:41:59 mail2 slapd[10431]: slapd starting
Mar 4 12:42:01 mail2 CRON[10435]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 4 12:42:04 mail2 zmmailboxdmgr[10548]: status requested
Mar 4 12:42:04 mail2 zmmailboxdmgr[10548]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Mar 4 12:42:04 mail2 zmmailboxdmgr[10548]: assuming no other instance is running
Mar 4 12:42:04 mail2 zmmailboxdmgr[10548]: no manager process is running
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: antispam: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: antivirus: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: ldap: Running
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: logger: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: mailbox: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: mta: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: snmp: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: spell: Stopped
Mar 4 12:42:05 mail2 zimbramon[10436]: 10436:info: 2009-03-04 12:42:02, STATUS: mail2.leetackle.com: stats: Stopped
Mar 4 12:42:05 mail2 CRON[10435]: (pam_unix) session closed for user zimbra
Mar 4 12:42:06 mail2 zimbramon[10391]: 10391:info: Rewriting configs antispam amavis antivirus amavis webxml mailbox amavis antispam antivirus mta sasl
Mar 4 12:42:16 mail2 zimbramon[10391]: 10391:info: Starting logger
Mar 4 12:42:16 mail2 zimbramon[10391]: 10391:info: Starting mailbox
Mar 4 12:42:17 mail2 zimbramon[10950]: 10950:info: zmmtaconfig: zmmtaconfig started on mail2.leetackle.com with loglevel=3 pid=10950
Mar 4 12:42:34 mail2 zmmailboxdmgr[11334]: status requested
Mar 4 12:42:34 mail2 zmmailboxdmgr[11334]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Mar 4 12:42:34 mail2 zmmailboxdmgr[11334]: assuming no other instance is running
Mar 4 12:42:34 mail2 zmmailboxdmgr[11334]: no manager process is running
Mar 4 12:42:34 mail2 zmmailboxdmgr[11341]: start requested
Mar 4 12:42:34 mail2 zmmailboxdmgr[11341]: checking if another instance of manager is already running
Mar 4 12:42:34 mail2 zmmailboxdmgr[11341]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Mar 4 12:42:34 mail2 zmmailboxdmgr[11341]: assuming no other instance is running
Mar 4 12:42:34 mail2 zmmailboxdmgr[11342]: wrote manager pid 11342 to /opt/zimbra/log/zmmailboxd.pid
Mar 4 12:42:34 mail2 zmmailboxdmgr[11342]: manager started mailboxd/JVM with pid 11343
Mar 4 12:42:34 mail2 zimbramon[10391]: 10391:info: Starting antispam
Mar 4 12:42:34 mail2 zimbramon[11355]: 11355:info: zmmtaconfig: zmmtaconfig already running at 10950
Mar 4 12:42:35 mail2 amavis[11384]: starting. /opt/zimbra/amavisd/sbin/amavisd at mail2.leetackle.com amavisd-new-2.5.2 (20070627), Unicode aware, LANG="C"
Mar 4 12:42:35 mail2 amavis[11384]: user=1001, EUID: 1001 (1001); group=, EGID: 1001 1002 1001 5 4 (1001 1002 1001 5 4)
Mar 4 12:42:35 mail2 amavis[11384]: Perl version 5.008007
Mar 4 12:42:36 mail2 amavis[11384]: SpamControl: init_pre_chroot done
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: Process Backgrounded
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: 2009/03/04-12:42:36 Amavis (type Net::Server::PreForkSimple) starting! pid(11398)
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: Binding to UNIX socket file /opt/zimbra/data/amavisd/amavisd.sock using SOCK_STREAM
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: Group Not Defined. Defaulting to EGID '1001 1002 1001 5 4'
Mar 4 12:42:36 mail2 amavis[11398]: Net::Server: User Not Defined. Defaulting to EUID '1001'
Mar 4 12:42:36 mail2 amavis[11398]: Module Amavis::Conf 2.091
Mar 4 12:42:36 mail2 amavis[11398]: Module Archive::Zip 1.23
Mar 4 12:42:36 mail2 amavis[11398]: Module Compress::Zlib 1.42
Mar 4 12:42:36 mail2 amavis[11398]: Module Convert::TNEF 0.17
Mar 4 12:42:36 mail2 amavis[11398]: Module Convert::UUlib 1.09
Mar 4 12:42:36 mail2 amavis[11398]: Module DBD::mysql 4.006
Mar 4 12:42:36 mail2 amavis[11398]: Module DBI 1.602
Mar 4 12:42:36 mail2 amavis[11398]: Module DB_File 1.816
Mar 4 12:42:36 mail2 amavis[11398]: Module Digest::MD5 2.33
Mar 4 12:42:36 mail2 amavis[11398]: Module Digest::SHA1 2.11
Mar 4 12:42:36 mail2 amavis[11398]: Module MIME::Entity 5.423
Mar 4 12:42:36 mail2 amavis[11398]: Module MIME::Parser 5.423
Mar 4 12:42:36 mail2 amavis[11398]: Module MIME::Tools 5.423
Mar 4 12:42:36 mail2 amavis[11398]: Module Mail::Header 2.02
Mar 4 12:42:36 mail2 amavis[11398]: Module Mail::Internet 2.02
Mar 4 12:42:36 mail2 amavis[11398]: Module Mail::SpamAssassin 3.002004
Mar 4 12:42:36 mail2 amavis[11398]: Module Net:NS 0.63
Mar 4 12:42:36 mail2 amavis[11398]: Module Net::LDAP 0.34
Mar 4 12:42:36 mail2 amavis[11398]: Module Net::Server 0.97
Mar 4 12:42:36 mail2 amavis[11398]: Module Time::HiRes 1.9712
Mar 4 12:42:36 mail2 amavis[11398]: Module URI 1.35
Mar 4 12:42:36 mail2 amavis[11398]: Module Unix::Syslog 1.0
Mar 4 12:42:36 mail2 amavis[11398]: Amavis:B code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: Amavis::Cache code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: SQL base code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: SQL::Log code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: SQL::Quarantine NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: Lookup::SQL code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: Lookup::LDAP code loaded
Mar 4 12:42:36 mail2 amavis[11398]: AM.PDP-in proto code loaded
Mar 4 12:42:36 mail2 amavis[11398]: SMTP-in proto code loaded
Mar 4 12:42:36 mail2 amavis[11398]: Courier proto code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: SMTP-out proto code loaded
Mar 4 12:42:36 mail2 amavis[11398]: Pipe-out proto code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: BSMTP-out proto code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: Local-out proto code loaded
Mar 4 12:42:36 mail2 amavis[11398]: OS_Fingerprint code NOT loaded
Mar 4 12:42:36 mail2 amavis[11398]: ANTI-VIRUS code loaded
Mar 4 12:42:36 mail2 amavis[11398]: ANTI-SPAM code loaded
Mar 4 12:42:36 mail2 amavis[11398]: ANTI-SPAM-SA code loaded
Mar 4 12:42:36 mail2 amavis[11398]: Unpackers code loaded
Mar 4 12:42:36 mail2 amavis[11398]: Found $file at /usr/bin/file
Mar 4 12:42:36 mail2 amavis[11398]: No $dspam, not using it
Mar 4 12:42:36 mail2 amavis[11398]: No $altermime, not using it
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .mail
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .asc
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .uue
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .hqx
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .ync
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .F tried: unfreeze, freeze -d, melt, fcat
Mar 4 12:42:36 mail2 amavis[11398]: Found decoder for .Z at /bin/uncompress
Mar 4 12:42:36 mail2 amavis[11398]: Found decoder for .gz at /bin/gzip -d
Mar 4 12:42:36 mail2 amavis[11398]: Found decoder for .bz2 at /usr/bin/bzip2 -d
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .lzo tried: lzop -d
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .rpm tried: rpm2cpio.pl, rpm2cpio
Mar 4 12:42:36 mail2 amavis[11398]: Found decoder for .cpio at /bin/cpio
Mar 4 12:42:36 mail2 amavis[11398]: Found decoder for .tar at /bin/cpio
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .deb tried: ar
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .zip
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .7z tried: 7zr, 7za, 7z
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .rar tried: rar, unrar
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .arj tried: arj, unarj
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .arc tried: nomarch, arc
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .zoo tried: zoo, unzoo
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .lha tried: lha
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .cab tried: cabextract
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .tnef tried: tnef
Mar 4 12:42:36 mail2 amavis[11398]: Internal decoder for .tnef
Mar 4 12:42:36 mail2 amavis[11398]: No decoder for .exe tried: rar, unrar; lha; arj, unarj
Mar 4 12:42:36 mail2 amavis[11398]: Using primary internal av scanner code for ClamAV-clamd
Mar 4 12:42:36 mail2 amavis[11398]: SpamControl: initializing Mail::SpamAssassin
Mar 4 12:42:37 mail2 amavis[11398]: SpamControl: init_pre_fork done
Mar 4 12:42:39 mail2 zimbramon[10391]: 10391:info: Starting antivirus
Mar 4 12:42:40 mail2 zimbramon[11417]: 11417:info: zmmtaconfig: zmmtaconfig already running at 10950
Mar 4 12:42:40 mail2 clamd[11454]: clamd daemon 0.92.1 (OS: linux-gnu, ARCH: i386, CPU: i686)
Mar 4 12:42:40 mail2 clamd[11454]: Log file size limited to 20971520 bytes.
Mar 4 12:42:40 mail2 clamd[11454]: Reading databases from /opt/zimbra/data/clamav/db
Mar 4 12:42:40 mail2 clamd[11454]: Not loading PUA signatures.
Mar 4 12:42:48 mail2 clamd[11454]: Loaded 689639 signatures.
Mar 4 12:42:48 mail2 clamd[11454]: Bound to tcp port 3310
Mar 4 12:42:48 mail2 clamd[11454]: Setting connection queue length to 15
Mar 4 12:42:48 mail2 clamd[11454]: Archive: Archived file size limit set to 104857600 bytes.
Mar 4 12:42:48 mail2 clamd[11454]: Archive: Recursion level limit set to 8.
Mar 4 12:42:48 mail2 clamd[11454]: Archive: Files limit set to 1000.
Mar 4 12:42:48 mail2 clamd[11454]: Archive: Compression ratio limit set to 250.
Mar 4 12:42:48 mail2 clamd[11454]: Archive support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: Algorithmic detection enabled.
Mar 4 12:42:48 mail2 clamd[11454]: Portable Executable support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: ELF support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: Mail files support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: Mail: Recursion level limit set to 64.
Mar 4 12:42:48 mail2 clamd[11454]: OLE2 support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: PDF support disabled.
Mar 4 12:42:48 mail2 clamd[11454]: HTML support enabled.
Mar 4 12:42:48 mail2 clamd[11454]: Self checking every 1800 seconds.
Mar 4 12:42:50 mail2 zimbramon[10391]: 10391:info: Starting snmp
Mar 4 12:42:50 mail2 zimbramon[10391]: 10391:info: Starting spell
Mar 4 12:42:50 mail2 zimbramon[10391]: 10391:info: Starting mta
Mar 4 12:42:51 mail2 zimbramon[11491]: 11491:info: zmmtaconfig: zmmtaconfig already running at 10950
Mar 4 12:42:51 mail2 postfix/postfix-script[11569]: warning: not owned by root: /opt/zimbra/postfix-2.4.3.4z/conf/main.cf
Mar 4 12:42:51 mail2 postfix/postfix-script[11582]: starting the Postfix mail system
Mar 4 12:42:51 mail2 postfix/master[11583]: daemon started -- version 2.4.3, configuration /opt/zimbra/postfix-2.4.3.4z/conf
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 78BD82000B2: from=<>, size=4626, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 8A8842000CC: from=<>, size=17736, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 069AE20090B: from=, size=2757, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 2243520090A: from=, size=6496, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 3F08D200907: from=, size=1307, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 41F2520090E: from=, size=155432, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 5BF1720090C: from=, size=4434, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 5549B200935: from=, size=21042, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 647B420032B: from=<>, size=6969, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 641AD2002A8: from=<>, size=9561, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: 97AAC200933: from=, size=102716, nrcpt=1 (queue active)
Mar 4 12:42:52 mail2 postfix/qmgr[11585]: D2F14200934: from=, size=1998, nrcpt=2 (queue active)
Mar 4 12:42:52 mail2 saslauthd[11598]: detach_tty : master pid is: 11598
Mar 4 12:42:52 mail2 saslauthd[11598]: ipc_init : listening on socket: /opt/zimbra/cyrus-sasl-2.1.22.3z/state/mux
Mar 4 12:42:52 mail2 zimbramon[10391]: 10391:info: Starting stats
Mar 4 12:43:01 mail2 postfix/smtpd[11858]: connect from 68-116-95-232.dhcp.trlk.ca.charter.com[68.116.95.232]
Mar 4 12:43:02 mail2 postfix/smtpd[11858]: NOQUEUE: reject: RCPT from 68-116-95-232.dhcp.trlk.ca.charter.com[68.116.95.232]: 550 5.1.1 : Recipient address rejected: leetackle.com; from= to= proto=ESMTP helo=<68-116-95-232.dhcp.trlk.ca.charter.com>
Mar 4 12:43:02 mail2 postfix/smtpd[11858]: lost connection after RCPT from 68-116-95-232.dhcp.trlk.ca.charter.com[68.116.95.232]
Mar 4 12:43:02 mail2 postfix/smtpd[11858]: disconnect from 68-116-95-232.dhcp.trlk.ca.charter.com[68.116.95.232]
Mar 4 12:43:06 mail2 postfix/smtpd[11858]: warning: 189.97.27.54: hostname ip-189-97-27-54.user.vivozap.com.br verification failed: Name or service not known
| |
03-04-2009, 01:11 PM
| | Intermediate Member | |
Posts: 17
| |  imap/pop3
Now I have been trying to access any email via pop3 or imap...If I can extract it via imap/pop3, I can start over with a fresh install...there is too much email to abandon and start over.....
Thunderbird keeps timing out...I have tried multiple users and both imap and pop3 services.....
Nmap reports that both ports are open:
PORT STATE SERVICE VERSION
25/tcp open smtp Postfix smtpd
80/tcp open http?
110/tcp open pop3?
143/tcp open imap?
389/tcp open ldap OpenLDAP 2.2.X
443/tcp open ssl/unknown
465/tcp open ssl/smtp Postfix smtpd
These commands were run from another host:
$ telnet mail2.leetackle.com 110
Trying 174.141.0.158...
Connected to mail2.leetackle.com.
Escape character is '^]'.
$ telnet mail2.leetackle.com 143
Trying 174.141.0.158...
Connected to mail2.leetackle.com.
Escape character is '^]'.
Thats all that telnet can give me...I am waiting for an:
OK IMAP4 ready
but I don't get any other responses....
Is there any way to rescue this system? Or should I start working on my resume? |
03-06-2009, 12:04 AM
| | |
Code: su - zimbra
zmlocalconfig | grep {old IP Address}
zmprov -l gs `zmhostname` | grep {old IP Address}
__________________  |
03-06-2009, 11:04 AM
| | Intermediate Member | |
Posts: 17
| | no output...
neither of those commands provided any output at all...I passed out in my cubicle last night around 1900hrs from frustration...
I had no choice but to setup a new server so that the employees can at least start receiving email as of yesterday afternoon...what is curious is the nmap scans/telnet connects to each machine is different:
Nmap of mail2.leetackle.com(bad machine):
PORT STATE SERVICE VERSION
22/tcp open ssh OpenSSH 4.2p1 Debian 7ubuntu3.5 (protocol 2.0)
25/tcp open smtp Postfix smtpd
80/tcp open http?
110/tcp open pop3?
143/tcp open imap?
389/tcp open ldap OpenLDAP 2.2.X
443/tcp open ssl/unknown
465/tcp open ssl/smtp Postfix smtpd
$ telnet mail2.leetackle.com 143
Trying 174.141.0.158...
Connected to mail2.leetackle.com.
Escape character is '^]'.
it looks like imap picks up the phone, but never says hello...
Nmap of mail.leetackle.com(new machine):
PORT STATE SERVICE VERSION
25/tcp open smtp Postfix smtpd
80/tcp open http?
110/tcp open pop3 Zimbra pop3d
143/tcp open imap Zimbra imapd
389/tcp open ldap OpenLDAP 2.2.X
465/tcp open ssl/smtp Postfix smtpd
993/tcp open ssl/imap Zimbra imapd
995/tcp open ssl/pop3 Zimbra pop3d
$ telnet mail.leetackle.com 143
Trying 174.141.0.148...
Connected to mail.leetackle.com.
Escape character is '^]'.
* OK mail.leetackle.com Zimbra IMAP4rev1 service ready
and yes, both machines are the same OS and version of zimbra(and from what I can tell and almost identical configuration...)
A dim little lightbulb when off and I said maybe the Imap server on the old machine was expecting only an SSL connection, so I ran this command...this is just special....... Quote:
$ zmprov mcf zimbraImapCleartextLoginEnabled true
ERROR: zclient.IO_ERROR (invoke cannot determine soap protocol in reply: Error 404 NOT_FOUNDHTTP ERROR: 404NOT_FOUND RequestURI=/service/admin/soap/ Powered by jetty:// , server: localhost) (cause: com.zimbra.common.soap.SoapParseException cannot determine soap protocol in reply: Error 404 NOT_FOUNDHTTP ERROR: 404NOT_FOUND RequestURI=/service/admin/soap/ Powered by jetty:// )
| I have no idea...here is a snippet of the latest zimbra.log: PHP Code: Mar 6 12:30:06 mail2 CRON[7390]: (pam_unix) session closed for user zimbra
Mar 6 12:30:57 mail2 zmmailboxdmgr[8014]: status requested
Mar 6 12:30:57 mail2 zmmailboxdmgr[8014]: status OK
Mar 6 12:30:58 mail2 zmmailboxdmgr[8074]: status requested
Mar 6 12:30:58 mail2 zmmailboxdmgr[8074]: status OK
Mar 6 12:31:37 mail2 postfix/smtp[17158]: 78BD849175: conversation with guardlake.com[99.198.151.78] timed out while receiving the initial server greeting
Mar 6 12:32:01 mail2 CRON[8205]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 6 12:32:05 mail2 zmmailboxdmgr[8397]: status requested
Mar 6 12:32:05 mail2 zmmailboxdmgr[8397]: status OK
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: antispam: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: antivirus: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: ldap: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: logger: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: mailbox: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: mta: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: snmp: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: spell: Running
Mar 6 12:32:06 mail2 zimbramon[8206]: 8206:info: 2009-03-06 12:32:01, STATUS: mail2.leetackle.com: stats: Running
Mar 6 12:32:06 mail2 CRON[8205]: (pam_unix) session closed for user zimbra
Mar 6 12:32:09 mail2 zmmailboxdmgr[8621]: status requested
Mar 6 12:32:09 mail2 zmmailboxdmgr[8621]: status OK
Mar 6 12:32:10 mail2 zmmailboxdmgr[8677]: status requested
Mar 6 12:32:10 mail2 zmmailboxdmgr[8677]: status OK
Mar 6 12:33:09 mail2 postfix/qmgr[7991]: 2BE8D65909: from=<3f1.4.74181726-36638157@throughoverjoyed.com>, size=8214, nrcpt=1 (queue active)
Mar 6 12:33:09 mail2 postfix/qmgr[7991]: A90F365657: from=<1-571509-leetackle.com?sas@mx5.navyfruitbanana.com>, size=7256, nrcpt=1 (queue active)
Mar 6 12:33:09 mail2 postfix/lmtp[8767]: connect to mail2.leetackle.com[174.141.0.158]: Connection refused (port 7025)
Mar 6 12:33:09 mail2 postfix/qmgr[7991]: DAC546592D: from=<405.4.74191374-18375518@gatewhere.com>, size=5246, nrcpt=1 (queue active)
Mar 6 12:33:09 mail2 postfix/lmtp[8768]: connect to mail2.leetackle.com[174.141.0.158]: Connection refused (port 7025)
Mar 6 12:33:09 mail2 postfix/qmgr[7991]: E259965655: from=<1-551008-leetackle.com?sas@mx6.gapfruit.com>, size=4896, nrcpt=1 (queue active)
Mar 6 12:33:09 mail2 postfix/lmtp[8770]: connect to mail2.leetackle.com[174.141.0.158]: Connection refused (port 7025)
Mar 6 12:33:09 mail2 postfix/lmtp[8772]: connect to mail2.leetackle.com[174.141.0.158]: Connection refused (port 7025)
Mar 6 12:33:09 mail2 postfix/lmtp[8767]: 2BE8D65909: to=<pwhite@leetackle.com>, relay=none, delay=74189, delays=74189/0.04/0.02/0, dsn=4.4.1, status=deferred (connect to mail2.leetackle.com[174.141.0.158]: Connection refused)
Mar 6 12:33:09 mail2 postfix/lmtp[8770]: DAC546592D: to=<pwhite@leetackle.com>, relay=none, delay=67739, delays=67739/0.02/0/0, dsn=4.4.1, status=deferred (connect to mail2.leetackle.com[174.141.0.158]: Connection refused)
Mar 6 12:33:09 mail2 postfix/lmtp[8772]: E259965655: to=<sas@leetackle.com>, relay=none, delay=59237, delays=59237/0.02/0/0, dsn=4.4.1, status=deferred (connect to mail2.leetackle.com[174.141.0.158]: Connection refused)
Mar 6 12:33:09 mail2 postfix/lmtp[8768]: A90F365657: to=<sas@leetackle.com>, relay=none, delay=59207, delays=59207/0.01/0/0, dsn=4.4.1, status=deferred (connect to mail2.leetackle.com[174.141.0.158]: Connection refused)
Mar 6 12:33:20 mail2 zmmailboxdmgr[9047]: status requested
Mar 6 12:33:20 mail2 zmmailboxdmgr[9047]: status OK
Mar 6 12:33:21 mail2 zmmailboxdmgr[9103]: status requested
Mar 6 12:33:21 mail2 zmmailboxdmgr[9103]: status OK
Mar 6 12:34:01 mail2 CRON[9192]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 6 12:34:04 mail2 zmmailboxdmgr[9328]: status requested
Mar 6 12:34:04 mail2 zmmailboxdmgr[9328]: status OK
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: antispam: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: antivirus: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: ldap: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: logger: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: mailbox: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: mta: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: snmp: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: spell: Running
Mar 6 12:34:05 mail2 zimbramon[9193]: 9193:info: 2009-03-06 12:34:01, STATUS: mail2.leetackle.com: stats: Running
Mar 6 12:34:05 mail2 CRON[9192]: (pam_unix) session closed for user zimbra
Mar 6 12:34:21 mail2 su[29746]: (pam_unix) session closed for user zimbra
Mar 6 12:34:31 mail2 zmmailboxdmgr[9749]: status requested
Mar 6 12:34:31 mail2 zmmailboxdmgr[9749]: status OK
Mar 6 12:34:32 mail2 zmmailboxdmgr[9805]: status requested
Mar 6 12:34:32 mail2 zmmailboxdmgr[9805]: status OK
Mar 6 12:35:01 mail2 CRON[9838]: (pam_unix) session opened for user zimbra by (uid=0)
Mar 6 12:35:01 mail2 CRON[9838]: (pam_unix) session closed for user zimbra
Mar 6 12:35:42 mail2 zmmailboxdmgr[10164]: status requested
Mar 6 12:35:42 mail2 zmmailboxdmgr[10164]: status OK
and /opt/zimbra/log/zmmailboxd.out: PHP Code: 67641240 INFO [Shutdown] log - Shutdown hook executing
67641245 INFO [Shutdown] log - Shutdown hook complete
CompilerOracle: exclude com/zimbra/cs/session/SessionMap.putAndPrune
0 INFO [main] log - Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog
Zimbra server reserving server socket port=110 bindaddr=174.141.0.158 ssl=false
Zimbra server reserving server socket port=143 bindaddr=174.141.0.158 ssl=false
865 INFO [main] log - Setting umask=027
866 INFO [main] log - Setting GID=1001
867 INFO [main] log - Setting UID=1001
867 INFO [main] log - jetty-6.1.5
905 ERROR [main] log - failed ContextHandlerCollection@64ab4d
java.lang.IllegalArgumentException: Illegal context spec:null
at org.mortbay.jetty.handler.ContextHandlerCollection.mapContexts(ContextHandlerCollection.java:87)
at org.mortbay.jetty.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:160)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerCollection.doStart(HandlerCollection.java:147)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.jetty.Server.doStart(Server.java:217)
at org.mortbay.setuid.SetUIDServer.doStart(SetUIDServer.java:100)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.xml.XmlConfiguration.main(XmlConfiguration.java:979)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.mortbay.start.Main.invokeMain(Main.java:183)
at org.mortbay.start.Main.start(Main.java:497)
at org.mortbay.start.Main.main(Main.java:115)
936 INFO [main] log - Opened /opt/zimbra/jetty-6.1.5/logs/access_log.2009-03-06
937 ERROR [main] log - failed HandlerCollection@bcda2d
java.lang.IllegalArgumentException: Illegal context spec:null
at org.mortbay.jetty.handler.ContextHandlerCollection.mapContexts(ContextHandlerCollection.java:87)
at org.mortbay.jetty.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:160)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerCollection.doStart(HandlerCollection.java:147)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.jetty.Server.doStart(Server.java:217)
at org.mortbay.setuid.SetUIDServer.doStart(SetUIDServer.java:100)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.xml.XmlConfiguration.main(XmlConfiguration.java:979)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.mortbay.start.Main.invokeMain(Main.java:183)
at org.mortbay.start.Main.start(Main.java:497)
at org.mortbay.start.Main.main(Main.java:115)
937 ERROR [main] log - failed RewriteHandler@97d01f
java.lang.IllegalArgumentException: Illegal context spec:null
at org.mortbay.jetty.handler.ContextHandlerCollection.mapContexts(ContextHandlerCollection.java:87)
at org.mortbay.jetty.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:160)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerCollection.doStart(HandlerCollection.java:147)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.jetty.Server.doStart(Server.java:217)
at org.mortbay.setuid.SetUIDServer.doStart(SetUIDServer.java:100)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.xml.XmlConfiguration.main(XmlConfiguration.java:979)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.mortbay.start.Main.invokeMain(Main.java:183)
at org.mortbay.start.Main.start(Main.java:497)
at org.mortbay.start.Main.main(Main.java:115)
941 ERROR [main] log - Error starting handlers
java.lang.IllegalArgumentException: Illegal context spec:null
at org.mortbay.jetty.handler.ContextHandlerCollection.mapContexts(ContextHandlerCollection.java:87)
at org.mortbay.jetty.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:160)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerCollection.doStart(HandlerCollection.java:147)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.jetty.handler.HandlerWrapper.doStart(HandlerWrapper.java:117)
at org.mortbay.jetty.Server.doStart(Server.java:217)
at org.mortbay.setuid.SetUIDServer.doStart(SetUIDServer.java:100)
at org.mortbay.component.AbstractLifeCycle.start(AbstractLifeCycle.java:40)
at org.mortbay.xml.XmlConfiguration.main(XmlConfiguration.java:979)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.mortbay.start.Main.invokeMain(Main.java:183)
at org.mortbay.start.Main.start(Main.java:497)
at org.mortbay.start.Main.main(Main.java:115)
966 INFO [main] log - Started SelectChannelConnector@0.0.0.0:80
1477 INFO [main] log - Started SslSelectChannelConnector@0.0.0.0:443
1481 INFO [main] log - Started SslSelectChannelConnector@0.0.0.0:7071
1482 INFO [main] log - Started SelectChannelConnector@0.0.0.0:7072
now here's the kicker, mailbox.log is still 0 bytes...it has yet to be written to...and the perms are zimbra:zimbra
is the mailbox server starting to 100%...it says that it is running with a zmcontrol status....
I just need pop3 or imap to run long enough to download all the email to each users workstation......... |
03-06-2009, 11:08 AM
| | Intermediate Member | |
Posts: 17
| | it outputted the html to the command line...
the previous post was quoted instead of surrounded with php tags...the command below sent the html to the command line, which I have never seen before: PHP Code: zimbra@mail2:~$ zmprov mcf zimbraImapCleartextLoginEnabled true
ERROR: zclient.IO_ERROR (invoke cannot determine soap protocol in reply: <html><head><meta content="text/html; charset=ISO-8859-1" http-equiv="Content-Type"/><title>Error 404 NOT_FOUND</title></head><body><h2>HTTP ERROR: 404</h2><pre>NOT_FOUND</pre><p>RequestURI=/service/admin/soap/</p><p><i><small><a href="http://jetty.mortbay.org">Powered by jetty://</a></small></i></p></body></html>, server: localhost) (cause: com.zimbra.common.soap.SoapParseException cannot determine soap protocol in reply: <html><head><meta content="text/html; charset=ISO-8859-1" http-equiv="Content-Type"/><title>Error 404 NOT_FOUND</title></head><body><h2>HTTP ERROR: 404</h2><pre>NOT_FOUND</pre><p>RequestURI=/service/admin/soap/</p><p><i><small><a href="http://jetty.mortbay.org">Powered by jetty://</a></small></i></p></body></html>)
|
03-06-2009, 11:46 AM
| | Zimbra Consultant & Moderator | |
Posts: 19,653
| |
I'm a bit confused by some of the output that you've posted here. In your first post you've got the IP address of your server as 174.141.0.158 (mail2.leetackle.com) and latterly you have 174.141.0.148 (mail.leetackle.com) - which is the correct one? The usual question follows, post the output of the following commands (run on the Zimbra server): Code: cat /etc/hosts
cat /etc/resolv.conf
dig leetackle.com mx
dig leetackle.com any
host `hostname` <-- type that exactly and use backticks not single quotes
host -v mail.leetackle.com
host -v mail2.leetackle.com
__________________
Regards
Bill
|
03-06-2009, 01:17 PM
| | Intermediate Member | |
Posts: 17
| | up until my last post...
I only had one server running:
mail2.leetackle.com/174.141.0.158
I had to put up another because none of my users were happy with me...
mail.leetackle.com/174.141.0.148
now that I see only one digit differs, I would have given the newer server(mail.leetackle.com) another IP address...
mail2.leetackle.com is the problem server...the following commands were run from that host:
zimbra@mail2:~$ cat /etc/hosts
127.0.0.1 localhost.localdomain localhost
174.141.0.158 mail2.leetackle.com mail2
zimbra@mail2:~$ cat /etc/resolv.conf
nameserver 174.141.0.151
zimbra@mail2:~$ dig leetackle.com mx
; <<>> DiG 9.3.2-P2.1 <<>> leetackle.com mx
;; global options: printcmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 659
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 1
;; QUESTION SECTION:
;leetackle.com. IN MX
;; ANSWER SECTION:
leetackle.com. 3600 IN MX 10 mail.leetackle.com.
;; ADDITIONAL SECTION:
mail.leetackle.com. 3600 IN A 174.141.0.148
;; Query time: 1 msec
;; SERVER: 174.141.0.151#53(174.141.0.151)
;; WHEN: Fri Mar 6 15:09:53 2009
;; MSG SIZE rcvd: 68
but the mx records changed only yesterday from mail2 to mail as indicated in my previous post...
zimbra@mail2:~$ dig leetackle.com any
; <<>> DiG 9.3.2-P2.1 <<>> leetackle.com any
;; global options: printcmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 30852
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 5, AUTHORITY: 0, ADDITIONAL: 3
;; QUESTION SECTION:
;leetackle.com. IN ANY
;; ANSWER SECTION:
leetackle.com. 3600 IN A 174.141.0.154
leetackle.com. 3600 IN NS ns1.leetackle.com.
leetackle.com. 3600 IN NS ns2.leetackle.com.
leetackle.com. 3600 IN SOA ns1.leetackle.com. admin.leetackle.com. 63 900 600 86400 3600
leetackle.com. 3600 IN MX 10 mail.leetackle.com.
;; ADDITIONAL SECTION:
ns1.leetackle.com. 3600 IN A 174.141.0.151
ns2.leetackle.com. 3600 IN A 66.93.49.31
mail.leetackle.com. 3600 IN A 174.141.0.148
;; Query time: 1 msec
;; SERVER: 174.141.0.151#53(174.141.0.151)
;; WHEN: Fri Mar 6 15:11:15 2009
;; MSG SIZE rcvd: 194
zimbra@mail2:~$ host 'mail2.leetackle.com'
mail2.leetackle.com has address 174.141.0.158
zimbra@mail2:~$ host -v mail.leetackle.com
Trying "mail.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 42236
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 0
;; QUESTION SECTION:
;mail.leetackle.com. IN A
;; ANSWER SECTION:
mail.leetackle.com. 3600 IN A 174.141.0.148
Received 52 bytes from 174.141.0.151#53 in 1 ms
Trying "mail.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 57965
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;mail.leetackle.com. IN AAAA
;; AUTHORITY SECTION:
leetackle.com. 3600 IN SOA ns1.leetackle.com. admin.leetackle.com. 63 900 600 86400 3600
Received 82 bytes from 174.141.0.151#53 in 0 ms
Trying "mail.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 37124
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;mail.leetackle.com. IN MX
;; AUTHORITY SECTION:
leetackle.com. 3600 IN SOA ns1.leetackle.com. admin.leetackle.com. 63 900 600 86400 3600
Received 82 bytes from 174.141.0.151#53 in 0 ms
zimbra@mail2:~$ host -v mail2.leetackle.com
Trying "mail2.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 41232
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 0
;; QUESTION SECTION:
;mail2.leetackle.com. IN A
;; ANSWER SECTION:
mail2.leetackle.com. 3600 IN A 174.141.0.158
Received 53 bytes from 174.141.0.151#53 in 1 ms
Trying "mail2.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 31986
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;mail2.leetackle.com. IN AAAA
;; AUTHORITY SECTION:
leetackle.com. 3600 IN SOA ns1.leetackle.com. admin.leetackle.com. 63 900 600 86400 3600
Received 83 bytes from 174.141.0.151#53 in 0 ms
Trying "mail2.leetackle.com"
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 60553
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;mail2.leetackle.com. IN MX
;; AUTHORITY SECTION:
leetackle.com. 3600 IN SOA ns1.leetackle.com. admin.leetackle.com. 63 900 600 86400 3600
Received 83 bytes from 174.141.0.151#53 in 0 ms |
03-06-2009, 01:22 PM
| | Intermediate Member | |
Posts: 17
| | soap doesn't like me
I attempted to retrieve the list of contacts manually,
$ zmmailbox
mbox> adminAuthenticate adminuser adminpassword
at that point it spit out the soap errors straight to the term: PHP Code: ERROR: zclient.IO_ERROR (invoke cannot determine soap protocol in reply: <html><head><meta content="text/html; charset=ISO-8859-1" http-equiv="Content-Type"/><title>Error 404 NOT_FOUND</title></head><body><h2>HTTP ERROR: 404</h2><pre>NOT_FOUND</pre><p>RequestURI=/service/admin/soap/</p><p><i><small><a href="http://jetty.mortbay.org">Powered by jetty://</a></small></i></p></body></html>, server: localhost) (cause: com.zimbra.common.soap.SoapParseException cannot determine soap protocol in reply: <html><head><meta content="text/html; charset=ISO-8859-1" http-equiv="Content-Type"/><title>Error 404 NOT_FOUND</title></head><body><h2>HTTP ERROR: 404</h2><pre>NOT_FOUND</pre><p>RequestURI=/service/admin/soap/</p><p><i><small><a href="http://jetty.mortbay.org">Powered by jetty://</a></small></i></p></body></html>)
I didn't even get the chance to play with the zmmailbox contact commands.... | | Thread Tools | Search this Thread | | | | | Display Modes |  Linear Mode | | Why Join? Registering let's you ask questions, makes it easier to search, displays any files attached to posts, and notifies you about replies.   |
Bugzilla
Wiki
Source
