Results 1 to 3 of 3

Thread: Log file zmmtaconfig.log growing 100 MB / day!!

Hybrid View

  1. #1
    Join Date
    Jul 2007
    Location
    Dublin, Ireland
    Posts
    19
    Rep Power
    8

    Default Log file zmmtaconfig.log growing 100 MB / day!!

    Something strange is happening to my brand new install of Zabbix. I went through the install without any issue, and things started properly.
    Upon looking in ~/log I noticed that the file zmtaconfig.log was very large and kept getting larger (100 MB in a day). The log looks very verbose.
    The reason the log file gets so large is that this long verbose output is generated every 120 seconds. See:

    zimbra@zoo ~/log> date
    Sun Jul 15 19:55:29 UTC 2007
    zimbra@zoo ~/log> ll zmmtaconfig.log
    -rw-r----- 1 zimbra zimbra 1362078 Jul 15 19:54 zmmtaconfig.log
    zimbra@zoo ~/log> date
    Sun Jul 15 19:58:04 UTC 2007
    zimbra@zoo ~/log> ll zmmtaconfig.log
    -rw-r----- 1 zimbra zimbra 1441869 Jul 15 19:57 zmmtaconfig.log
    zimbra@zoo ~/log> date
    Sun Jul 15 20:03:36 UTC 2007
    zimbra@zoo ~/log> ll zmmtaconfig.log
    -rw-r----- 1 zimbra zimbra 1681242 Jul 15 20:03 zmmtaconfig.log
    zimbra@zoo ~/log> date
    Sun Jul 15 20:49:39 UTC 2007
    zimbra@zoo ~/log> ll zmmtaconfig.log
    -rw-r----- 1 zimbra zimbra 3436644 Jul 15 20:49 zmmtaconfig.log
    zimbra@zoo ~/log> date
    Sun Jul 15 22:05:19 UTC 2007
    zimbra@zoo ~/log> ll zmmtaconfig.log
    -rw-r----- 1 zimbra zimbra 6309120 Jul 15 22:04 zmmtaconfig.log

    I'm curious to find out what I have done wrong? I didn't deviate from the default configuration options and did not change anything through the admin interface.

    I have put extracts of the zmmtaconfig.log at the end of this message (edited for brevity).

    Strangely enough in this log it reports that zmclamdctl returns a 1 status but when I try from the command line I get 0:

    zimbra@zoo ~/log> /opt/zimbra/bin/zmclamdctl status norewrite
    zimbra@zoo ~/log> echo $?
    0

    Here is my setup:
    - Linux Debian with kernel 2.6.21-5
    - Zimbra installed from zcs-4.5.6_GA_1044.DEBIAN3.1.tgz

    Here is the host file:
    # /etc/hosts
    127.0.0.1 localhost
    88.88.88.123 zoo.zcsdomain.com zoo

    Here is the DNS stuff:
    zimbra@zoo:~/log$ dig mx zcsdomain.com

    ; <<>> DiG 9.3.4 <<>> mx zcsdomain.com
    ;; global options: printcmd
    ;; Got answer:
    ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 50925
    ;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 2, ADDITIONAL: 2

    ;; QUESTION SECTION:
    ;zcsdomain.com. IN MX

    ;; ANSWER SECTION:
    zcsdomain.com. 300 IN MX 10 zoo.zcsdomain.com.

    ;; AUTHORITY SECTION:
    zcsdomain.com. 300 IN NS ns.a.com.
    zcsdomain.com. 300 IN NS ns2.a.com.

    ;; ADDITIONAL SECTION:
    zoo.zcsdomain.com. 300 IN A 88.88.88.123
    ns.a.com. 170132 IN A 99.99.99.123

    ;; Query time: 144 msec
    ;; SERVER: 88.88.88.60#53(88.88.88.60)
    ;; WHEN: Sat Jul 14 21:17:21 2007
    ;; MSG SIZE rcvd: 128

    Everything started up fine and is running:
    zimbra@zoo:~/log$ zmcontrol status
    Host zoo.zcsdomain.com
    antispam Running
    antivirus Running
    ldap Running
    logger Running
    mailbox Running
    mta Running
    snmp Running
    spell Running

    Below are extracts of thhsi growing log file. Every 120 seconds it spits 100K so I'm not copying the whole thing.

    Sun Jul 15 22:04:49 2007 main::getLocalConfig::163 Entering Function
    Sun Jul 15 22:04:49 2007 main::getLocalConfig::163 localconfig localconfig /opt/zimbra/bin/zmlocalconfig -s -x
    Sun Jul 15 22:04:49 2007 main::executeCommand::228 Entering Function
    Sun Jul 15 22:04:49 2007 main::executeCommand::228 Executing: localconfig /opt/zimbra/bin/zmlocalconfig -s -x
    /opt/zimbra/bin/zmclamdctl status norewrite returned 0000:Sun Jul 15 22:04:49 2007 main::executeCommand::228 Executed: Local server configuration rc=0
    Sun Jul 15 22:04:49 2007 main::getLocalConfig::163 av_notify_user=admin@zcsdomain.com
    Sun Jul 15 22:04:49 2007 main::getLocalConfig::163 calendar_outlook_compatible_allday_events=true

    [...]

    Sun Jul 15 22:04:54 2007 main::getServerConfig::165 zimbraTableMaintenanceMinRows=10000
    Sun Jul 15 22:04:54 2007 main::getServerConfig::165 zimbraTableMaintenanceOperation=ANALYZE
    Sun Jul 15 22:04:54 2007 main::getServerConfig::165 zimbraVirusDefinitionsUpdateFrequency=2h
    Sun Jul 15 22:04:54 2007 main::getServerConfig::165 zimbraXMPPEnabled=no
    Sun Jul 15 22:04:54 2007 main::getServerConfig::165 Leaving Function
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=antivirus with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 SERVICE lookup antivirus=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::466 Checking conditional for negate=0 type=SERVICE antivirus=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::466 Checking conditional for negate=0 type=SERVICE antivirus=1 return=1
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding file rewrite conf/amavisd.conf.in to section antivirus
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding file rewrite conf/salocal.cf.in to section antivirus
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding file rewrite conf/clamd.conf.in to section antivirus
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding file rewrite conf/freshclam.conf.in to section antivirus
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraVirusWarnRecipient to required vars: processing VAR zimbraVirusWarnRecipient
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraVirusWarnAdmin to required vars: processing VAR zimbraVirusWarnAdmin

    [...]

    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=mta with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 SERVICE lookup mta=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::466 Checking conditional for negate=0 type=SERVICE mta=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::466 Checking conditional for negate=0 type=SERVICE mta=1 return=1
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=antivirus with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 SERVICE lookup antivirus=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=SERVICE antivirus=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=SERVICE antivirus=1 return=1
    Sun Jul 15 22:04:54 2007 main::readConfig::176 checkConditional SERVICE antivirus is true
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=antispam with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 SERVICE lookup antispam=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=SERVICE antispam=1
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=SERVICE antispam=1 return=1
    Sun Jul 15 22:04:54 2007 main::readConfig::176 checkConditional SERVICE antispam is true
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraMtaRestriction to required vars: processing VAR zimbraMtaRestriction
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraMtaBlockedExtension to required vars: processing VAR zimbraMtaBlockedExtension
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraMtaRecipientDelimiter to required vars: processing VAR zimbraMtaRecipientDelimiter
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbraMtaMyNetworks to required vars: processing VAR zimbraMtaMyNetworks
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=zimbraMtaMyNetworks with type=VAR
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=VAR zimbraMtaMyNetworks=
    Sun Jul 15 22:04:54 2007 main::checkConditional::507 Checking conditional for negate=0 type=VAR zimbraMtaMyNetworks= return=0
    Sun Jul 15 22:04:54 2007 main::readConfig::176 checkConditional VAR zimbraMtaMyNetworks is false: 'if VAR zimbraMtaMyNetworks'
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Skipping line='POSTCONF mynetworks VAR zimbraMtaMyNetworks'
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Skipping line='fi'
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding zimbra_server_hostname to required vars: processing LOCAL zimbra_server_hostname
    Sun Jul 15 22:04:54 2007 main::readConfig::176 Adding file rewrite conf/postfix_header_checks.in to section mta

    [...]

    Sun Jul 15 22:04:54 2007 main::lookUpConfig::651 Looking up key=antivirus with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::651 SERVICE lookup antivirus=1
    Sun Jul 15 22:04:54 2007 main:rocessIsNotRunning::651 ProcessIsNotRunning antivirus
    Sun Jul 15 22:04:54 2007 main::controlProcess::840 CONTROL ANTIVIRUS: /opt/zimbra/bin/zmclamdctl status norewrite
    Sun Jul 15 22:04:54 2007 main::controlProcess::840 1
    Sun Jul 15 22:04:54 2007 main::controlProcess::840 /opt/zimbra/bin/zmclamdctl returned non-zero status 0
    Sun Jul 15 22:04:54 2007 main::controlProcess::840 Failed to status antivirus rc=0
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Entering Function
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking keys for antivirus
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=zimbraVirusBlockEncryptedArchive with type=VAR

    [...]

    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_mailq_path with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_mailq_path=/opt/zimbra/postfix-2.2.9/sbin/mailq
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_recipient_restrictions.cf with type=FILE
    Sun Jul 15 22:04:54 2007 main::rewriteConfig::409 Entering Function
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::783 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::rewriteConfig::409 Leaving Function
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_recipient_restrictions.cf=reject_non_fqdn_ recipient, permit_sasl_authenticated, permit_mynetworks, reject_unlisted_recipient, reject_invalid_hostname, reject_non_fqdn_sender, reject_unauth_destination, permit
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_virtual_mailbox_maps with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_virtual_mailbox_maps=ldap:/opt/zimbra/conf/ldap-vmm.cf
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_queue_directory with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_queue_directory=/opt/zimbra/postfix-2.2.9/spool

    [...]

    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=zimbraMtaRestriction with type=VAR
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking zimbraMtaRestriction=reject_invalid_hostname reject_non_fqdn_sender
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=zimbraMtaRelayHost with type=VAR
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking zimbraMtaRelayHost=
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Required key is not defined zimbraMtaRelayHost=''
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_newaliases_path with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_newaliases_path=/opt/zimbra/postfix-2.2.9/sbin/newaliases
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_smtpd_client_restrictions with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_smtpd_client_restrictions=reject_unauth_pi pelining
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_virtual_transport with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_virtual_transport=error
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::434 Looking up key=zimbraMtaDnsLookupsEnabled with type=VAR
    Sun Jul 15 22:04:54 2007 main::checkConditional::393 Checking conditional for negate=1 type=VAR zimbraMtaDnsLookupsEnabled=yes
    Sun Jul 15 22:04:54 2007 main::checkConditional::393 Checking conditional for negate=1 type=VAR zimbraMtaDnsLookupsEnabled=yes return=0
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking !zimbraMtaDnsLookupsEnabled=no
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_smtpd_data_restrictions with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_smtpd_data_restrictions=reject_unauth_pipe lining
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_smtpd_tls_key_file with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_smtpd_tls_key_file=/opt/zimbra/conf/smtpd.key
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=postfix_sender_canonical_maps with type=LOCAL
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking postfix_sender_canonical_maps=ldap:/opt/zimbra/conf/ldap-scm.cf
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Checking keys for sasl
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::566 Looking up key=zimbraMtaAuthURL with type=VAR

    [...]

    Sun Jul 15 22:04:54 2007 main::lookUpConfig::580 Looking up key=antivirus with type=SERVICE
    Sun Jul 15 22:04:54 2007 main::lookUpConfig::580 SERVICE lookup antivirus=1
    Sun Jul 15 22:04:54 2007 main::compareKeys::182 Leaving Function
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for antivirus
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section antivirus did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for antispam
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section antispam did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for mta
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section mta did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for sasl
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section sasl did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for webxml
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section webxml did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for mailbox
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section mailbox did not change skipping
    Sun Jul 15 22:04:54 2007 main::compileActions::185 compiling actions for perdition
    Sun Jul 15 22:04:54 2007 main::compileActions::185 Section perdition did not change skipping
    Sun Jul 15 22:04:54 2007 main::unk Sleeping for 120.

  2. #2
    Join Date
    Jul 2006
    Posts
    623
    Rep Power
    10

    Default

    Looks like the default loglevel was set to high. You can edit /opt/zimbra/libexec/zmmtaconfig and change the default loglevel to 3. This is on line 55.

    Bug 18445 was created to get this lowered to a sane level.
    Bugzilla - Wiki - Downloads - Before posting... Search!

  3. #3
    Join Date
    Jul 2007
    Location
    Dublin, Ireland
    Posts
    19
    Rep Power
    8

    Thumbs up It was loglevel indeed

    Thanks, this did the trick. I still get log entires every 120 seconds but it's only a few lines now.

Similar Threads

  1. centos 5 zimbra 4.5.6 no statistics
    By rutman286 in forum Installation
    Replies: 9
    Last Post: 08-14-2007, 09:30 AM
  2. Opensource backup Question.
    By nfear24 in forum Administrators
    Replies: 3
    Last Post: 03-31-2007, 11:47 PM
  3. Traslation SVN tree status
    By meikka in forum I18N/L10N - Translations
    Replies: 7
    Last Post: 02-13-2007, 10:13 AM
  4. Replies: 2
    Last Post: 10-02-2006, 08:44 AM
  5. M3 problem with shares
    By titangears in forum Users
    Replies: 4
    Last Post: 01-12-2006, 12:01 PM

Posting Permissions

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