Service Router SERIOUS ERROR

[rudi]

Hi,

I have this message in the fatal log file:

SERIOUS ERROR Service Router(Incoming Trans) 11.04.05 13:23:45
[OM 1001] Transaction File record size is out of bounds
Pid of logging process: 11148

Do you know what this mean?

Thanks for help!!!

[ScalixSupport]

Hi,

Go to /var/opt/scalix/xport.hold and see if there are any files in this directory. Restart Scalix and see if the error is cleared up. If it is (or even if it isn't), put these files back in xport.hold and run:

xport.in -H

This will resubmit the messages.

This error can happen after restarting Scalix.This directory is a holding area for incoming and outgoing messages and items can (sometimes) get stuck if Scalix is restrated unexpectedly (server crash, power failure...).

Regards,

Matthew
Support

[rudi]

Hi,

I went to /var/opt/scalix/xport.hold and there are many files like 15265.1 and so on. I have run xport.in -H an after that I have restarted the scalix system and after that the error is listed again in the fatal log (about 100 times):

SERIOUS ERROR Service Router(Service Router) 11.02.05 17:17:42
[OM 5183] A Mapper error has been detected.
Pid of logging process: 5394
Current errno value: 4

Can I delete this files in /var/opt/scalix/xport.hold?

Thanks!!

[ScalixSupport]

Do not delete the files in this directory.

Do you have ClamAV installed? If so, in var/opt/scalix/sys, edit the omvscan.cfg file so that debug logging in increased to "3". The output will go to /var/opt/scalix/tmp/clamav.log.

When you get a chance, post the output and I'll take a look...

Regards,

Matthew
Support

[rudi]

Hi,

Yes, I have installed ClamAV on the Scalix System and set the LogLevel to 3. But in /var/opt/scalix/tmp/ there is no clamav.log file. The output in the /var/opt/scalix/logs/omvscan.log is this:

2005-11-17 07:53:33:PID=30342:############## /var/opt/scalix/tmp/omvscan_cfg.30342
2005-11-17 07:53:33:PID=30342:OMAV_LOGFILE=/var/opt/scalix/logs/omvscan.log
2005-11-17 07:53:33:PID=30342:OMAV_LOGLEVEL=3
2005-11-17 07:53:33:PID=30342:CLAMAV_ENGINE=/usr/local/bin/clamdscan
2005-11-17 07:53:33:PID=30342:CLAMAV_SCAN_OPTIONS='--stdout'
2005-11-17 07:53:33:PID=30342:CLAMAV_CLEAN_OPTIONS='--stdout'
2005-11-17 07:53:33:PID=30342:CLAMAV_LOGPGX=/var/opt/scalix/tmp/clamav.log
2005-11-17 07:53:33:PID=30342:CLAMAV_USE_LOCKING=no
2005-11-17 07:53:33:PID=30342:CLAMAV_LOCK_FILE=clamav.lock
2005-11-17 07:53:33:PID=30342:############## /var/opt/scalix/tmp/omvscan_cfg.30342
2005-11-17 07:53:33:PID=30342:[Reply]:220 Virus Scanning Client Ready
2005-11-17 07:53:33:PID=30342:[Command Received]:HELO From Scalix Service Router, Version 1.0
2005-11-17 07:53:33:PID=30342:[Reply]:250 Ok
2005-11-17 07:53:33:PID=30342:[Command Received]:HELO From Scalix Service Router, Version 1.0
2005-11-17 07:53:33:PID=30342:[Reply]:250 Ok
2005-11-17 07:59:39:PID=30342:[Command Received]:SCAN:/var/opt/scalix/data/0000053/0009vrj
2005-11-17 07:59:39:PID=30342:/usr/local/bin/clamdscan --stdout /var/opt/scalix/data/0000053/0009vrj > /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:exit_code 0
2005-11-17 07:59:39:PID=30342:############## start /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:/var/opt/scalix/data/0000053/0009vrj: OK
2005-11-17 07:59:39:PID=30342:
2005-11-17 07:59:39:PID=30342:----------- SCAN SUMMARY -----------
2005-11-17 07:59:39:PID=30342:Infected files: 0
2005-11-17 07:59:39:PID=30342:Time: 0.000 sec (0 m 0 s)
2005-11-17 07:59:39:PID=30342:############## end /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:[Reply]:271 No viruses found
2005-11-17 07:59:39:PID=30342:[Command Received]:SCAN:/var/opt/scalix/data/0000053/0009vrg
2005-11-17 07:59:39:PID=30342:/usr/local/bin/clamdscan --stdout /var/opt/scalix/data/0000053/0009vrg > /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:exit_code 0
2005-11-17 07:59:39:PID=30342:############## start /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:/var/opt/scalix/data/0000053/0009vrg: OK
2005-11-17 07:59:39:PID=30342:
2005-11-17 07:59:39:PID=30342:----------- SCAN SUMMARY -----------
2005-11-17 07:59:39:PID=30342:Infected files: 0
2005-11-17 07:59:39:PID=30342:Time: 0.000 sec (0 m 0 s)
2005-11-17 07:59:39:PID=30342:############## end /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 07:59:39:PID=30342:[Reply]:271 No viruses found
2005-11-17 08:00:41:PID=30342:[Command Received]:SCAN:/var/opt/scalix/data/000004s/0009vrn
2005-11-17 08:00:41:PID=30342:/usr/local/bin/clamdscan --stdout /var/opt/scalix/data/000004s/0009vrn > /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:exit_code 0
2005-11-17 08:00:41:PID=30342:############## start /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:/var/opt/scalix/data/000004s/0009vrn: OK
2005-11-17 08:00:41:PID=30342:
2005-11-17 08:00:41:PID=30342:----------- SCAN SUMMARY -----------
2005-11-17 08:00:41:PID=30342:Infected files: 0
2005-11-17 08:00:41:PID=30342:Time: 0.000 sec (0 m 0 s)
2005-11-17 08:00:41:PID=30342:############## end /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:[Reply]:271 No viruses found
2005-11-17 08:00:41:PID=30342:[Command Received]:SCAN:/var/opt/scalix/data/0000053/0009vrk
2005-11-17 08:00:41:PID=30342:/usr/local/bin/clamdscan --stdout /var/opt/scalix/data/0000053/0009vrk > /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:exit_code 0
2005-11-17 08:00:41:PID=30342:############## start /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:/var/opt/scalix/data/0000053/0009vrk: OK
2005-11-17 08:00:41:PID=30342:
2005-11-17 08:00:41:PID=30342:----------- SCAN SUMMARY -----------
2005-11-17 08:00:41:PID=30342:Infected files: 0
2005-11-17 08:00:41:PID=30342:Time: 0.000 sec (0 m 0 s)
2005-11-17 08:00:41:PID=30342:############## end /var/opt/scalix/tmp/clamav.log.30342
2005-11-17 08:00:41:PID=30342:[Reply]:271 No viruses found

Can you use this output?

Thanks for help!!!

[ScalixSupport]

Sorry... you're right. That's the one I meant.

Anyway, it looks good to me. I was thinking that that was causing the mapper errors.

BTW, is this error still occuring?

Matthew
Support

[rudi]

Yes, the error happen, after I restart the scalix system. The files in the /var/opt/scalix/xport.hold directory are older than 2 weeks. I think this error was occur, when I set the dirsync. But he dirsync between the two scalix systems runs now without problems.
The files in /var/opt/scalix/xport.hold contains messages of "unknown mailer error 1" and this messages should be send to a receipient that doesn't exists. So the messages cannot be sent.

Hope this helps!

[ScalixSupport]

Do you have BB sync setup? I assuming that you might, since you are doing dir syncs...

If this is so, then the error messages you are getting (Transaction File record size is out of bounds ) are caused by a Scalix Server bug - the way that the BB server and xport.in function together.

Try restarting the Service Router, then enter

Code: Select all

xport.in -H

Let me know if this clears it up. If not, I'll have to consult with Eng and see how we can get these messages submitted.

Matthew
Support

[rudi]

Hi,

I have restartet the service router, and do xport.in -H, but the error comes again. Yes and I have configured BB sync too. The command xport.in -H runs about 4 minutes.

Thanks for help!!

[rudi]

Hi,

I have started in a cron job the Scalix Weekly Maintenance Report and in the output there come following:

Orphans found ....
Orphan name Orphan type
~/data/0000001/0000u15 Transaction file.
~/data/0000001/0003bge Container.
~/data/0000001/0003v60 Transaction file.
~/data/0000001/0009611 Transaction file.
~/data/0000001/0009jqa Transaction file.
~/data/0000001/0009lb4 Transaction file.
~/data/0000001/0009mru Transaction file.
~/data/0000001/000c00n Transaction file.

Have this to do with the serious error in the fatal log?

Thanks!!

[ScalixSupport]

Hi,

No, I don't think so as the "Transaction File..." error is a bug that should be fixed in the next release of Scalix.

To clean up the orphans, enter:

omscan -a -f

However, you won't see a new report until next time omscan runs.

Can you post the contents of one of the messages in the /var/opt/scalix/xport.hold directory. Restarting the SR really should have cleared this out... ?


Matthew
Support

[rudi]

Hi,

Here is the content of one file in /var/opt/scalix/xport.hold directory:

Received: from server1.domain.com (server1.domain.com 192.168.202.5)
by server2.domain.com (Scalix SMTP Relay 9.4.0.9)
via ESMTP; Mon, 07 Nov 2005 17:53:14 +0100 (CET)
Received: from localhost (localhost)
by server1.domain.com (8.12.10/8.12.10/SuSE Linux 0.7) id jA3CEg2Y003370;
Thu, 3 Nov 2005 13:14:42 +0100
Date: Thu, 3 Nov 2005 13:14:42 +0100
From: Mail Delivery Subsystem <MAILER-DAEMON@server1.domain.com>
Message-Id: <200511031214.jA3CEg2Y003370@server1.domain.com>
To: <scalix@server2.domain.com>
MIME-Version: 1.0
Content-Type: multipart/report; report-type=delivery-status;
boundary="jA3CEg2Y003370.1131020082/server1.domain.com"
Subject: Returned mail: see transcript for details
Auto-Submitted: auto-generated (failure)

This is a MIME-encapsulated message

--jA3CEg2Y003370.1131020082/server1.domain.com

The original message was received at Thu, 3 Nov 2005 13:14:41 +0100
from localhost [127.0.0.1]

----- The following addresses had permanent fatal errors -----
<scalix@domain.com>

----- Transcript of session follows -----
554 5.3.0 unknown mailer error 1

--jA3CEg2Y003370.1131020082/server1.domain.com
Content-Type: message/delivery-status

Reporting-MTA: dns; server1.domain.com
Received-From-MTA: DNS; localhost
Arrival-Date: Thu, 3 Nov 2005 13:14:41 +0100

Final-Recipient: RFC822; scalix@domain.com
X-Actual-Recipient: rfc822; scalix@server1.domain.com
Action: failed
Status: 5.0.0
Last-Attempt-Date: Thu, 3 Nov 2005 13:14:42 +0100

--jA3CEg2Y003370.1131020082/server1.domain.com
Content-Type: message/rfc822

Return-Path: <scalix@server2.domain.com>
Received: from server1.domain.com (localhost [127.0.0.1])
by server1.domain.com (8.12.10/8.12.10/SuSE Linux 0.7) with ESMTP id jA3CEf2Y003366
for <scalix@domain.com>; Thu, 3 Nov 2005 13:14:41 +0100
Received: from server1.domain.com (root@localhost)
by server1.domain.com (9.12.10/8.12.10/Submit) with ESMTP id jA3CEfnY003365
for <scalix@domain.com>; Thu, 3 Nov 2005 13:14:41 +0100
Received: from server2.domain.com (server2.domain.com 192.168.200.12)
by server1.domain.com (Scalix SMTP Relay 9.4.0.8)
via ESMTP; Thu, 03 Nov 2005 13:14:41 +0100 (CET)
Received: from server2.domain.com (localhost [127.0.0.1])
by server2.domain.com (8.12.10/8.12.10/SuSE Linux 0.7) with ESMTP id jA3CFljw016727
for <scalix@domain.com>; Thu, 3 Nov 2005 13:15:47 +0100
Received: (from root@localhost)
by server2.domain.com (8.12.10/8.12.10/Submit) id jA3CFlda016724
for scalix@domain.com; Thu, 3 Nov 2005 13:15:47 +0100
Date: Thu, 3 Nov 2005 13:15:47 +0100
From: Scalix User <scalix@server2.domain.com>
Sender: scalix@server2.domain.com
To: undisclosed-recipients:;;;@server1.domain.com;
Message-ID: <X00000000001e800.1131020081.server1.domain.com@MHS>
Subject: Encoded Scalix Transport Message
x-scalix-Hops: 1
MIME-Version: 1.0
Content-Type: text/plain;
charset="US-ASCII"
Content-Transfer-Encoding: quoted-printable
Content-Disposition: inline

scalix-encoded-message
~to~
>SMINTFC:scalix@server1.domain.com
~pri~
0
~tf~
M`+QA3@````$````D```$3``````````H``$```````$"`H````````````,`
M```<```G&@`````````H0P!)4T\X.#4Y7S$`````2P``,Y``````````*```
M2#`P,#`P-C4P,#`Q93=3DE,RXQ,3,Q,#(P,#<W+G-C86QI>"YM:71T92YW<V0N
M8FUV:70N9W8N870`````/P``)Q``````````*`````````````$`````````
M````*W1E<W0=3D'1T=3D<W!O<FX=3D=3DFEA+61O;F%U'1T`````)P``*UP`````````
M*%1E<W0@4V5R=3DF5R(%)E<&]R=3D```````````@```,RP`````````*```2#`P
M,#`P,#`P,#`P,#@W-"XQ,3,Q,#(P,30W+G-P;W)N+G-C86QI>"YV:6$M9&]N
M874N;W)G`$@P,#`P,#`P,#`P,#`X-S0N,3$S,3`R,#$T-RYS<&]R;BYS8V%L
M:7@N=3DFEA+61O;F%U+F]R9P`````6```RR``````````H0VG_<P`\````.```
M=3DR0`````````*```!(X```2.`````@```,(```````!#`$E33S@X-3E?,0``
M```````````X``!W)``````````H```$CP``!(\`````````H````````$,`
M25-/.#@U.5\Q`````````````)H``)Q``````````"@`(`````!334E.5$9#
M`'-C86QI>$!M:71T92YS8V%L:7@N=3DFEA+61O;F%U+F]R9P!S>&%D;6EN'1T=3D
M'6UI=3D'1E'79I861O;F%U'1T=3D'1T=3D'1T=3D'1T=3D'1T=3D'1T=3D%W-X861M:6X7%Q=
<=3D
M'2)S>&%D;6EN(B`\<WAA9&UI;D!V:6$M9&]N874N;W)G/@`````9``"L1```
M```````I0VG_+0`\``4`````+@``J^``````````*4-I_RT`/```<V-A;&EX
M'6UI=3D'1E+'9I861O;F%U`````"X``*O@`````````"E#:?]S`#P``'-P;W)N
M'7-P;W)N+'9I82UD;VYA=3D0`````N``"KX``````````H0VG_<P`\``!S<&]R
2;AUS<&]R;BQV:6$M9&]N874`
`
~bf~
M`+QA3@````$````D```$3``````````H``$````"`^@`````````````````
M```D``!.*@`````````H`````0`!`````0````````````````!R``!65```
M```````H`````````!!S>&%D;6EN'1T=3D'6UI=3D'1E'79I861O;F%U'1T=3D'1T=3D
M'1T=3D'1T=3D'1T=3D'1T=3D%W-X861M:6X7%Q<=3D'2)S>&%D;6EN(B`\<WAA9&UI;D!V
=2E:6$M9&]N874N;W)G/@!X
`
~bf~
M66]U<B!M97-S86=3DE('=3DA<R!S=3D6-C97-S9G5L;'D@<F5C96EV960N"@I3>7-T
M96TZ('-P;W)N"E-C86QI>"!V97)S:6]N.B`Y+C0N,"XY"E)E8V5I=3DF5D(&UE
M<W-A9V4@8W)E871E('1I;64Z(#$Q+C`S+C`U(#$S.C$T.C,W"E)E8V5I=3DF5D
9('1I;64Z(#$Q+C`S+C`U(#$S.C$U.C0W"C`U
`

--jA3CEg2Y003370.1131020082/server1.domain.com--

When I restart the SR, I get again the error messages in the fatal log and the files aren't cleared out.

Thanks for help!

[rudi]

Hi,

I have updated the Scalix Server to 10.0.5. But I have this error again:

ERROR Service Router(Incoming Trans) Wed Feb 7 12:14:59 2007
[OM 1001] Transaction File record size is out of bounds
Pid of logging process: 10822

Thanks for help!!!

[rudi]

Now I have updated to Scalix 11.0.1 and this error comes again:

ERROR Service Router(Incoming Trans) Thu Feb 8 15:07:53 2007
[OM 1001] Transaction File record size is out of bounds
Pid of logging process: 6258

[florian]

have you followed the troubleshooting steps documented in this thread?

also, is this a multi-server installation in a mixed scalix 10/scalix 11 environment?

Florian.