Scalix Outbound SMTP failures

FrogSkin · Postby **FrogSkin** » Fri Apr 28, 2006 10:15 pm

Hi Guys,

I have been running Scalix 10 on Suse OSS 10 for a month or so no problems.

However this was on a VMWare server and things where humming along nicely to the point that we decided we would move the server to a physical server.

So I built the physical server and I setup Scalix on the new server. Then to move the VM Scalix server over I stopped the new Scalix install and then rsync'd the message store over to the new server.

I started the new server and whammo it all looked good. Well that was until I dug a little deeper to discover the following error when sending outbound emails:

---------------------------------Scalix SMTP Log---------------------------------------------------
dogfood:/var/opt/scalix/sys # cat /var/opt/scalix/tmp/smtpd.log
SMTP Relay 10.0.0.175 started (32332): Sat, 29 Apr 2006 12:00:51 +1000 (EST)
Accepted client 1 from (dogfood.speering.net)
Cli 32332/1 sent : 220 dogfood.speering.net ESMTP Scalix SMTP Relay 10.0.0.175; Sat, 29 Apr 2006 12:02:50 +1000 (EST)

Cli 32332/1 rcvd: 'EHLO dogfood.speering.net'
Cli 32332/1 sent : 250-dogfood.speering.net Hello dogfood.speering.net [10.10.10.8], pleased to meet you
250-AUTH CRAM-MD5 DIGEST-MD5 LOGIN PLAIN GSSAPI
250-AUTH=LOGIN
250-DSN
250 8BITMIME

Cli 32332/1 rcvd: 'MAIL FROM:<shane@speering.net>'
Cli 32332/1 sent : 250 shane@speering.net... Sender ok

Cli 32332/1 rcvd: 'RCPT TO:<shane@binaryvision.com.au> NOTIFY=FAILURE,DELAY'
... new process 32413
32332: Allocate new unix.in process 32413
Cli 32332/1 rcvd U: '220 Scalix ESMTP Ready.'
Cli 32332/1 rcvd U: '250 Ok'
Cli 32332/1 sent U: rcpt to: <shane@binaryvision.com.au> NOTIFY=FAILURE,DELAY

Cli 32332/1 rcvd U: '250 Ok'
Cli 32332/1 sent : 250 Ok

Cli 32332/1 rcvd: 'DATA'
Cli 32332/1 sent : 354 Enter mail, end with "." on a line by itself (relay)

Cli 32332/1 sent U: data

Cli 32332/1 rcvd U: '354 Enter mail, end with "." on a line by itself.'
Cli 32332/1 got .
Cli 32332/1 sent U: Received: from dogfood.speering.net (dogfood.speering.net 10.10.10.8)
by dogfood.speering.net (Scalix SMTP Relay 10.0.0.175)
via ESMTP; Sat, 29 Apr 2006 12:02:52 +1000 (EST)
Message-ID: <19561502.1146276170578.JavaMail.root@dogfood.speering.net>
Date: Sat, 29 Apr 2006 12:02:50 +1000 (EST)
From: Shane Speering <shane@speering.net>
To: Shane Speering <shane@binaryvision.com.au>
Subject: Mail Test
Mime-Version: 1.0
Content-Type: multipart/alternative;
boundary="----=_Part_6_15441752.1146276170574"
X-Mailer: Scalix 10.0.0.343
X-MSMail-Priority:

------=_Part_6_15441752.1146276170574
Content-Type: text/plain; charset=us-ascii
Content-Transfer-Encoding: 7bit

------=_Part_6_15441752.1146276170574
Content-Type: text/html; charset=us-ascii
Content-Transfer-Encoding: 7bit

<html><head><style type="text/css"></style></head><body><font face="times new roman, new york, times, serif" size=3></font></body></html>
------=_Part_6_15441752.1146276170574--

.

Cli 32332/1 rcvd U: '250 Ok'
Cli 32332/1: Submitted message ': <19561502.1146276170578.JavaMail.root@dogfood.speering.net>' to unix.in.
response: '250 Ok'
Cli 32332/1 Finished submitting msg : <19561502.1146276170578.JavaMail.root@dogfood.speering.net>
Cli 32332/1 sent : 250 Ok

Cli 32332/1 rcvd: 'QUIT'
Cli 32332/1 sent : 221 dogfood.speering.net closing connection
---------------------------------------------END OF LOG---------------------------------------------

The above message I highlighted the part that I think is the issue.

Here is the sendmail error message Im getting:

Apr 29 12:10:55 dogfood sendmail[32581]: k3S5o2pl029890: to=<shane@speering.net>, delay=20:20:53, xdelay=00:00:00, mailer=scalix, pri=4172466, relay=dogfood, dsn=4.0.0, stat=Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood': Fatal error encountered

Once again I have highlighted the part of the message that isnt making sense.

The configuration files I copied from the working server, however something obivously isnt right as some messages just dont seem to get through.

Any insight would be greatly appreciated.

Cheers
FrogSkin

FrogSkin · Postby **FrogSkin** » Mon May 01, 2006 5:55 am

Has anyone got any ideas where I may look to solve the above issue.

Cheers
FrogSkin

mephisto · Postby **mephisto** » Mon May 01, 2006 7:07 am

It seems to me your host's fqdn has not the right reverse lookup configured. The reverse lookup of your mailserver's name, i.e. the thing I get if I enter
dig -x 59.167.208.213
is not dogfood.speering.ne.
You need to talk to your provider (Internode) to set the according entry in their DNS.

FrogSkin · Postby **FrogSkin** » Mon May 01, 2006 9:17 am

Thanks for the reply.. I understand what you are saying, however the VMServer running on the same network doesnt have this issue when sending mail.

The mail thats failing to send is local to the host and is Internet bound, its getting a Unix Queuing denied error before it even gets out?

I agree, I still need to get Internode to fix the reverse DNS for my IP though.

Cheers
FrogSkin

Postby **ScalixSupport** » Tue May 02, 2006 7:53 am

Hi,

your problem is the unix gateway refusing the message. Can you paste an omstat -s and omstat -a here?

Thanks,

Sascha.

FrogSkin · Postby **FrogSkin** » Tue May 02, 2006 8:13 am

Hi,

omstat -s output:

dogfood:/Downloads/scalix-core-intel-suse-10.0.0 # omstat -s
Service Router Started 04.29.06 0
Local Delivery Started 04.29.06 0
Internet Mail Gateway Started 04.29.06 0
Local Client Interface Enabled 04.29.06 0
Remote Client Interface Enabled 04.29.06 0
Test Server Started 04.29.06 0
Request Server Started 04.29.06 0
Print Server Started 04.29.06 0
Bulletin Board Server Started 04.29.06 0
Background Search Service Started 04.29.06 0
CDA Server Started 04.29.06 0
POP3 interface Started 04.29.06 0
Omscan Server Started 04.29.06 0
Archiver Started 04.29.06 0
dogfood:/Downloads/scalix-core-intel-suse-10.0.0 #

omstat -a output:

dogfood:/Downloads/scalix-core-intel-suse-10.0.0 # omstat -a
PC Monitor Started NON-STOP 0
Directory Relay Server Started 04.29.06
Notification Server Started 04.29.06 0
Shared memory daemon Started NON-STOP
Notification Monitor Started NON-STOP
Session Monitor Started NON-STOP
Container Access Monitor Started NON-STOP
Item Structure Server Stopped
Database Monitor Started 04.29.06
Licence Monitor Daemon Started NON-STOP
LDAP Daemon Started 04.29.06
Queue Manager Started NON-STOP
Item Delete Daemon Started NON-STOP
IMAP Server Daemon Started 04.29.06
SMTP Relay Started 04.29.06
Mime Browser Controller Started 04.29.06
dogfood:/Downloads/scalix-core-intel-suse-10.0.0 #

Cheers
FrogSkin

Postby **ScalixSupport** » Tue May 02, 2006 8:25 am

I am tempted to think this is a file rights issue. Please try this:

Shut down Scalix
run omcheck -s -s

Start Scalix again.

Cheers,

Sascha.

FrogSkin · Postby **FrogSkin** » Tue May 02, 2006 9:31 am

Hi,

Well a file permission problem would be feasible considering I moved the message store from one server to another.

The output seems to be supporting your training of thought, here are the result of the omcheck -s -s

===================OUTPUT START==================================
# ---------------------------------------------------------
#
#Now checking component OM-ADM
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-AMECAT
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-AMEPAW
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-AMEPDA
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-AMERW
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-AMEWAP
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-APPL
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-BB
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-CHSCAT
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-CHSPAW
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-CHSPDA
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-CHSRW
#
#
#Component checks complete.

# ---------------------------------------------------------
#
#Now checking component OM-CORE
#
# Filename: /var/opt/scalix/msgpool/poolctrl ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/msgpool/poolctrl
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/msgpool/poolctrl
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/shutfile
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/shutfile
# Filename: /var/opt/scalix/sys/pcshfile ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/pcshfile
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/pcshfile
# Filename: /var/opt/scalix/sys/general.cfg ( OpenMail OM-CORE )
# Mode is 664 (-rw-rw-r--) should be 444 (-r--r--r--)
chmod 444 /var/opt/scalix/sys/general.cfg
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/general.cfg
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/general.cfg
# Filename: /var/opt/scalix/logs/daemon.stderr ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/logs/daemon.stderr
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/logs/daemon.stderr
# Filename: /var/opt/scalix/admin/stop.delay ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/admin/stop.delay
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/admin/stop.delay
# Filename: /var/opt/scalix/sys/router ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/router
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/router
# Filename: /var/opt/scalix/sys/ornia ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/ornia
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/ornia
# Filename: /var/opt/scalix/sys/sysdata ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/sysdata
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/sysdata
# Filename: /var/opt/scalix/sys/config ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/config
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/config
# Filename: /var/opt/scalix/sys/omlocks.000 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.000
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.000
# Filename: /var/opt/scalix/sys/omlocks.001 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.001
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.001
# Filename: /var/opt/scalix/sys/omlocks.002 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.002
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.002
# Filename: /var/opt/scalix/sys/omlocks.003 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.003
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.003
# Filename: /var/opt/scalix/sys/omlocks.004 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.004
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.004
# Filename: /var/opt/scalix/sys/omlocks.005 ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/omlocks.005
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/omlocks.005
# Filename: /var/opt/scalix/sys/CSTables.ld ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/CSTables.ld
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/CSTables.ld
# Filename: /var/opt/scalix/sys/CSTables.lk ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/CSTables.lk
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/CSTables.lk
# Filename: /var/opt/scalix/sys/LCMap.bin ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)
chown scalix /var/opt/scalix/sys/LCMap.bin
# Gid is 0 (root) should be 105 (scalix)
chgrp scalix /var/opt/scalix/sys/LCMap.bin
# Filename: /var/opt/scalix/sys/LCMap.lk ( OpenMail OM-CORE )
# Uid is 0 (root) should be 103 (scalix)

===================This goes on for pages..============================

I stopped pasting the output as there are several areas that the permissions are screwed?

How can I fix this?

Cheers
FrogSkin

Postby **ScalixSupport** » Tue May 02, 2006 9:40 am

Hi,

I actually meant to type omcheck -i -s, but fat-fingered. When you run this, it will fix it automagically.

Cheers,

Sascha.

FrogSkin · Postby **FrogSkin** » Tue May 02, 2006 4:24 pm

Morning :),

I ran the command and it didnt appear to do anything different than from using -s -s

I restarted the server and restarted sendmail and it immediately reported the same message in the sendmail log as before, here a copy of that message:

May 3 06:24:08 dogfood sendmail[3643]: k3S5o2pl029890: smtpquit: mailer scalix exited with exit value 1
May 3 06:24:08 dogfood sendmail[3643]: k3S5o2pl029890: to=<shane@speering.net>, delay=4+14:34:06, xdelay=00:00:00, mailer=scalix, pri=20552466, relay=dogfood, dsn=4.0.0, stat=Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood': Fatal error encountered

Cheers
Shane

FrogSkin · Postby **FrogSkin** » Thu May 04, 2006 10:40 pm

Hi,

Im still having the above issue.

Any other ideas on how to resolve this?

Cheers
FrogSkin

Postby **ScalixSupport** » Fri May 05, 2006 5:10 am

OK, some more ideas:

When you copied the Scalix server, what parameters did you use in rsync? Did you use --numeric-ids? What was the exact command?

What else is different between the two machines? Has the domain name or hostname changed?

To exclude the possibility of a bad message, let's delete the messages on the queues. Run

omqdump with the password A15E when prompted.

Then "l" list the queues, if there are any messages listed, delete them.

Once those are cleaned out, restart the server.

Please come back if there are any more issues.

Cheers,

Sascha.

FrogSkin · Postby **FrogSkin** » Fri May 05, 2006 6:37 am

Hi,

The rsynch command I used was:

rsync -vtrp /var/opt/scalix 10.10.10.8:/var/opt/scalix

The host where built with exactly the same using the same host name and configuration.

Ill clean out the queues and see how that goes.

Cheers
FrogSkin

FrogSkin · Postby **FrogSkin** » Sat May 06, 2006 1:19 am

Hi,

I have looked at the queues in the Scalix Server and there arent any messages in the queues.

All the messages are in the Sendmail queues. Heres a snippet of when I run sendmail -bp

------------------------Sendmail Output--------------------------------------------

/var/spool/mqueue (20 requests)
-----Q-ID----- --Size-- -----Q-Time----- ------------Sender/Recipient-----------
k45Mngn3008328 8303 Sat May 6 08:49 MAILER-DAEMON
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
frogskin
k45IXen2002796 1694 Sat May 6 04:33 <root@dogfood.speering.net>
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
frogskin
k44NJg6v009416 3765 Fri May 5 09:39 MAILER-DAEMON
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
frogskin
k44NJg6u009416 3843 Fri May 5 09:39 MAILER-DAEMON
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
frogskin
k44Mng6u008782 154678 Fri May 5 08:54 MAILER-DAEMON
(timeout writing message to dogfood.speering.net: Resource te)
frogskin
k44M9D6u007911 2408 Fri May 5 08:09 MAILER-DAEMON
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
frogskin
k44M9D6t007911 5959 Fri May 5 08:09 MAILER-DAEMON
(Deferred: 451 Message rejected by OM.UX Gateway on 'dogfood')
<margie@speering.net>
k44IZMnG003366* 152729 Fri May 5 04:35 <root@dogfood.speering.net>
(timeout writing message to dogfood.speering.net: Resource te)
frogskin
k443Jfec016617 11905 Thu May 4 13:29 MAILER-DAEMON

=====================End Sendmail Output==================================

So whats happening, does the client send the outbound message to Sendmail and then sendmail tries to send it to Scalix for Internet delivery?

Its the passing from Sendmail to Scalix thats dieing. It seems that Sendmail does not have permission to pass some mesages to Scalix as I have sent some messages that do get out, however the majority dont.

Does this help, why would Scalix reject sendmail messages?

UPDATE: Here is a copy of the sendmail message header.

-------Message Header--------------
MDeferred: 451 Message rejected by OM.UX Gateway on 'dogfood': Fatal error encountered
Fs
--------------------------------------

When sendmail goes to pass the message to Scalix the Scalix service is having a fatal error for some reason, now Im not sure why, but that appears to be the problem.

Any ideas how to fix this ?

Cheers
Shane

Postby **ScalixSupport** » Sat May 06, 2006 11:33 am

Throughout this thread, there has been details that a fatal error was encountered but you haven't looked at the Scalix server logs.

Please take some time to look at the sticky at the top of this section as this details what troubleshooting information is available to you.

Cheers

Dave

Scalix Forums

Scalix Outbound SMTP failures

Scalix Outbound SMTP failures

Bump

Who is online