Loading ...
Sorry, an error occurred while loading the content.

Re: queue file write error for my milter

Expand Messages
  • Wietse Venema
    ... You need to find out why your cleanup server dies. Wietse
    Message 1 of 5 , Mar 4, 2008
    • 0 Attachment
      Mani Jassar:
      > Mar 1 18:16:30 mjassar-cent postfix/cleanup[23840]: warning: cannot receive milters via service cleanup socket socket
      > Mar 1 18:16:31 mjassar-cent postfix/master[23824]: warning: process /usr/libexec/postfix/cleanup pid 23840 killed by signal 11

      You need to find out why your cleanup server dies.

      Wietse
    • Mani Jassar
      The cleanup server runs fine until the data command. After that the cleanup server dies. I don t think my issue has to do with the cleanup server. Here is
      Message 2 of 5 , Mar 5, 2008
      • 0 Attachment
        The cleanup server runs fine until the data command. After that the cleanup server dies. I don't think my issue has to do with the cleanup server. Here is the complete log, somebody please help.

        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: connection established
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: master_notify: status 0
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: name_mask: resource
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: name_mask: software
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: connect from mjassar-cent.abaca.com[127.0.0.1]
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_list_match: mjassar-cent.abaca.com: no match
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_list_match: 127.0.0.1: no match
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_list_match: mjassar-cent.abaca.com: no match
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_list_match: 127.0.0.1: no match
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_hostname: mjassar-cent.abaca.com ~? 127.0.0.0/8
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: match_hostaddr: 127.0.0.1 ~? 127.0.0.0/8
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: report connect to all milters
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "j"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "mjassar-cent.abaca.com"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{daemon_name}"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "mjassar-cent.abaca.com"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "v"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "Postfix 2.4.6"
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: non-protocol events for protocol version 2: SMFIP_NOUNKNOWN SMFIP_NODATA 0xfffffc00
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: transport=inet endpoint=localhost:8000
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: trying... [127.0.0.1]
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: vstream_tweak_tcp: TCP_MAXSEG 16384
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: my_version=0x2
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: my_actions=0x3f SMFIF_ADDHDRS SMFIF_CHGBODY SMFIF_ADDRCPT SMFIF_DELRCPT SMFIF_CHGHDRS SMFIF_QUARANTINE
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: my_events=0x7f SMFIP_NOCONNECT SMFIP_NOHELO SMFIP_NOMAIL SMFIP_NORCPT SMFIP_NOBODY SMFIP_NOHDRS SMFIP_NOEOH
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: milter inet:localhost:8000 version 2
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: events SMFIP_NOHELO SMFIP_NOBODY
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_connect: requests SMFIF_ADDHDRS SMFIF_ADDRCPT
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: milter8_conn_event: milter inet:localhost:8000: connect mjassar-cent.abaca.com/127.0.0.1
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: event: SMFIC_CONNECT; macros: j=mjassar-cent.abaca.com {daemon_name}=mjassar-cent.abaca.com v=Postfix 2.4.6
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: reply: SMFIR_CONTINUE data 0 bytes
        Mar 1 18:16:22 mjassar-cent postfix/smtpd[23832]: > mjassar-cent.abaca.com[127.0.0.1]: 220 mjassar-cent.abaca.com ESMTP Postfix
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: < mjassar-cent.abaca.com[127.0.0.1]: mail from:test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: extract_addr: input: test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: smtpd_check_addr: addr=test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: ctable_locate: leave existing entry key test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: extract_addr: in: test@..., result: test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: report sender to all milters
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "i"
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{auth_type}"
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{auth_authen}"
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{auth_author}"
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{mail_addr}"
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "test@..."
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: milter8_mail_event: milter inet:localhost:8000: mail test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: event: SMFIC_MAIL; macros: {mail_addr}=test@...
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: reply: SMFIR_CONTINUE data 0 bytes
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: fsspace: .: block size 4096, blocks free 3640445
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: smtpd_check_queue: blocks 4096 avail 3640445 min_free 0 msg_size_limit 10240000
        Mar 1 18:16:26 mjassar-cent postfix/smtpd[23832]: > mjassar-cent.abaca.com[127.0.0.1]: 250 2.1.0 Ok
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: < mjassar-cent.abaca.com[127.0.0.1]: rcpt to:test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: extract_addr: input: test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: smtpd_check_addr: addr=test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: ctable_locate: leave existing entry key test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: extract_addr: in: test@..., result: test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: >>> START Recipient address RESTRICTIONS <<<
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: generic_checks: name=permit_mynetworks
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: permit_mynetworks: mjassar-cent.abaca.com 127.0.0.1
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_hostname: mjassar-cent.abaca.com ~? 127.0.0.0/8
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_hostaddr: 127.0.0.1 ~? 127.0.0.0/8
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: generic_checks: name=permit_mynetworks status=1
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: >>> CHECKING RECIPIENT MAPS <<<
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: ctable_locate: leave existing entry key test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: recipient_canonical_maps: test@...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? mjassar-cent.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_list_match: domain.com: no match
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: recipient_canonical_maps: @...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: mail_addr_find: test@... -> (not found)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: canonical_maps: test@...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? mjassar-cent.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_list_match: domain.com: no match
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: canonical_maps: @...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: mail_addr_find: test@... -> (not found)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: virtual_alias_maps: test@...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? mjassar-cent.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost.abaca.com
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_string: domain.com ~? localhost
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: match_list_match: domain.com: no match
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: maps_find: virtual_alias_maps: @...: not found
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: mail_addr_find: test@... -> (not found)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: report recipient to all milters
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "i"
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "{rcpt_addr}"
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "test@..."
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter8_rcpt_event: milter inet:localhost:8000: rcpt test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: event: SMFIC_RCPT; macros: {rcpt_addr}=test@...
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: reply: SMFIR_CONTINUE data 0 bytes
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: smtpd_check_rewrite: trying: permit_inet_interfaces
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: permit_inet_interfaces: mjassar-cent.abaca.com 127.0.0.1
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: before input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping enable_milters
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: after input_transp_cleanup: cleanup flags = enable_header_body_filter enable_automatic_bcc enable_address_mapping enable_milters
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: connect to subsystem public/cleanup
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: queue_id
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: queue_id
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute value: 13FF2418FBE
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: (list terminator)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: (end)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr flags = 114
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr conn_macros = j {daemon_name} v
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr helo_macros = {tls_version} {cipher} {cipher_bits} {cert_subject} {cert_issuer}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr mail_macros = i {auth_type} {auth_authen} {auth_author} {mail_addr}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr rcpt_macros = i {rcpt_addr}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr data_macros = i
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr eod_macros = i
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr unk_macros =
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: status
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: status
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute value: 0
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: (list terminator)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: (end)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: 13FF2418FBE: client=mjassar-cent.abaca.com[127.0.0.1]
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: > mjassar-cent.abaca.com[127.0.0.1]: 250 2.1.5 Ok
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: < mjassar-cent.abaca.com[127.0.0.1]: data
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: report data to all milters
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: "i"
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter_macro_lookup: result "13FF2418FBE"
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter8_data_event: milter inet:localhost:8000: data command
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: skipping non-protocol event SMFIC_DATA for milter inet:localhost:8000
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr conn_macros = j {daemon_name} v
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr helo_macros = {tls_version} {cipher} {cipher_bits} {cert_subject} {cert_issuer}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr mail_macros = i {auth_type} {auth_authen} {auth_author} {mail_addr}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr rcpt_macros = i {rcpt_addr}
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr data_macros = i
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr eod_macros = i
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr unk_macros =
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: milter8_send: milter inet:localhost:8000
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_name = inet:localhost:8000
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_version = 2
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_actions = 5
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_events = 18
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_non_events = 4294967040
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_state = 4
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_conn_timeout = 30
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_cmd_timeout = 30
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_msg_timeout = 300
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: send attr milter_action = tempfail
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: dummy
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: dummy
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute value: (end)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: public/cleanup socket: wanted attribute: (list terminator)
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: input attribute name: (end)
        Mar 1 18:16:30 mjassar-cent postfix/cleanup[23840]: warning: cannot receive milters via service cleanup socket socket
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: warning: cannot send milters to service public/cleanup socket
        Mar 1 18:16:30 mjassar-cent postfix/smtpd[23832]: > mjassar-cent.abaca.com[127.0.0.1]: 354 End data with <CR><LF>.<CR><LF>
        Mar 1 18:16:31 mjassar-cent postfix/master[23824]: warning: process /usr/libexec/postfix/cleanup pid 23840 killed by signal 11
        Mar 1 18:16:32 mjassar-cent postfix/smtpd[23832]: > mjassar-cent.abaca.com[127.0.0.1]: 451 4.3.0 Error: queue file write error
        Mar 1 18:16:32 mjassar-cent postfix/smtpd[23832]: abort all milters
        Mar 1 18:16:32 mjassar-cent postfix/smtpd[23832]: milter8_abort: abort milter inet:localhost:8000

        -----Original Message-----
        From: Wietse Venema [mailto:wietse@...]
        Sent: Tuesday, March 04, 2008 1:56 AM
        To: Mani Jassar
        Cc: postfix-users@...
        Subject: Re: queue file write error for my milter

        Mani Jassar:
        > Mar 1 18:16:30 mjassar-cent postfix/cleanup[23840]: warning: cannot receive milters via service cleanup socket socket
        > Mar 1 18:16:31 mjassar-cent postfix/master[23824]: warning: process /usr/libexec/postfix/cleanup pid 23840 killed by signal 11

        You need to find out why your cleanup server dies.

        Wietse
      • Wietse Venema
        ... You are mistaken. ... No-one can help as long as you persist in your mistake. Wietse
        Message 3 of 5 , Mar 6, 2008
        • 0 Attachment
          Mani Jassar:
          > The cleanup server runs fine until the data command. After that
          > the cleanup server dies. I don't think my issue has to do with
          > the cleanup server.

          You are mistaken.

          > Here is the complete log, somebody please
          > help.

          No-one can help as long as you persist in your mistake.

          Wietse
        Your message has been successfully submitted and would be delivered to recipients shortly.