Postfix issues

Discussion in 'Installation/Configuration' started by NewMee, Apr 14, 2009.

  1. NewMee

    NewMee New Member

    Hello all,

    I have some issues with postfix.
    Afster installing ISPConfig3, i've created a Client, an E-mail domain and an E-mail user. (mail_domain and mail_user are available in the MySQL tables)
    The mail-user is active.

    Somehow, Postfix does not accept messages to the mail_user in the mail_domain.

    I'm not new to Unix/Linux, but untill today I was a Sendmail user, and I'm not used to finding issues in Postfix yet.
    Can anyone give a hint where to look for?

    Thanks in advance!

    Marco
     
  2. till

    till Super Moderator Staff Member ISPConfig Developer

    Please post the exact error messages from the mail log file.
     
  3. NewMee

    NewMee New Member

    Sorry for the delay. Been out for work a few days.
    OK, here it is.
    This is the log-output of 1 sent e-mail.
    The sender and receiver are both 'known' to the machine. The message was sent through Squirrelmail on the particular machine, so local delivery is obvious.

    For known reasons, the involved domainnames have been replaced in this view. Hostnames involved are legal and registered. Bending port 25 to another local host will result in an accepted e-mail (on sendmail...)

    Marco



    Apr 17 17:16:19 nolimits sendmail[25972]: n3HFGJto025972: Authentication-Warning: nolimits.justadomainname.nl: apache set sender to [email protected] using -f
    Apr 17 17:16:19 nolimits sendmail[25972]: n3HFGJto025972: [email protected], size=601, class=0, nrcpts=1, msgid=<6b9a78fbd5d9f267c0d20689856d3b12.squirrel@nolimits.justadomainname.nl>, relay=apache@localhost
    Apr 17 17:16:19 nolimits postfix/smtpd[25706]: connect from localhost.localdomain[127.0.0.1]
    Apr 17 17:16:19 nolimits sendmail[25972]: STARTTLS=client, relay=[127.0.0.1], version=TLSv1/SSLv3, verify=FAIL, cipher=DHE-RSA-AES256-SHA, bits=256/256
    Apr 17 17:16:19 nolimits postfix/smtpd[25706]: 7953943AAE8: client=localhost.localdomain[127.0.0.1]
    Apr 17 17:16:19 nolimits postfix/cleanup[25717]: 7953943AAE8: message-id=<6b9a78fbd5d9f267c0d20689856d3b12.squirrel@nolimits.justadomainname.nl>
    Apr 17 17:16:19 nolimits postfix/qmgr[2246]: 7953943AAE8: from=<[email protected]>, size=1057, nrcpt=1 (queue active)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) Net::Server: 2009/04/17-17:16:19 CONNECT TCP Peer: "127.0.0.1:40859" Local: "127.0.0.1:10024"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) idle_proc, hi : was idle, 42559.2 ms, total idle 4523.254 s, busy 5.694 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) loaded base policy bank
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) lookup_ip_acl (inet_acl): key="127.0.0.1" matches "127.0.0.1", result=1
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) process_request: fileno sock=10, STDIN=0, STDOUT=1
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) switch_to_my_time 480 s, new request
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-05) process_request: suggested_protocol="" on TCP
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) SMTP> 220 [127.0.0.1] ESMTP amavisd-new service ready
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 4: was busy, 2.4 ms, total idle 4523.254 s, busy 5.696 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.2 ms, total idle 4523.254 s, busy 5.696 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) SMTP< EHLO nolimits.justadomainname.nl\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP EHLO received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-[127.0.0.1]
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-VRFY
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-PIPELINING
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-SIZE
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-ENHANCEDSTATUSCODES
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-8BITMIME
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250-DSN
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250 XFORWARD NAME ADDR PROTO HELO
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 1.6 ms, total idle 4523.254 s, busy 5.698 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.1 ms, total idle 4523.254 s, busy 5.698 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< XFORWARD NAME=localhost.localdomain ADDR=127.0.0.1\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP XFORWARD received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250 2.5.0 Ok XFORWARD
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 0.8 ms, total idle 4523.254 s, busy 5.699 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.1 ms, total idle 4523.254 s, busy 5.699 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< XFORWARD PROTO=ESMTP HELO=nolimits.justadomainname.nl\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP XFORWARD received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250 2.5.0 Ok XFORWARD
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 0.7 ms, total idle 4523.254 s, busy 5.699 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.1 ms, total idle 4523.255 s, busy 5.699 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< MAIL FROM:<[email protected]> SIZE=1057 BODY=8BITMIME\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP MAIL received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) check_mail_begin_task: task_count=6
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_ip_acl (mynetworks): key="127.0.0.1" matches "127.0.0.0/8", result=1
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) loaded policy bank "MYNETS"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (debug_sender) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250 2.1.0 Sender <[email protected]> OK
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 2.0 ms, total idle 4523.255 s, busy 5.701 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.1 ms, total idle 4523.255 s, busy 5.701 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< RCPT TO:<[email protected]> ORCPT=rfc822;[email protected]\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP RCPT received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_acl([email protected]), no match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (local_domains) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], @justadomainname.nl, @.justadomainname.nl, @.nl, @.
    Apr 17 17:16:19 nolimits sendmail[25972]: n3HFGJto025972: [email protected], delay=00:00:00, xdelay=00:00:00, mailer=relay, pri=30601, relay=[127.0.0.1] [127.0.0.1], dsn=2.0.0, stat=Sent (Ok: queued as 7953943AAE8)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql "[email protected]", query args: "[email protected]", "@justadomainname.nl", "@.justadomainname.nl", "@.nl", "@."
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) 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
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) sql begin, nontransaction
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) 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
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql, "[email protected]" no match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(message_size_limit), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (message_size_limit) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 250 2.1.5 Recipient <[email protected]> OK
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 3.4 ms, total idle 4523.255 s, busy 5.705 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.1 ms, total idle 4523.255 s, busy 5.705 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< DATA\r\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP DATA received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP::10024 /var/spool/amavisd/tmp/amavis-20090417T160050-02366: <[email protected]> -> <[email protected]> SIZE=1057 BODY=8BITMIME Received: from nolimits.justadomainname.nl ([127.0.0.1]) by localhost (nolimits.justadomainname.nl [127.0.0.1]) (amavisd-new, port 10024) with ESMTP for <[email protected]>; Fri, 17 Apr 2009 17:16:19 +0200 (CEST)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP> 354 End data with <CR><LF>.<CR><LF>
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:19 nolimits postfix/smtpd[25706]: disconnect from localhost.localdomain[127.0.0.1]
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, receiving data
    Apr 17 17:16:19 nolimits imapd: Connection, ip=[::ffff:127.0.0.1]
    Apr 17 17:16:19 nolimits imapd: LOGIN, [email protected], ip=[::ffff:127.0.0.1], port=[58835], protocol=IMAP
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, data-end received
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ESMTP< .<CR><LF>
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(local), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_acl([email protected]), no match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (local_domains) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) body type: labeled 8BITMIME unnecessarily (h=0, b=0)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) body hash: baf4c18adcbdb5257bc1e439cc477ea0
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Original mail size: 1057; quota set to: 528500 bytes
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Checking: r7W8saJD2s03 MYNETS [127.0.0.1] <[email protected]> -> <[email protected]>
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) 2822.From: <[email protected]>
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_virus_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_virus_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Extracting mime components
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Issued a new file name: p001
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Charging 41 bytes to remaining quota 528500 (out of 528500, (0%)) - by mime_decode
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) p001 1 Content-Type: text/plain, size: 41 B, name:
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer mime_decode: remaining time = 480 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer mime_decode-1: remaining time = 480 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) decode_parts: level=1, #parts=1 : p001
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) run_command: [25974] /usr/bin/file p001 </dev/null 2>&1
    Apr 17 17:16:19 nolimits amavis[25974]: (02366-06) open_on_specific_fd: target fd0 closing, to become < /dev/null
    Apr 17 17:16:19 nolimits imapd: LOGOUT, [email protected], ip=[::ffff:127.0.0.1], headers=0, body=0, rcvd=701, sent=203, time=0
    Apr 17 17:16:19 nolimits amavis[25974]: (02366-06) open_on_specific_fd: target fd2 closing, to become > &1
    Apr 17 17:16:19 nolimits amavis[25974]: (02366-06) open_on_specific_fd: target fd2 dup2 from fd1 > &1
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) result line from file(1): p001: ASCII text\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_re("ASCII text") matches key "(?i-xsm:^(ASCII|text)\b)", result="asc"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (map_full_type_to_short_type) => true, "ASCII text" matches, result="asc", matching_key="(?i-xsm:^(ASCII|text)\\b)"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) File-type of p001: ASCII text; (asc)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) do_ascii: Decoding part p001
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) do_ascii: Setting sigaction handler, was 0
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) timer set to 320 s (was 480 s)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) do_ascii: Decoding part p001 (0 items), uulib V0.5pl20
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer do_ascii: timer set to 480 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) decompose_part: p001 - atomic
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer parts_decode: remaining time = 480 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_header_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_header_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) check_header: 0, OK
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_header_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_header_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Checking for banned types and filenames
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_banned_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits imapd: Connection, ip=[::ffff:127.0.0.1]
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_banned_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(banned_rulenames), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="DEFAULT"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (banned_filename), 1 matches for "[email protected]", results: "(constant:DEFAULT)"=>"DEFAULT"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) collect banned table[0]: [email protected], tables: DEFAULT=>Amavis::Lookup::RE=ARRAY(0x9730794)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) starting banned checks - traversing message structure tree
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) check_for_banned (p001) text/plain,.asc
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) doing banned check for [email protected] on text/plain,.asc
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_re(["text/plain",".asc"]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (check_bann:[email protected]) => undef, ["text/plain",".asc"] does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) p.path [email protected]: "P=p001,L=1,M=text/plain,T=asc"
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) banned check: any=0, all=N (1)
    Apr 17 17:16:19 nolimits imapd: LOGIN, [email protected], ip=[::ffff:127.0.0.1], port=[58836], protocol=IMAP
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_re("MAIL"), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (keep_decoded_original) => undef, "MAIL" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Using ClamAV-clamd: (built-in interface)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) timer set to 320 s (was 480 s)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ask_av (ClamAV-clamd): query template1: CONTSCAN {}\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) Using (ClamAV-clamd) on dir: CONTSCAN /var/spool/amavisd/tmp/amavis-20090417T160050-02366/parts\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) timer set to 10 s (was 320 s)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ClamAV-clamd: Connecting to socket /var/spool/amavisd/clamd.sock
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ClamAV-clamd: Sending CONTSCAN /var/spool/amavisd/tmp/amavis-20090417T160050-02366/parts\n to UNIX socket /var/spool/amavisd/clamd.sock
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer ask_daemon_internal: timer set to 256 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ask_av (ClamAV-clamd) result: /var/spool/amavisd/tmp/amavis-20090417T160050-02366/parts: OK\n
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ask_av (ClamAV-clamd): /var/spool/amavisd/tmp/amavis-20090417T160050-02366/parts CLEAN
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) ClamAV-clamd result: clean
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) prolong_timer run_av: timer set to 480 s
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_virus_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_virus_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_spam_checks), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits imapd: LOGOUT, [email protected], ip=[::ffff:127.0.0.1], headers=0, body=0, rcvd=119, sent=900, time=0
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (bypass_spam_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) wbl: checking sender <[email protected]>
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_sql_field(id), "[email protected]" no matching records
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) wbl: (SQL) recip <[email protected]>, 0 matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (blacklist_recip<[email protected]>) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], tryout@, nolimits.justadomainname.nl, .nolimits.justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (blacklist_sender) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (whitelist_recip<[email protected]>) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], tryout@, nolimits.justadomainname.nl, .nolimits.justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (whitelist_sender) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]) matches keys: "."=>ARRAY(0x9730d64)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (score_sender), 1 matches for "[email protected]", results: "."=>[Amavis::Lookup::RE=ARRAY(0x9730aa4),HASH(0x9730b34)]
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_re("[email protected]"), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) query_keys: [email protected], tryout@, nolimits.justadomainname.nl, .nolimits.justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) lookup (score_sender<[email protected]>) => undef, "[email protected]" does not match
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) SpamControl: calling spam scanner
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) spam_scan: DSPAM not available, skipping it
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) timer set to 320 s for SA (was 480 s)
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) calling SA parse, SA version 3.2.5, 3.002005, data as GLOB
    Apr 17 17:16:19 nolimits amavis[2366]: (02366-06) CALLING SA check
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer spam_scan_sa_finish: timer set to 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) spam_scan: score=1.459 autolearn=no tests=[ALL_TRUSTED=-1.44,TVD_SPACE_RATIO=2.899]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer spam_scan: remaining time = 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) enqueue: stat is not numeric: ""
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(spam_tag_level), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="2"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_tag_level) => true, "[email protected]" matches, result="2", matching_key="(constant:2)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(spam_tag2_level), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="6.2"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_tag2_level) => true, "[email protected]" matches, result="6.2", matching_key="(constant:6.2)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_tag3_level) => undef, "[email protected]" does not match
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(spam_kill_level), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="6.9"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_kill_level) => true, "[email protected]" matches, result="6.9", matching_key="(constant:6.9)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(bypass_spam_checks), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) query_keys: [email protected], marco@, justadomainname.nl, .justadomainname.nl, .nl, .
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_hash([email protected]), no matches
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (bypass_spam_checks) => undef, "[email protected]" does not match
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(message_size_limit), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (message_size_limit) => undef, "[email protected]" does not match
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) final_destiny (ccat=0) is PASS, recip [email protected]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) final_destiny PASS, recip [email protected]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) do_notify_and_quar: ccat=Clean (1,0) ("1":Clean, "0":CatchAll) ccat_block=(), q_mth=, qar_mth=
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) skip admin notification, no administrators
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) do_notify_and_quarantine - done
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(spam_tag_level), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="2"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_tag_level) => true, "[email protected]" matches, result="2", matching_key="(constant:2)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_sql_field(spam_tag2_level), "[email protected]" no matching records
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="6.2"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_tag2_level) => true, "[email protected]" matches, result="6.2", matching_key="(constant:6.2)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) headers CLUSTERING: NEW CLUSTER <[email protected]>: score=1.459, tag=0, tag2=0, local=0, bl=, s=, mangle=
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) header: X-Virus-Scanned: amavisd-new at nolimits.justadomainname.nl\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) header: Received: from nolimits.justadomainname.nl ([127.0.0.1])\n\tby localhost (nolimits.justadomainname.nl [127.0.0.1]) (amavisd-new, port 10024)\n\twith ESMTP id r7W8saJD2s03 for <[email protected]>;\n\tFri, 17 Apr 2009 17:16:19 +0200 (CEST)\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) headers CLUSTERING: done all 1 recips in one go
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) (about to connect to [127.0.0.1]:10025) FWD via SMTP: <[email protected]> -> <[email protected]>
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp creating socket by IO::Socket::INET: 127.0.0.1
    Apr 17 17:16:20 nolimits postfix/smtpd[25738]: connect from unknown[127.0.0.1]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=1, flush=0, wr=0, timeout=30
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: receiving
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop read 38 chars< 220 nolimits.justadomainname.nl ESMTP Postfix\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to greeting: 220 nolimits.justadomainname.nl ESMTP Postfix
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp cmd> EHLO localhost
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=0, flush=1, wr=1, timeout=300
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: sending
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop send 16> EHLO localhost\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=1, flush=0, wr=0, timeout=300
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: receiving
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop read 176 chars< 250-nolimits.justadomainname.nl\r\n250-PIPELINING\r\n250-SIZE\r\n250-VRFY\r\n250-ETRN\r\n250-STARTTLS\r\n250-AUTH PLAIN LOGIN\r\n250-AUTH=PLAIN LOGIN\r\n250-ENHANCEDSTATUSCODES\r\n250-8BITMIME\r\n250 DSN\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to EHLO: 250 nolimits.justadomainname.nl\nPIPELINING\nSIZE\nVRFY\nETRN\nSTARTTLS\nAUTH PLAIN LOGIN\nAUTH=PLAIN LOGIN\nENHANCEDSTATUSCODES\n8BITMIME\nDSN
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) Remote host presents itself as: nolimits.justadomainname.nl, handles DSN, handles PIPELINING
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) AUTH not needed, user='', MTA offers 'PLAIN LOGIN'
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp cmd> MAIL FROM:<[email protected]> BODY=8BITMIME
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp cmd> RCPT TO:<[email protected]> ORCPT=rfc822;[email protected]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp cmd> DATA
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=0, flush=1, wr=1, timeout=120
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: sending
    Apr 17 17:16:20 nolimits postfix/smtpd[25738]: 2163843AAE6: client=unknown[127.0.0.1]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop send 123> MAIL FROM:<[email protected]> BODY=8BITMIME\r\nRCPT TO:<[email protected]> ORCPT=rfc822;[email protected]\r\nDATA\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=1, flush=0, wr=0, timeout=300
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: receiving
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop read 65 chars< 250 2.1.0 Ok\r\n250 2.1.5 Ok\r\n354 End data with <CR><LF>.<CR><LF>\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to MAIL (pip): 250 2.1.0 Ok
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to RCPT (pip) (<[email protected]>): 250 2.1.5 Ok, id=02366-06, from MTA([127.0.0.1]:10025): 250 2.1.5 Ok
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to DATA: 354 End data with <CR><LF>.<CR><LF>
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) write_header: 0, Amavis::Out::SMTP::protocol=HASH(0xb709954)
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp cmd> QUIT
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=0, flush=1, wr=1, timeout=479
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: sending
    Apr 17 17:16:20 nolimits postfix/cleanup[25713]: 2163843AAE6: message-id=<6b9a78fbd5d9f267c0d20689856d3b12.squirrel@nolimits.justadomainname.nl>
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop send 1338> X-Virus-Scanned: amavisd-new at nolimits.justadomainname.nl\r\nReceived: from nolimits.justadomainname.nl ([127.0.0.1])\r\n\tby localhost (nolimits.justadomainname.nl [127.0.0.1]) (amavisd-new, port 10024)\r\n\twith ESMTP id r7W8saJD2s [...]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: needline=1, flush=0, wr=0, timeout=479
    Apr 17 17:16:20 nolimits postfix/qmgr[2246]: 2163843AAE6: from=<[email protected]>, size=1504, nrcpt=1 (queue active)
    Apr 17 17:16:20 nolimits postfix/smtpd[25738]: disconnect from unknown[127.0.0.1]
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop: receiving
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rw_loop read 52 chars< 250 2.0.0 Ok: queued as 2163843AAE6\r\n221 2.0.0 Bye\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to data-dot (<[email protected]>): 250 2.0.0 Ok: queued as 2163843AAE6
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) smtp resp to QUIT: 221 2.0.0 Bye
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer fwd-end-chkpnt: timer set to 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) FWD via SMTP: <[email protected]> -> <[email protected]>,BODY=8BITMIME 250 2.6.0 Ok, id=02366-06, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 2163843AAE6
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer forwarding: remaining time = 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup: (scalar) matches, result="10"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup (spam_dsn_cutoff_level_bysender) => true, "[email protected]" matches, result="10", matching_key="(constant:10)"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) dsn: from MTA 250 NonBlocking:Clean <[email protected]> -> <[email protected]>: on_succ=0, on_dly=1, on_fail=1, never=0, warn_sender=, DSN_passed_on=1, mta_resp: "250 2.0.0 Ok: queued as 2163843AAE6"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) DSN: SUCC from MTA 250 NonBlocking:Clean, no DSN requested: <[email protected]> -> <[email protected]>
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) one_response_for_all <[email protected]>: success, r=0,b=0,d=0, ndn_needed=0, '250 2.0.0 Ok: queued as 2163843AAE6'
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) notif=N, suppressed=0, ndn_needed=0, exit=0, 250 2.0.0 Ok: queued as 2163843AAE6
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer delivery-notification: remaining time = 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) parse_received: from = 82.95.194.101 /82.95.194.101//
    Apr 17 17:16:20 nolimits postfix/pipe[25929]: 2163843AAE6: to=<[email protected]>, relay=maildrop, delay=0.02, delays=0.01/0/0/0.01, dsn=5.1.1, status=bounced (user unknown. Command output: Invalid user specified. )
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) parse_received: by = nolimits.justadomainname.nl /nolimits.justadomainname.nl//
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) parse_received: with = HTTP/HTTP//
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) parse_received: ; = Fri, 17 Apr 2009 17:16:19 +0200 (CEST)/Fri, 17 Apr 2009 17:16:19 +0200 (CEST)//
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) fish_out_ip_from_received: 82.95.194.101, 82.95.194.101
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) lookup_ip_acl (publicnetworks): key="82.95.194.101" matches "::FFFF:0:0/96", result=1
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) best_try_originator_ip: 82.95.194.101
    Apr 17 17:16:20 nolimits postfix/cleanup[25717]: 25F9643AAE9: message-id=<[email protected]>
    Apr 17 17:16:20 nolimits postfix/qmgr[2246]: 25F9643AAE9: from=<>, size=3378, nrcpt=1 (queue active)
    Apr 17 17:16:20 nolimits postfix/bounce[25933]: 2163843AAE6: sender non-delivery notification: 25F9643AAE9
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) Passed CLEAN, MYNETS LOCAL [127.0.0.1] [82.95.194.101] <[email protected]> -> <[email protected]>, Message-ID: <6b9a78fbd5d9f267c0d20689856d3b12.squirrel@nolimits.justadomainname.nl>, mail_id: r7W8saJD2s03, Hits: 1.459, size: 1057, queued_as: 2163843AAE6, 618 ms
    Apr 17 17:16:20 nolimits postfix/qmgr[2246]: 2163843AAE6: removed
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer main_log_entry: remaining time = 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) updating snmp variables
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) prolong_timer check done: remaining time = 479 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) sending SMTP response: "250 2.0.0 Ok: queued as 2163843AAE6"
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) ESMTP> 250 2.0.0 Ok: queued as 2163843AAE6
    Apr 17 17:16:20 nolimits postfix/smtp[25718]: 7953943AAE8: to=<[email protected]>, relay=127.0.0.1[127.0.0.1]:10024, delay=0.67, delays=0.05/0/0.01/0.62, dsn=2.0.0, status=sent (250 2.0.0 Ok: queued as 2163843AAE6)
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:20 nolimits postfix/qmgr[2246]: 7953943AAE8: removed
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) TempDir::strip: /var/spool/amavisd/tmp/amavis-20090417T160050-02366
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) rmdir_recursively: /var/spool/amavisd/tmp/amavis-20090417T160050-02366/parts, excl=1
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) TIMING [total 624 ms] - SMTP greeting: 2 (0%)0, SMTP EHLO: 2 (0%)1, SMTP pre-MAIL: 2 (0%)1, lookup_sql: 4 (1%)2, SMTP pre-DATA-flush: 2 (0%)2, SMTP DATA: 32 (5%)7, check_init: 1 (0%)7, digest_hdr: 1 (0%)7, digest_body: 0 (0%)7, gen_mail_id: 1 (0%)8, mime_decode: 9 (1%)9, get-file-type1: 14 (2%)11, decompose_part: 2 (0%)12, parts_decode: 0 (0%)12, check_header: 4 (1%)12, AV-scan-1: 12 (2%)14, spam-wb-list: 5 (1%)15, SA parse: 3 (0%)15, SA check: 486 (78%)93, update_cache: 4 (1%)94, decide_mail_destiny: 3 (0%)94, fwd-connect: 7 (1%)95, fwd-mail-pip: 2 (0%)96, fwd-rcpt-pip: 0 (0%)96, fwd-data-chkpnt: 0 (0%)96, write-header: 1 (0%)96, fwd-data-contents: 0 (0%)96, fwd-end-chkpnt: 11 (2%)98, prepare-dsn: 1 (0%)98, main_log_entry: 9 (1%)99, update_snmp: 2 (0%)100, SMTP pre-response: 0 (0%)100, SMTP response: 1 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) idle_proc, 6: was busy, 612.4 ms, total idle 4523.255 s, busy 6.317 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) idle_proc, 5: was idle, 0.2 ms, total idle 4523.255 s, busy 6.317 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) ESMTP< QUIT\r\n
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) switch_to_my_time 480 s, SMTP QUIT received
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) ESMTP> 221 2.0.0 [127.0.0.1] amavisd-new closing transmission channel
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) switch_to_client_time 480 s, smtp response sent
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) SMTP session over, timer stopped
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) exiting process_request
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) post_process_request_hook: timer was not running
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) idle_proc, bye: was busy, 2.0 ms, total idle 4523.255 s, busy 6.319 s
    Apr 17 17:16:20 nolimits amavis[2366]: (02366-06) load: 0 %, total idle 4523.255 s, busy 6.319 s
    Apr 17 17:16:20 nolimits postfix/local[25742]: 25F9643AAE9: to=<[email protected]>, relay=local, delay=0.01, delays=0/0/0/0.01, dsn=5.1.1, status=bounced (unknown user: "tryout")
    Apr 17 17:16:20 nolimits postfix/qmgr[2246]: 25F9643AAE9: removed
     
  4. till

    till Super Moderator Staff Member ISPConfig Developer

    Which installation guide did you use to configure yor server for ispconfig 3?
     
  5. NewMee

    NewMee New Member

    The one at Howtoforge :)
    http://www.howtoforge.com/perfect-server-fedora-10-ispconfig-3

    [edit]
    I have re-installed everything this evening (well, it's evening here...)
    It appears the problems rise after a system update, initiated by fc10.
    After this update, alle mail is rejected?

    MyDNS also gets updated, it needs to be reconfigured by hand.

    [edit 2]
    Re-installed the lot again.
    If the update for Postfix (2.2.5.6-1) is done after the ISPC3 installation, Postfix settings are wrong.
    Do not install ISPConfig 3 untill all updates/fixes are installed!

    Marco
     
    Last edited: Apr 18, 2009
  6. falko

    falko Super Moderator ISPConfig Developer

    Ok, it seems as if the Postfix update also overwrites /etc/postfix/main.cf and /etc/postfix/master.cf. I think the updater should at least ask what you want to do in such a case (like Debian/Ubuntu do).
     
  7. NewMee

    NewMee New Member

    Indeed, it would have saved me (and others) quite some time.
    Thanks for the effort Falko!

    Marco
     
  8. till

    till Super Moderator Staff Member ISPConfig Developer

    Fedora and centos are known for this behaviour as their rpm installer destroy existing system configurations by resetting them to defualts instead of keeping the configuration that is used on the system. In such a case you can use the ispconfig updater to reconfigure your system or you use a linux distribution like debian or ubuntu which does not destroy configurations on system upgrades.
     

Share This Page