[code]linux:/home/matt # tail -F /var/log/mail
Nov 13 01:44:10 linux postfix/smtpd[15803]: name_mask: resource
Nov 13 01:44:10 linux postfix/smtpd[15803]: name_mask: software
Nov 13 01:44:10 linux postfix/smtpd[15803]: error: incorrect SMTP server privileges: uid=0 euid=0
Nov 13 01:44:10 linux postfix/smtpd[15803]: fatal: the Postfix SMTP server must run with $mail_owner privileges
Nov 13 01:44:11 linux postfix/master[8962]: warning: process /usr/lib/postfix/smtpd pid 15798 exit status 1
Nov 13 01:44:11 linux postfix/master[8962]: warning: /usr/lib/postfix/smtpd: bad command startup -- throttling
Nov 13 01:44:11 linux postfix/master[8962]: warning: process /usr/lib/postfix/smtpd pid 15799 exit status 1
Nov 13 01:44:11 linux postfix/master[8962]: warning: process /usr/lib/postfix/smtpd pid 15800 exit status 1
Nov 13 01:44:11 linux postfix/master[8962]: warning: process /usr/lib/postfix/smtpd pid 15802 exit status 1
Nov 13 01:44:11 linux postfix/master[8962]: warning: process /usr/lib/postfix/smtpd pid 15803 exit status 1
Nov 13 01:45:01 linux imapd: Connection, ip=[::ffff:127.0.0.1]
Nov 13 01:45:01 linux imapd: Disconnected, ip=[::ffff:127.0.0.1], time=0
Nov 13 01:45:04 linux postfix/master[8962]: terminating on signal 15
Nov 13 01:45:05 linux postfix/postfix-script[16130]: starting the Postfix mail system
Nov 13 01:45:05 linux postfix/master[16131]: daemon started -- version 2.7.1, configuration /etc/postfix
Nov 13 01:45:06 linux postfix/qmgr[16146]: F03C71280C9: from=<wwwrun@linux.e-penguin.idv.tw>, size=616, nrcpt=1 (queue active)
Nov 13 01:45:06 linux amavis[4325]: (04325-03) Net::Server: 2010/11/13-01:45:06 CONNECT TCP Peer: "127.0.0.1:43451" Local: "127.0.0.1:10024"
Nov 13 01:45:06 linux amavis[4325]: (04325-03) idle_proc, hi : was idle, 2674672.6 ms, total idle 11873.414 s, busy 46.676 s
Nov 13 01:45:06 linux amavis[4325]: (04325-03) loaded base policy bank
Nov 13 01:45:06 linux amavis[4325]: (04325-03) lookup_ip_acl (inet_acl): key="127.0.0.1" matches "127.0.0.1", result=1
Nov 13 01:45:06 linux amavis[4325]: (04325-03) process_request: fileno sock=11, STDIN=0, STDOUT=1
Nov 13 01:45:06 linux amavis[4325]: (04325-03) switch_to_my_time 480 s, new request
Nov 13 01:45:06 linux amavis[4325]: (04325-03) process_request: suggested_protocol="" on TCP
Nov 13 01:45:06 linux amavis[4325]: (04325-04) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 4: was busy, 1.6 ms, total idle 11873.414 s, busy 46.677 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 46.677 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) SMTP< EHLO mail.e-penguin.idv.tw\r\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP EHLO received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-[127.0.0.1]
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-VRFY
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-PIPELINING
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-SIZE
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-ENHANCEDSTATUSCODES
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-8BITMIME
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250-DSN
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250 XFORWARD NAME ADDR PORT PROTO HELO SOURCE
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 6: was busy, 1.1 ms, total idle 11873.414 s, busy 46.679 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 46.679 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP< XFORWARD SOURCE=LOCAL\r\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP XFORWARD received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250 2.5.0 Ok XFORWARD
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 6: was busy, 0.5 ms, total idle 11873.414 s, busy 46.679 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 46.679 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP< MAIL FROM:<wwwrun@linux.e-penguin.idv.tw> SIZE=616\r\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP MAIL received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) check_mail_begin_task: task_count=4
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_ip_acl: key="0.0.0.0", no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [debug_sender] => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250 2.1.0 Sender <wwwrun@linux.e-penguin.idv.tw> OK
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 6: was busy, 1.2 ms, total idle 11873.414 s, busy 46.680 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 46.680 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP< RCPT TO:<matt@e-penguin.idv.tw> ORCPT=rfc822;matt@e-penguin.idv.tw\r\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP RCPT received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_acl(matt@e-penguin.idv.tw), no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [local_domains] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: matt@e-penguin.idv.tw, @e-penguin.idv.tw, @.e-penguin.idv.tw, @.idv.tw, @.tw, @.
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql "matt@e-penguin.idv.tw", query args: "ARRAY(0x67e9b08)", "ARRAY(0x64a38d0)", "ARRAY(0x67e9988)", "ARRAY(0x67e9928)", "ARRAY(0x67e98e0)", "ARRAY(0x67e97d8)"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql select: SELECT *,spamfilter_users.id FROM spamfilter_users LEFT JOIN spamfilter_policy ON spamfilter_users.policy_id=spamfilter_policy.id WHERE spamfilter_users.email IN (?,?,?,?,?,?) ORDER BY spamfilter_users.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql begin, nontransaction
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql: executing clause: SELECT *,spamfilter_users.id FROM spamfilter_users LEFT JOIN spamfilter_policy ON spamfilter_users.policy_id=spamfilter_policy.id WHERE spamfilter_users.email IN (?,?,?,?,?,?) ORDER BY spamfilter_users.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql(matt@e-penguin.idv.tw) matches, result=(id=>"1", sys_userid=>"1", sys_groupid=>"0", sys_perm_user=>"riud", sys_perm_group=>"riud", sys_perm_other=>"r", server_id=>"1", priority=>"10", policy_id=>"4", email=>"matt@e-penguin.idv.tw", fullname=>"matt@e-penguin.idv.tw", local=>"Y", id=>"1", sys_userid=>"1", sys_groupid=>"0", sys_perm_user=>"riud", sys_perm_group=>"riud", sys_perm_other=>"r", policy_name=>"Wants viruses", virus_lover=>"Y", spam_lover=>"N", banned_files_lover=>"Y", bad_header_lover=>"Y", bypass_virus_checks=>"N", bypass_spam_checks=>"N", bypass_banned_checks=>"N", bypass_header_checks=>"N", spam_modifies_subj=>"Y", virus_quarantine_to=>-, spam_quarantine_to=>-, banned_quarantine_to=>-, bad_header_quarantine_to=>-, clean_quarantine_to=>-, other_quarantine_to=>-, spam_tag_level=>"3", spam_tag2_level=>"6.9", spam_kill_level=>"6.9", spam_dsn_cutoff_level=>-, spam_quarantine_cutoff_level=>-, addr_extension_virus=>-, addr_extension_spam...
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ...=>-, addr_extension_banned=>-, addr_extension_bad_header=>-, warnvirusrecip=>-, warnbannedrecip=>-, warnbadhrecip=>-, newvirus_admin=>-, virus_admin=>-, banned_admin=>-, bad_header_admin=>-, spam_admin=>-, spam_subject_tag=>-, spam_subject_tag2=>-, message_size_limit=>-, banned_rulenames=>-, id=>"1")
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(message_size_limit) "matt@e-penguin.idv.tw" result=undef
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [message_size_limit] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 250 2.1.5 Recipient <matt@e-penguin.idv.tw> OK
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 6: was busy, 2.5 ms, total idle 11873.414 s, busy 46.683 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 46.683 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP< DATA\r\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP DATA received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP::10024 /var/spool/amavis/tmp/amavis-20101112T222625-04325: <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw> SIZE=616 Received: from mail.e-penguin.idv.tw ([127.0.0.1]) by localhost (linux-jfp8.site [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <matt@e-penguin.idv.tw>; Sat, 13 Nov 2010 01:45:06 +0800 (CST)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP> 354 End data with <CR><LF>.<CR><LF>
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, receiving data
Nov 13 01:45:06 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, data-end received
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ESMTP< .<CR><LF>
Nov 13 01:45:06 linux amavis[4325]: (04325-04) smtp connection cache, dt: 2674.7, state: 0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer digest_init: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) get_body_digest: reading header section
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer digest_hdr: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) get_body_digest: reading mail body
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer digest_body: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) body type (ESMTP BODY): unlabeled, good (h=0, b=0)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) body hash: 2eb3480abe5095da69bbf4cf30c27a87
Nov 13 01:45:06 linux amavis[4325]: (04325-04) parse_ip_address_from_received:
Nov 13 01:45:06 linux amavis[4325]: (04325-04) client IP address unknown, fetching from Received:
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Original mail size: 616; quota set to: 308000 bytes
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Checking: l-UTyiYeLiQn <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>
Nov 13 01:45:06 linux amavis[4325]: (04325-04) 2822.From: <webmaster@localhost.tld>, 2821.Mail_From: <wwwrun@linux.e-penguin.idv.tw>
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(local) "matt@e-penguin.idv.tw" result=Y
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [local_domains] => true, "matt@e-penguin.idv.tw" matches, result="Y", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(bypass_virus_checks) "matt@e-penguin.idv.tw" result=0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [bypass_virus_checks] => false, "matt@e-penguin.idv.tw" matches, result="0", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(bypass_banned_checks) "matt@e-penguin.idv.tw" result=0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [bypass_banned_checks] => false, "matt@e-penguin.idv.tw" matches, result="0", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(bypass_spam_checks) "matt@e-penguin.idv.tw" result=0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [bypass_spam_checks] => false, "matt@e-penguin.idv.tw" matches, result="0", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Cached virus check expired, TTL = 180 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) cached 2eb3480abe5095da69bbf4cf30c27a87 from <wwwrun@linux.e-penguin.idv.tw> (0,0)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) cache entry age: . c=20101112T132050 a=20101112T170107
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Extracting mime components
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Issued a new file name: p001
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Charging 51 bytes to remaining quota 308000 (out of 308000, (0%)) - by mime_decode
Nov 13 01:45:06 linux amavis[4325]: (04325-04) p001 1 Content-Type: text/plain, size: 51 B, name:
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer mime_decode: remaining time = 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer mime_decode-1: remaining time = 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) decode_parts: level=1, #parts=1 : p001
Nov 13 01:45:06 linux amavis[4325]: (04325-04) running file(1) on 1 files, arglist size 18
Nov 13 01:45:06 linux amavis[4325]: (04325-04) run_command: [16163] /usr/bin/file p001 </dev/null 2>&1
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: target fd0 closing, to become < /dev/null
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: target fd1 closing, to become > &=15
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: target fd1 dup2 from fd15 > &=15
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: source fd15 closed
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: target fd2 closing, to become > &1
Nov 13 01:45:06 linux amavis[16163]: (04325-04) open_on_specific_fd: target fd2 dup2 from fd1 > &1
Nov 13 01:45:06 linux amavis[4325]: (04325-04) result line from file(1): p001: ASCII text\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_re("ASCII text") matches key "(?i-xsm:^(ASCII|text)\b)", result="asc"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [map_full_type_to_short_type] => true, "ASCII text" matches, result="asc", matching_key="(?i-xsm:^(ASCII|text)\\b)"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) File-type of p001: ASCII text; (asc)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) do_ascii: Decoding part p001
Nov 13 01:45:06 linux amavis[4325]: (04325-04) do_ascii: Setting sigaction handler, was 0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) timer set to 320 s (was 480 s)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) do_ascii: Decoding part p001 (0 items), uulib V0.5pl20
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer do_ascii: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) decompose_part: p001 - atomic
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer parts_decode: remaining time = 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(bypass_header_checks) "matt@e-penguin.idv.tw" result=0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [bypass_header_checks] => false, "matt@e-penguin.idv.tw" matches, result="0", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) check_header: 0, OK
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(bypass_header_checks) "matt@e-penguin.idv.tw" result=0
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [bypass_header_checks] => false, "matt@e-penguin.idv.tw" matches, result="0", matching_key="/cached/"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Checking for banned types and filenames
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(banned_rulenames) "matt@e-penguin.idv.tw" result=undef
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup: (scalar) matches, result="DEFAULT"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [banned_filename], 1 matches for "matt@e-penguin.idv.tw", results: "(constant:DEFAULT)"=>"DEFAULT"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) collect banned table[0]: matt@e-penguin.idv.tw, tables: DEFAULT=>Amavis::Lookup::RE=ARRAY(0x1814de0)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) starting banned checks - traversing message structure tree
Nov 13 01:45:06 linux amavis[4325]: (04325-04) check_for_banned (p001) text/plain,.asc
Nov 13 01:45:06 linux amavis[4325]: (04325-04) doing banned check for matt@e-penguin.idv.tw on text/plain,.asc
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_re(["text/plain",".asc"]), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [check_bann:matt@e-penguin.idv.tw] => undef, ["text/plain",".asc"] does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [banned_namepath_re] => undef, "P=p001\tL=1\tM=text/plain\tT=asc" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) p.path matt@e-penguin.idv.tw: "P=p001,L=1,M=text/plain,T=asc"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) banned check: any=0, all=N (1)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_re("MAIL"), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [keep_decoded_original] => undef, "MAIL" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) Calling virus scanners, 1 files to scan in /var/spool/amavis/tmp/amavis-20101112T222625-04325/parts
Nov 13 01:45:06 linux amavis[4325]: (04325-04) run_av (ClamAV-clamd): query template(1,0): CONTSCAN {}\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer run_av: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer run_av: timer set to 384 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ask_av Using (ClamAV-clamd): CONTSCAN /var/spool/amavis/tmp/amavis-20101112T222625-04325/parts\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ask_daemon_internal: timer set to 10 s (was 384 s)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ClamAV-clamd: Connecting to socket /var/run/clamav/clamd
Nov 13 01:45:06 linux amavis[4325]: (04325-04) creating socket by IO::Socket::UNIX to /var/run/clamav/clamd
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ClamAV-clamd: Sending CONTSCAN /var/spool/amavis/tmp/amavis-20101112T222625-04325/parts\n to UNIX socket /var/run/clamav/clamd
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer ask_daemon_internal: timer set to 307 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer ask_daemon_internal: timer set to 384 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) prolong_timer ask_av: timer set to 480 s
Nov 13 01:45:06 linux amavis[4325]: (04325-04) ask_av (ClamAV-clamd) result: /var/spool/amavis/tmp/amavis-20101112T222625-04325/parts: OK\n
Nov 13 01:45:06 linux amavis[4325]: (04325-04) run_av (ClamAV-clamd): CLEAN
Nov 13 01:45:06 linux amavis[4325]: (04325-04) run_av (ClamAV-clamd) result: clean
Nov 13 01:45:06 linux amavis[4325]: (04325-04) wbl: checking sender <wwwrun@linux.e-penguin.idv.tw>, <webmaster@localhost.tld>
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(id) "matt@e-penguin.idv.tw" result=1
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [users.id], 1 matches for "matt@e-penguin.idv.tw", results: "/cached/"=>"1"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) wbl: (SQL) recip <matt@e-penguin.idv.tw>, 1 matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_acl(wwwrun@linux.e-penguin.idv.tw), no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [local_domains] => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: wwwrun@linux.e-penguin.idv.tw, @linux.e-penguin.idv.tw, @.linux.e-penguin.idv.tw, @.e-penguin.idv.tw, @.idv.tw, @.tw, @.
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql "wwwrun@linux.e-penguin.idv.tw", query args: "1", "ARRAY(0x67d8b30)", "ARRAY(0x5453df0)", "ARRAY(0x67e71b8)", "ARRAY(0x64865d8)", "ARRAY(0x64b79d0)", "ARRAY(0x67e7728)", "ARRAY(0x53aee00)"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql select: SELECT wb FROM spamfilter_wblist WHERE (spamfilter_wblist.rid=?) AND (spamfilter_wblist.email IN (?,?,?,?,?,?,?)) ORDER BY spamfilter_wblist.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql begin, nontransaction
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql: executing clause: SELECT wb FROM spamfilter_wblist WHERE (spamfilter_wblist.rid=?) AND (spamfilter_wblist.email IN (?,?,?,?,?,?,?)) ORDER BY spamfilter_wblist.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql, "wwwrun@linux.e-penguin.idv.tw" no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(wb), "wwwrun@linux.e-penguin.idv.tw" no matching records
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) wbl: (SQL) recip <matt@e-penguin.idv.tw>, rid=1, got: ""
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [blacklist_recip<matt@e-penguin.idv.tw>] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: wwwrun@linux.e-penguin.idv.tw, wwwrun@, linux.e-penguin.idv.tw, .linux.e-penguin.idv.tw, .e-penguin.idv.tw, .idv.tw, .tw, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(wwwrun@linux.e-penguin.idv.tw), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [blacklist_sender<wwwrun@linux.e-penguin.idv.tw>,blacklist_sender] => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [whitelist_recip<matt@e-penguin.idv.tw>] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: wwwrun@linux.e-penguin.idv.tw, wwwrun@, linux.e-penguin.idv.tw, .linux.e-penguin.idv.tw, .e-penguin.idv.tw, .idv.tw, .tw, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(wwwrun@linux.e-penguin.idv.tw), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [whitelist_sender<wwwrun@linux.e-penguin.idv.tw>,whitelist_sender] => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: matt@e-penguin.idv.tw, matt@, e-penguin.idv.tw, .e-penguin.idv.tw, .idv.tw, .tw, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(matt@e-penguin.idv.tw) matches keys: "."=>ARRAY(0x2250738)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [score_recip<matt@e-penguin.idv.tw>,score_sender], 1 matches for "matt@e-penguin.idv.tw", results: "."=>[Amavis::Lookup::RE=ARRAY(0x224aa80),HASH(0x224ab58)]
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_re("wwwrun@linux.e-penguin.idv.tw"), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: wwwrun@linux.e-penguin.idv.tw, wwwrun@, linux.e-penguin.idv.tw, .linux.e-penguin.idv.tw, .e-penguin.idv.tw, .idv.tw, .tw, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(wwwrun@linux.e-penguin.idv.tw), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [score_sender<wwwrun@linux.e-penguin.idv.tw>] => undef, "wwwrun@linux.e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_acl(webmaster@localhost.tld), no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [local_domains] => undef, "webmaster@localhost.tld" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: webmaster@localhost.tld, @localhost.tld, @.localhost.tld, @.tld, @.
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql "webmaster@localhost.tld", query args: "1", "ARRAY(0x67e95c8)", "ARRAY(0x67f8f30)", "ARRAY(0x654f190)", "ARRAY(0x67d0760)", "ARRAY(0x64978e8)"
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql select: SELECT wb FROM spamfilter_wblist WHERE (spamfilter_wblist.rid=?) AND (spamfilter_wblist.email IN (?,?,?,?,?)) ORDER BY spamfilter_wblist.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql begin, nontransaction
Nov 13 01:45:06 linux amavis[4325]: (04325-04) sql: executing clause: SELECT wb FROM spamfilter_wblist WHERE (spamfilter_wblist.rid=?) AND (spamfilter_wblist.email IN (?,?,?,?,?)) ORDER BY spamfilter_wblist.priority DESC
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql, "webmaster@localhost.tld" no match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_sql_field(wb), "webmaster@localhost.tld" no matching records
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup => undef, "webmaster@localhost.tld" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) wbl: (SQL) recip <matt@e-penguin.idv.tw>, rid=1, got: ""
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [blacklist_recip<matt@e-penguin.idv.tw>] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: webmaster@localhost.tld, webmaster@, localhost.tld, .localhost.tld, .tld, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(webmaster@localhost.tld), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [blacklist_sender<webmaster@localhost.tld>,blacklist_sender] => undef, "webmaster@localhost.tld" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [whitelist_recip<matt@e-penguin.idv.tw>] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: webmaster@localhost.tld, webmaster@, localhost.tld, .localhost.tld, .tld, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(webmaster@localhost.tld), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [whitelist_sender<webmaster@localhost.tld>,whitelist_sender] => undef, "webmaster@localhost.tld" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: matt@e-penguin.idv.tw, matt@, e-penguin.idv.tw, .e-penguin.idv.tw, .idv.tw, .tw, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(matt@e-penguin.idv.tw) matches keys: "."=>ARRAY(0x2250738)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [score_recip<matt@e-penguin.idv.tw>,score_sender], 1 matches for "matt@e-penguin.idv.tw", results: "."=>[Amavis::Lookup::RE=ARRAY(0x224aa80),HASH(0x224ab58)]
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_re("webmaster@localhost.tld"), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) query_keys: webmaster@localhost.tld, webmaster@, localhost.tld, .localhost.tld, .tld, .
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup_hash(webmaster@localhost.tld), no matches
Nov 13 01:45:06 linux amavis[4325]: (04325-04) lookup [score_sender<webmaster@localhost.tld>] => undef, "webmaster@localhost.tld" does not match
Nov 13 01:45:06 linux amavis[4325]: (04325-04) SpamControl: calling spam scanner SpamAssassin
Nov 13 01:45:06 linux amavis[4325]: (04325-04) timer set to 320 s for SA (was 480 s)
Nov 13 01:45:06 linux amavis[4325]: (04325-04) calling SA parse, SA version 3.3.1, 3.003001, data as GLOB
Nov 13 01:45:06 linux amavis[4325]: (04325-04) CALLING SA check
Nov 13 01:45:07 linux amavis[4325]: (04325-04) prolong_timer spam_scan_sa_finish: timer set to 479 s
Nov 13 01:45:07 linux amavis[4325]: (04325-04) spam_scan: score=0.799 autolearn=no tests=[DKIM_ADSP_NXDOMAIN=0.8,NO_RELAYS=-0.001]
Nov 13 01:45:07 linux amavis[4325]: (04325-04) prolong_timer spam_scan: remaining time = 479 s
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: stat is not numeric: ""
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: not deleting: 2eb3480abe5095da69bbf4cf30c27a87, was refreshed since
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: stat is not numeric: ""
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: not deleting: 2eb3480abe5095da69bbf4cf30c27a87, was refreshed since
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: stat is not numeric: ""
Nov 13 01:45:07 linux amavis[4325]: (04325-04) enqueue: not deleting: 2eb3480abe5095da69bbf4cf30c27a87, was refreshed since
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_tag_level) "matt@e-penguin.idv.tw" result=3
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_tag_level] => true, "matt@e-penguin.idv.tw" matches, result="3", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_tag2_level) "matt@e-penguin.idv.tw" result=6.9
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_tag2_level] => true, "matt@e-penguin.idv.tw" matches, result="6.9", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_tag3_level] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_kill_level) "matt@e-penguin.idv.tw" result=6.9
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_kill_level] => true, "matt@e-penguin.idv.tw" matches, result="6.9", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(message_size_limit) "matt@e-penguin.idv.tw" result=undef
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [message_size_limit] => undef, "matt@e-penguin.idv.tw" does not match
Nov 13 01:45:07 linux amavis[4325]: (04325-04) final_destiny (ccat=0) is PASS, recip matt@e-penguin.idv.tw
Nov 13 01:45:07 linux amavis[4325]: (04325-04) final_destiny PASS, recip matt@e-penguin.idv.tw
Nov 13 01:45:07 linux amavis[4325]: (04325-04) do_notify_and_quar: ccat=Clean (1,0) ("1":Clean, "0":CatchAll) ccat_block=(), qar_mth=
Nov 13 01:45:07 linux amavis[4325]: (04325-04) skip admin notification, no administrators
Nov 13 01:45:07 linux amavis[4325]: (04325-04) do_notify_and_quarantine - done
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_tag_level) "matt@e-penguin.idv.tw" result=3
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_tag_level] => true, "matt@e-penguin.idv.tw" matches, result="3", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_tag2_level) "matt@e-penguin.idv.tw" result=6.9
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_tag2_level] => true, "matt@e-penguin.idv.tw" matches, result="6.9", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup_sql_field(spam_modifies_subj) "matt@e-penguin.idv.tw" result=Y
Nov 13 01:45:07 linux amavis[4325]: (04325-04) lookup [spam_modifies_subj] => true, "matt@e-penguin.idv.tw" matches, result="Y", matching_key="/cached/"
Nov 13 01:45:07 linux amavis[4325]: (04325-04) headers CLUSTERING: NEW CLUSTER <matt@e-penguin.idv.tw>: score=0.799, tag=0, tag2=0, local=1, bl=, s=, mangle=
Nov 13 01:45:07 linux amavis[4325]: (04325-04) header: X-Virus-Scanned: amavisd-new at site\n
Nov 13 01:45:07 linux amavis[4325]: (04325-04) header: Received: from mail.e-penguin.idv.tw ([127.0.0.1])\n\tby localhost (linux-jfp8.site [127.0.0.1]) (amavisd-new, port 10024)\n\twith ESMTP id l-UTyiYeLiQn for <matt@e-penguin.idv.tw>;\n\tSat, 13 Nov 2010 01:45:06 +0800 (CST)\n
Nov 13 01:45:07 linux amavis[4325]: (04325-04) headers CLUSTERING: done all 1 recips in one go
Nov 13 01:45:07 linux amavis[4325]: (04325-04) (about to connect to [127.0.0.1]:10025) FWD via SMTP: <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>
Nov 13 01:45:07 linux amavis[4325]: (04325-04) smtp session: setting up a new session
Nov 13 01:45:07 linux amavis[4325]: (04325-04) establish_or_refresh, state: down
Nov 13 01:45:07 linux amavis[4325]: (04325-04) smtp creating socket by IO::Socket::INET to [127.0.0.1]:10025
Nov 13 01:45:07 linux amavis[4325]: (04325-04) rw_loop: needline=1, flush=0, wr=0, timeout=35
Nov 13 01:45:07 linux postfix/smtpd[16170]: connect from unknown[127.0.0.1]
Nov 13 01:45:07 linux postfix/smtpd[16170]: warning: SASL: Connect to private/auth failed: No such file or directory
Nov 13 01:45:07 linux postfix/smtpd[16170]: fatal: no SASL authentication mechanisms
Nov 13 01:45:08 linux postfix/master[16131]: warning: process /usr/lib/postfix/smtpd pid 16170 exit status 1
Nov 13 01:45:08 linux postfix/master[16131]: warning: /usr/lib/postfix/smtpd: bad command startup -- throttling
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop: receiving
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop read: got eof
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp resp to greeting:
Nov 13 01:45:08 linux amavis[4325]: (04325-04) mail_via_smtp: session failed: Negative greeting: at (eval 100) line 596.
Nov 13 01:45:08 linux amavis[4325]: (04325-04) prolong_timer fwd-end-chkpnt: timer set to 478 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) (!)FWD via SMTP: <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>, 451 4.5.0 From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04
Nov 13 01:45:08 linux amavis[4325]: (04325-04) prolong_timer forwarding: remaining time = 478 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) DSN: sender NOT credible, SA: 0.799, <wwwrun@linux.e-penguin.idv.tw>
Nov 13 01:45:08 linux amavis[4325]: (04325-04) lookup: (scalar) matches, result="10"
Nov 13 01:45:08 linux amavis[4325]: (04325-04) lookup [spam_dsn_cutoff_level_bysender] => true, "wwwrun@linux.e-penguin.idv.tw" matches, result="10", matching_key="(constant:10)"
Nov 13 01:45:08 linux amavis[4325]: (04325-04) dsn: . 451 MtaTempFailed <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>: on_succ=0, on_dly=1, on_fail=1, never=0, warn_sender=, DSN_passed_on=0, mta_resp: "451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04"
Nov 13 01:45:08 linux amavis[4325]: (04325-04) DSN: TMPFAIL . 451 MtaTempFailed, need not be reported: <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>
Nov 13 01:45:08 linux amavis[4325]: (04325-04) one_response_for_all <wwwrun@linux.e-penguin.idv.tw>: 4xx found, '451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04'
Nov 13 01:45:08 linux amavis[4325]: (04325-04) notif=N, suppressed=0, ndn_needed=, exit=75, 451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04
Nov 13 01:45:08 linux amavis[4325]: (04325-04) prolong_timer delivery-notification: remaining time = 478 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) parse_ip_address_from_received:
Nov 13 01:45:08 linux amavis[4325]: (04325-04) Blocked MTA-BLOCKED, <wwwrun@linux.e-penguin.idv.tw> -> <matt@e-penguin.idv.tw>, Message-ID: <20101108134812.F03C71280C9@linux.e-penguin.idv.tw>, mail_id: l-UTyiYeLiQn, Hits: 0.799, size: 616, 2585 ms
Nov 13 01:45:08 linux amavis[4325]: (04325-04) prolong_timer main_log_entry: remaining time = 478 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) TIMING-SA total 1423 ms - parse: 0.82 (0.1%), extract_message_metadata: 132 (9.3%), poll_dns_idle: 127 (8.9%), get_uri_detail_list: 0.18 (0.0%), tests_pri_-1000: 2 (0.2%), tests_pri_-950: 0.83 (0.1%), tests_pri_-900: 0.89 (0.1%), tests_pri_-400: 0.75 (0.1%), tests_pri_0: 1276 (89.7%), check_dkim_signature: 0.45 (0.0%), check_dkim_adsp: 215 (15.1%), check_spf: 0.30 (0.0%), check_razor2: 1035 (72.8%), check_pyzor: 0.22 (0.0%), tests_pri_500: 3 (0.2%), get_report: 0.77 (0.1%)
Nov 13 01:45:08 linux amavis[4325]: (04325-04) updating snmp variables
Nov 13 01:45:08 linux amavis[4325]: (04325-04) prolong_timer check done: remaining time = 478 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) sending SMTP response: "451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04"
Nov 13 01:45:08 linux amavis[4325]: (04325-04) ESMTP> 451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04
Nov 13 01:45:08 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:08 linux amavis[4325]: (04325-04) TempDir::strip: /var/spool/amavis/tmp/amavis-20101112T222625-04325
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rmdir_recursively: /var/spool/amavis/tmp/amavis-20101112T222625-04325/parts, excl=1
Nov 13 01:45:08 linux amavis[4325]: (04325-04) TIMING [total 2589 ms] - SMTP greeting: 1 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 1 (0%)0, lookup_sql: 3 (0%)0, SMTP pre-DATA-flush: 1 (0%)0, SMTP DATA: 35 (1%)2, check_init: 0 (0%)2, digest_hdr: 0 (0%)2, digest_body: 1 (0%)2, gen_mail_id: 2 (0%)2, mime_decode: 7 (0%)2, get-file-type1: 6 (0%)2, decompose_part: 1 (0%)2, parts_decode: 0 (0%)2, check_header: 1 (0%)2, AV-scan-1: 4 (0%)2, lookup_sql: 2 (0%)3, lookup_sql: 3 (0%)3, spam-wb-list: 2 (0%)3, SA parse: 2 (0%)3, SA check: 1420 (55%)58, update_cache: 4 (0%)58, decide_mail_destiny: 1 (0%)58, fwd-end-chkpnt: 1080 (42%)100, prepare-dsn: 2 (0%)100, main_log_entry: 6 (0%)100, update_snmp: 2 (0%)100, SMTP pre-response: 0 (0%)100, SMTP response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100
Nov 13 01:45:08 linux amavis[4325]: (04325-04) idle_proc, 6: was busy, 2581.5 ms, total idle 11873.414 s, busy 49.264 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) idle_proc, 5: was idle, 0.1 ms, total idle 11873.414 s, busy 49.264 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) ESMTP< QUIT\r\n
Nov 13 01:45:08 linux amavis[4325]: (04325-04) switch_to_my_time 480 s, SMTP QUIT received
Nov 13 01:45:08 linux amavis[4325]: (04325-04) ESMTP> 221 2.0.0 [127.0.0.1] amavisd-new closing transmission channel
Nov 13 01:45:08 linux amavis[4325]: (04325-04) switch_to_client_time 480 s, smtp response sent
Nov 13 01:45:08 linux amavis[4325]: (04325-04) SMTP session over, timer stopped
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp session rundown, cache off, idle 0.0 s, smtp:[127.0.0.1]:10025, state connected
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp session rundown, sending QUIT
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp cmd> QUIT
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop: needline=0, flush=1, wr=1, timeout=35
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop: receiving
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop read: got eof
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop: sending
Nov 13 01:45:08 linux amavis[4325]: (04325-04) rw_loop sent 6> QUIT\r\n
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp resp to QUIT:
Nov 13 01:45:08 linux amavis[4325]: (04325-04) Negative SMTP resp. to QUIT:
Nov 13 01:45:08 linux amavis[4325]: (04325-04) smtp session rundown, closing session smtp:[127.0.0.1]:10025
Nov 13 01:45:08 linux amavis[4325]: (04325-04) Amavis::Out::SMTP::Session close, already disconnected
Nov 13 01:45:08 linux amavis[4325]: (04325-04) exiting process_request
Nov 13 01:45:08 linux amavis[4325]: (04325-04) post_process_request_hook: timer was not running
Nov 13 01:45:08 linux amavis[4325]: (04325-04) idle_proc, bye: was busy, 2.2 ms, total idle 11873.414 s, busy 49.266 s
Nov 13 01:45:08 linux amavis[4325]: (04325-04) load: 0 %, total idle 11873.414 s, busy 49.266 s
Nov 13 01:45:08 linux postfix/smtp[16162]: F03C71280C9: to=<matt@e-penguin.idv.tw>, relay=127.0.0.1[127.0.0.1]:10024, delay=359816, delays=359813/0/0/2.6, dsn=4.5.0, status=deferred (host 127.0.0.1[127.0.0.1] said: 451 4.5.0 id=04325-04 - Temporary MTA failure on relaying, From MTA([127.0.0.1]:10025) during fwd-connect (Negative greeting: at (eval 100) line 596.): id=04325-04 (in reply to end of DATA command))
Nov 13 01:45:08 linux postfix/smtp[16162]: warning: connect to mysql server localhost: Can't connect to local MySQL server through socket '/var/run/mysql/mysql.sock' (2)
Nov 13 01:45:08 linux postfix/smtp[16162]: fatal: mysql:/etc/postfix/mysql_relay_domains_maps.cf(0,lock|fold_fix): table lookup problem
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const mail
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const all
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: name_mask: all
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand mail.$mydomain -> mail.e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const Postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${multi_instance_name:postfix}${multi_instance_name?$multi_instance_name} -> postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const maildrop
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $myhostname, localhost, localhost.$mydomain -> mail.e-penguin.idv.tw, localhost, localhost.e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $myhostname -> mail.e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /usr/lib/postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /var/lib/postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /usr/sbin
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /var/spool/postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const pid
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const all
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const double-bounce
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const nobody
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const hash:/etc/postfix/aliasas
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 20100608
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 2.7.1
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const hash
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const deferred, defer
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const mysql:/etc/postfix/mysql_relay_domains_maps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $relay_domains -> mysql:/etc/postfix/mysql_relay_domains_maps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const TZ MAIL_CONFIG LANG
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const MAIL_CONFIG MAIL_DEBUG MAIL_LOGTAG TZ XAUTHORITY DISPLAY LANG=C
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const subnet
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const +=
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const -=+
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const debug_peer_list,fast_flush_domains,mynetworks,permit_mx_backup_networks,qmqpd_authorized_clients,relay_domains,smtpd_access_maps
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const bounce
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const cleanup
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const defer
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const pickup
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const qmgr
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const rewrite
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const showq
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const error
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const flush
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const verify
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const trace
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const proxymap
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const proxywrite
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 0
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 2
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3600s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3600s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 5s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 5s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 10s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 10s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 500s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 500s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 18000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 18000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: inet_addr_local: configured 3 IPv4 addresses
Nov 13 01:45:08 linux postfix/smtpd[16175]: inet_addr_local: configured 2 IPv6 addresses
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 10
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${stress?1}${stress:20} -> 20
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${stress?1}${stress:100} -> 100
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${stress?1}${stress:3} -> 3
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 450
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $myhostname ESMTP $mail_name -> mail.e-penguin.idv.tw ESMTP Postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const resource, software
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const check_client_access mysql:/etc/postfix/mysql-virtual_client.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const check_sender_access mysql:/etc/postfix/mysql-virtual_sender.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const permit_mynetworks,permit_sasl_authenticated,reject_unauth_destination
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const postmaster
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const hash:/etc/postfix/canonical
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const mysql:/etc/postfix/mysql_virtual_alias_maps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const mysql:/etc/postfix/mysql_virtual_mailbox_maps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const hash:/etc/aliases
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand proxy:unix:passwd.byname $alias_maps -> proxy:unix:passwd.byname hash:/etc/aliases
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const noanonymous
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const private/auth
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const amavis:[127.0.0.1]:10024
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const CONNECT GET POST
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const <>
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const mysql:/etc/postfix/mysql-virtual_relayrecipientmaps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $double_bounce_sender -> double-bounce
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $authorized_verp_clients ->
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $myhostname -> mail.e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no_address_mappings
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${smtpd_client_connection_limit_exceptions:$mynetworks} ->
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const permit_inet_interfaces
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $smtpd_sasl_security_options -> noanonymous
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /etc/postfix/smtpd.cert
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const /etc/postfix/smtpd.key
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $smtpd_tls_dcert_file ->
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $smtpd_tls_eccert_file ->
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const export
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const medium
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const SSLv3, TLSv1
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const none
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const md5
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const may
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const dovecot
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const j {daemon_name} v
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const {tls_version} {cipher} {cipher_bits} {cert_subject} {cert_issuer}
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const i {auth_type} {auth_authen} {auth_author} {mail_addr} {mail_host} {mail_mailer}
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const i {rcpt_addr} {rcpt_host} {rcpt_mailer}
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const i
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const i
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const i
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 6
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const tempfail
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $myhostname -> mail.e-penguin.idv.tw
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $mail_name $mail_version -> Postfix 2.7.1
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const defer_if_permit
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $reject_tempfail_action -> defer_if_permit
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $reject_tempfail_action -> defer_if_permit
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $reject_tempfail_action -> defer_if_permit
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand $reject_tempfail_action -> defer_if_permit
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const yes
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const yes
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const yes
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const yes
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const no
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const yes
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${stress?10}${stress:300}s -> 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: expand ${stress?10}${stress:300}s -> 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 100s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 1000s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3600s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 3600s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 30s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 30s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 30s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 30s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_eval: const 300s
Nov 13 01:45:08 linux postfix/smtpd[16175]: process generation: 7 (7)
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: mynetworks ~? debug_peer_list
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: mynetworks ~? fast_flush_domains
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: mynetworks ~? mynetworks
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? debug_peer_list
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? fast_flush_domains
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? mynetworks
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? permit_mx_backup_networks
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? qmqpd_authorized_clients
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: relay_domains ~? relay_domains
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: user = postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: password = postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: dbname = postfix
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: result_format = %s
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_int: /etc/postfix/mysql_relay_domains_maps.cf: expansion_limit = 0
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: query = <NULL>
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: table = domain
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: select_field = domain
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: where_field = domain
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: additional_conditions = and backupmx = '1'
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: domain =
Nov 13 01:45:08 linux postfix/smtpd[16175]: cfg_get_str: /etc/postfix/mysql_relay_domains_maps.cf: hosts = localhost
Nov 13 01:45:08 linux postfix/smtpd[16175]: dict_open: mysql:/etc/postfix/mysql_relay_domains_maps.cf
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: permit_mx_backup_networks ~? debug_peer_list
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: permit_mx_backup_networks ~? fast_flush_domains
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: permit_mx_backup_networks ~? mynetworks
Nov 13 01:45:08 linux postfix/smtpd[16175]: match_string: permit_mx_backup_networks ~? permit_mx_backup_networks
Nov 13 01:45:08 linux postfix/smtpd[16175]: connect to subsystem private/proxymap
Nov 13 01:45:08 linux postfix/smtpd[16175]: send attr request = open
Nov 13 01:45:08 linux postfix/smtpd[16175]: send attr table = unix:passwd.byname
Nov 13 01:45:08 linux postfix/smtpd[16175]: send attr flags = 16448
Nov 13 01:45:08 linux postfix/smtpd[16175]: priva