You're right, there's one master postfix process locking it even though "postfix status" reported postfix is down. Killed it & now postifx could start & I'm beginning to get bounced mails notifications (shown below ***)
chroot is disabled & I've whitelisted the sending domains Ran tcpdump nohup in background to check for SMTP connections but there's none other than one test outgoing email which probably failed as well. Does my firewall need to permit SMTP outgoing or just incoming is sufficient? 250-PIPELINING 250-SIZE 10240000 250-VRFY 250-ETRN 250-ENHANCEDSTATUSCODES 250-8BITMIME MAIL FROM:<prvs=02230e707=recipient...@mds.com.sg> SIZE=1383 ************************************************************ Delivery has failed to these recipients or groups: r...@myportaltech.com A problem occurred during the delivery of this message to this e-mail address. Try sending this message again. If the problem continues, please contact your helpdesk. The following organization rejected your message: [202.6.163.31]. Diagnostic information for administrators: Generating server: gate2.mds.com.sg r...@myportaltech.com [202.6.163.31] #<[202.6.163.31] #5.0.0 smtp; 5.1.0 - Unknown address error 554-'5.7.1 <r...@myportaltech.com>: Relay access denied' (delivery attempts: 0)> #SMTP# Original message headers: X-IronPort-Anti-Spam-Filtered: true X-IronPort-Anti-Spam-Result: AhEBAMtCXE3AqINE/2dsb2JhbACXTI88vSyFXgSPXw Received: from unknown (HELO sght02.mds.corp.int-ads) ([192.168.131.68]) by gate2.mds.com.sg with ESMTP/TLS/AES128-SHA; 17 Feb 2011 15:44:26 +0800 Received: from SGMBX02.mds.corp.int-ads ([fe80::11cd:49e0:af0f:1ba]) by sght02.mds.corp.int-ads ([::1]) with mapi id 14.01.0270.001; Thu, 17 Feb 2011 15:44:26 +0800 From: "G PO mds" <sender...@mds.com.sg> To: "recipient...@myportaltech.com" <recipient...@myportaltech.com> CC: "r...@myportaltech.com" <r...@myportaltech.com> Subject: RE: testg tcpdump 1 Thread-Topic: testg tcpdump 1 Thread-Index: AQHLznZ/QZa8lLNf9kWxtxpo3qMWag== Date: Thu, 17 Feb 2011 07:44:25 +0000 Message-ID: <b4d798bd8ba6a140b26ef75c1012558d114...@sgmbx02.mds.corp.int-ads > References: <b4d798bd8ba6a140b26ef75c1012558d0f1...@sgmbx03.mds.corp.int-ads > Accept-Language: en-US Content-Language: en-US ***************************** latest maillog ********************************* Feb 17 14:12:41 hostname postfix/smtpd[30975]: > gate2.mds.com.sg[203.126.130.164]: 554 5.7.1 <sende...@myportaltech.com>: Relay access denied Feb 17 14:12:41 hostname postfix/smtpd[30975]: watchdog_pat: 0x80baf68 Feb 17 14:12:41 hostname postfix/smtpd[30975]: < gate2.mds.com.sg[203.126.130.164]: RCPT TO:<r...@myportaltech.com> Feb 17 14:12:41 hostname postfix/smtpd[30975]: extract_addr: input: < r...@myportaltech.com> Feb 17 14:12:41 hostname postfix/smtpd[30975]: smtpd_check_addr: addr= r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr request = rewrite Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr rule = local Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr address = r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: 0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: address Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: address Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: (list terminator) Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: (end) Feb 17 14:12:41 hostname postfix/smtpd[30975]: rewrite_clnt: local: r...@myportaltech.com -> r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr request = resolve Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr sender = Feb 17 14:12:41 hostname postfix/smtpd[30975]: send attr address = r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: 0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: transport Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: transport Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: smtp Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: nexthop Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: nexthop Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: recipient Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: recipient Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: flags Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute value: 4096 Feb 17 14:12:41 hostname postfix/smtpd[30975]: private/rewrite socket: wanted attribute: (list terminator) Feb 17 14:12:41 hostname postfix/smtpd[30975]: input attribute name: (end) Feb 17 14:12:41 hostname postfix/smtpd[30975]: resolve_clnt: `' -> ` r...@myportaltech.com' -> transp=`smtp' host=`por talcity-tech.com' rcpt=`r...@myportaltech.com' flags= class=default Feb 17 14:12:41 hostname postfix/smtpd[30975]: ctable_locate: install entry key r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: extract_addr: in: < r...@myportaltech.com>, result: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: >>> START Recipient address RESTRICTIONS <<< Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_invalid_hostname Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_invalid_hostname Feb 17 14:12:41 hostname postfix/smtpd[30975]: reject_invalid_hostname: gate2.mds.com.sg Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_invalid_hostname status=0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_unauth_pipelining Feb 17 14:12:41 hostname postfix/smtpd[30975]: reject_unauth_pipelining: RCPT Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_unauth_pipelining status=0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=permit_mynetworks Feb 17 14:12:41 hostname postfix/smtpd[30975]: permit_mynetworks: gate2.mds.com.sg 203.126.130.164 Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_hostname: gate2.mds.com.sg ~? 172.18.20.0/24 Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_hostaddr: 203.126.130.164 ~? 172.18.20.0/24 Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_hostname: gate2.mds.com.sg ~? 127.0.0.0/8 Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_hostaddr: 203.126.130.164 ~? 127.0.0.0/8 Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_list_match: gate2.mds.com.sg: no match Feb 17 14:12:41 hostname postfix/smtpd[30975]: match_list_match: 203.126.130.164: no match Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=permit_mynetworks status=0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=permit_sasl_authenticated Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=permit_sasl_authenticated Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=permit_sasl_authenticated status=0 Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_unauth_destination Feb 17 14:12:41 hostname postfix/smtpd[30975]: reject_unauth_destination: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: permit_auth_destination: r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: ctable_locate: leave existing entry key r...@myportaltech.com Feb 17 14:12:41 hostname postfix/smtpd[30975]: NOQUEUE: reject: RCPT from gate2.mds.com.sg[203.126.130.164]: 554 5.7.1 < r...@myportaltech.com>: Relay access denied; from=<prvs=02230e707= sende...@mds.com.sg> to=<r...@myportaltech.com> pr oto=ESMTP helo=<gate2.mds.com.sg> Feb 17 14:12:41 hostname postfix/smtpd[30975]: generic_checks: name=reject_unauth_destination status=2 Feb 17 14:12:41 hostname postfix/smtpd[30975]: > gate2.mds.com.sg[203.126.130.164]: 554 5.7.1 <r...@myportaltech.com> : Relay access denied Feb 17 14:12:41 hostname postfix/smtpd[30975]: watchdog_pat: 0x80baf68 Feb 17 14:12:42 hostname postfix/smtpd[30975]: < gate2.mds.com.sg[203.126.130.164]: RSET Feb 17 14:12:42 hostname postfix/smtpd[30975]: > gate2.mds.com.sg[203.126.130.164]: 250 2.0.0 Ok Feb 17 14:12:42 hostname postfix/smtpd[30975]: watchdog_pat: 0x80baf68 Feb 17 14:12:47 hostname postfix/smtpd[30975]: < gate2.mds.com.sg[203.126.130.164]: QUIT Feb 17 14:12:47 hostname postfix/smtpd[30975]: > gate2.mds.com.sg[203.126.130.164]: 221 2.0.0 Bye Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_hostname: gate2.mds.com.sg ~? 172.18.20.0/24 Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_hostaddr: 203.126.130.164 ~? 172.18.20.0/24 Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_hostname: gate2.mds.com.sg ~? 127.0.0.0/8 Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_hostaddr: 203.126.130.164 ~? 127.0.0.0/8 Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_list_match: gate2.mds.com.sg: no match Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_list_match: 203.126.130.164: no match Feb 17 14:12:47 hostname postfix/smtpd[30975]: send attr request = disconnect Feb 17 14:12:47 hostname postfix/smtpd[30975]: send attr ident = smtp:203.126.130.164 Feb 17 14:12:47 hostname postfix/smtpd[30975]: private/anvil: wanted attribute: status Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute name: status Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute value: 0 Feb 17 14:12:47 hostname postfix/smtpd[30975]: private/anvil: wanted attribute: (list terminator) Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute name: (end) Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_hostaddr: 203.126.130.164 ~? 127.0.0.0/8 Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_list_match: gate2.mds.com.sg: no match Feb 17 14:12:47 hostname postfix/smtpd[30975]: match_list_match: 203.126.130.164: no match Feb 17 14:12:47 hostname postfix/smtpd[30975]: send attr request = disconnect Feb 17 14:12:47 hostname postfix/smtpd[30975]: send attr ident = smtp:203.126.130.164 Feb 17 14:12:47 hostname postfix/smtpd[30975]: private/anvil: wanted attribute: status Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute name: status Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute value: 0 Feb 17 14:12:47 hostname postfix/smtpd[30975]: private/anvil: wanted attribute: (list terminator) Feb 17 14:12:47 hostname postfix/smtpd[30975]: input attribute name: (end) Feb 17 14:12:47 hostname postfix/smtpd[30975]: disconnect from gate2.mds.com.sg[203.126.130.164] Feb 17 14:16:07 hostname postfix/anvil[30977]: statistics: max connection rate 1/60s for (smtp:203.126.130.164) at Feb 1 7 14:12:41 Feb 17 14:16:07 hostname postfix/anvil[30977]: statistics: max connection count 1 for (smtp:203.126.130.164) at Feb 17 1 4:12:41 Feb 17 14:16:07 hostname postfix/anvil[30977]: statistics: max cache size 1 at Feb 17 14:12:41 On Thu, Feb 17, 2011 at 3:02 PM, Daniel Bromberg <dan...@basezen.com> wrote: > On 2/16/2011 10:21 PM, sunhux G wrote: > >> >> Sorry for the lack of info in earlier post. >> >> Think the main issue is I can't even start up postfix : >> >> # postfix set-permissions >> [root@etc]# postfix start >> postfix/postfix-script: starting the Postfix mail system >> [root@ etc]# postfix reload >> postfix/postfix-script: fatal: the Postfix mail system is not running >> >> I googed for "master.lock unable exclusive lock" but it's mostly on >> MacOS & editing php.ini doesn't help: >> >> Relevant error from /var/log/maillog >> Feb 17 11:15:20 hostname postfix/postfix-script[29383]: starting the >> Postfix mail system >> Feb 17 11:15:20 hostname postfix/master[29384]: fatal: open lock file >> /var/lib/postfix/master.lock: unable to set exclusive lock: Resource >> temporarily unavailable >> [SNIP] >> > This would indicate some process, perhaps an earlier attempt at running > postfix, already has the lock. > What is the output of fuser as below? Follows is a literal interaction from > my installation > > # ls -l /var/lib/postfix/master.lock > -rw------- 1 postfix postfix 17 Feb 7 11:08 /var/lib/postfix/master.lock > # fuser /var/lib/postfix/master.lock > /var/lib/postfix/master.lock: 15590 > # ps auwwx | grep 15590 > root 15590 0.0 0.0 6624 1868 ? Ss Feb07 0:33 > /usr/libexec/postfix/master > > > -Daniel > >
