For me it looks like someone open many connections to your server and not close them probaly. Maybe you want to "drop" the timeout.
bye Norman Am Sonntag, den 27.08.2006, 11:58 +0200 schrieb Rudolf Schmidt: > I am runnning James since 2004 and never got such serious problems. > Occasionally James runs out of connections (thats what the connection log is > saying) and from that point whether pop3 or smtp are working anymore > (connection Timeout is 60000ms). I tried to migrate to 2.3, increased the > max connections to 50. Another message I sometimes got is, that not enough > components could be created, so I already increased the threadcount. > > Here are some snippets from my logs, it happened last night at 4:02 so I > would think, it's not because of high traffic. Could this be an unfriendly > attack? Could this be an database issue, I am running on MySQL 4.1 with > 3.1.13 Connectors using Modred connection pooling (dhcp want work, states > port already in use after some minutes). > > The server is not recovering, so I always have to restart james. > > Thanks for help > > SMTP-Server Log: > > 27/08/06 04:02:39 INFO smtpserver: Connection from 125.136.22.132 > (125.136.22.132) > 27/08/06 04:02:42 INFO smtpserver: Successfully spooled mail > Mail1156644162243-4279 from [EMAIL PROTECTED] on > 125.136.22.132 for [EMAIL PROTECTED] > 27/08/06 04:02:53 INFO smtpserver: Connection from > host109-57.pool8710.interbusiness.it (87.10.57.109) > 27/08/06 04:03:11 INFO smtpserver: Connection from > lns-bzn-28-82-250-146-127.adsl.proxad.net (82.250.146.127) > 27/08/06 04:04:36 INFO smtpserver: Connection from 190.40.245.30 > (190.40.245.30) > 27/08/06 04:05:07 INFO smtpserver: Connection from vps.9ads.com.au > (207.58.137.176) > 27/08/06 04:05:16 INFO smtpserver: Connection from renoirpc58.sdnet.com.br > (200.195.3.58) > 27/08/06 04:05:46 ERROR smtpserver: Unknown error occurred while processing > DATA. > javax.mail.MessagingException: Unable to retrieve the data: Read timed out; > nested exception is: > java.net.SocketTimeoutException: Read timed out > at > org.apache.james.core.MimeMessageInputStreamSource.<init>(MimeMessageInputSt > reamSource.java:99) > at org.apache.james.core.MailImpl.<init>(MailImpl.java:179) > at > org.apache.james.smtpserver.DataCmdHandler.processMail(DataCmdHandler.java:2 > 64) > at > org.apache.james.smtpserver.DataCmdHandler.doDATA(DataCmdHandler.java:131) > at > org.apache.james.smtpserver.DataCmdHandler.onCommand(DataCmdHandler.java:79) > at > org.apache.james.smtpserver.SMTPHandler.handleConnection(SMTPHandler.java:39 > 1) > at > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner.run > (ServerConnection.java:422) > at > org.apache.excalibur.thread.impl.ExecutableRunnable.execute(ExecutableRunnab > le.java:55) > at > org.apache.excalibur.thread.impl.WorkerThread.run(WorkerThread.java:116) > Caused by: java.net.SocketTimeoutException: Read timed out > at java.net.SocketInputStream.socketRead0(Native Method) > at java.net.SocketInputStream.read(SocketInputStream.java:129) > at java.io.BufferedInputStream.fill(BufferedInputStream.java:218) > at java.io.BufferedInputStream.read(BufferedInputStream.java:235) > at > org.apache.james.util.CharTerminatedInputStream.read(CharTerminatedInputStre > am.java:98) > at > org.apache.james.util.watchdog.BytesReadResetInputStream.read(BytesReadReset > InputStream.java:96) > at > org.apache.james.util.DotStuffingInputStream.read(DotStuffingInputStream.jav > a:48) > at java.io.SequenceInputStream.read(SequenceInputStream.java:135) > at java.io.SequenceInputStream.read(SequenceInputStream.java:135) > at > org.apache.james.core.MimeMessageInputStreamSource.<init>(MimeMessageInputSt > reamSource.java:76) > ... 8 more > 27/08/06 04:05:50 ERROR smtpserver: Socket to 190.40.245.30 (190.40.245.30) > closed remotely. > java.net.SocketException: Connection reset > at java.net.SocketInputStream.read(SocketInputStream.java:168) > at java.io.BufferedInputStream.fill(BufferedInputStream.java:218) > at java.io.BufferedInputStream.read(BufferedInputStream.java:235) > at > org.apache.james.util.CRLFTerminatedReader.read(CRLFTerminatedReader.java:15 > 1) > at > org.apache.james.util.CRLFTerminatedReader.readLine(CRLFTerminatedReader.jav > a:111) > at > org.apache.james.smtpserver.SMTPHandler.readCommandLine(SMTPHandler.java:749 > ) > at > org.apache.james.smtpserver.SMTPHandler.handleConnection(SMTPHandler.java:37 > 0) > at > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner.run > (ServerConnection.java:422) > at > org.apache.excalibur.thread.impl.ExecutableRunnable.execute(ExecutableRunnab > le.java:55) > at > org.apache.excalibur.thread.impl.WorkerThread.run(WorkerThread.java:116) > 27/08/06 04:06:03 INFO smtpserver: Connection from 221.196.124.79 > (221.196.124.79) > 27/08/06 04:06:12 INFO smtpserver: Connection from > 85-250-132-198.bb.netvision.net.il (85.250.132.198) > 27/08/06 04:06:53 INFO smtpserver: Connection from 221.139.120.41 > (221.139.120.41) > 27/08/06 04:07:04 INFO smtpserver: Connection from OL51-196.fibertel.com.ar > (24.232.196.51) > 27/08/06 04:07:11 INFO smtpserver: Connection from 189.166.102.207 > (189.166.102.207) > 27/08/06 04:07:22 INFO smtpserver: Connection from > sal69-1-82-231-94-116.fbx.proxad.net (82.231.94.116) > 27/08/06 04:07:24 INFO smtpserver: Connection from 201.254.209.149 > (201.254.209.149) > 27/08/06 04:07:58 INFO smtpserver: Connection from 69.79.176.166 > (69.79.176.166) > 27/08/06 04:08:15 INFO smtpserver: Connection from 24.49.116.62 > (24.49.116.62) > 27/08/06 04:08:35 INFO smtpserver: Connection from 124.80.115.248 > (124.80.115.248) > 27/08/06 04:09:00 INFO smtpserver: Connection from > pool-71-101-142-254.tampfl.dsl-w.verizon.net (71.101.142.254) > 27/08/06 04:09:30 INFO smtpserver: Connection from > 119.Red-83-46-39.dynamicIP.rima-tde.net (83.46.39.119) > 27/08/06 04:09:47 INFO smtpserver: Connection from 201.96.142.225 > (201.96.142.225) > 27/08/06 04:10:06 INFO smtpserver: Connection from > AAmiens-157-1-123-218.w86-215.abo.wanadoo.fr (86.215.182.218) > 27/08/06 04:10:44 INFO smtpserver: Connection from 218.239.87.58 > (218.239.87.58) > 27/08/06 04:10:54 ERROR smtpserver: Unknown error occurred while processing > DATA. > javax.mail.MessagingException: Unable to retrieve the data: Read timed out; > nested exception is: > java.net.SocketTimeoutException: Read timed out > at > org.apache.james.core.MimeMessageInputStreamSource.<init>(MimeMessageInputSt > reamSource.java:99) > at org.apache.james.core.MailImpl.<init>(MailImpl.java:179) > at > org.apache.james.smtpserver.DataCmdHandler.processMail(DataCmdHandler.java:2 > 64) > at > org.apache.james.smtpserver.DataCmdHandler.doDATA(DataCmdHandler.java:131) > at > org.apache.james.smtpserver.DataCmdHandler.onCommand(DataCmdHandler.java:79) > at > org.apache.james.smtpserver.SMTPHandler.handleConnection(SMTPHandler.java:39 > 1) > at > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner.run > (ServerConnection.java:422) > at > org.apache.excalibur.thread.impl.ExecutableRunnable.execute(ExecutableRunnab > le.java:55) > at > org.apache.excalibur.thread.impl.WorkerThread.run(WorkerThread.java:116) > Caused by: java.net.SocketTimeoutException: Read timed out > at java.net.SocketInputStream.socketRead0(Native Method) > at java.net.SocketInputStream.read(SocketInputStream.java:129) > at java.io.BufferedInputStream.fill(BufferedInputStream.java:218) > at java.io.BufferedInputStream.read(BufferedInputStream.java:235) > at > org.apache.james.util.CharTerminatedInputStream.read(CharTerminatedInputStre > am.java:98) > at > org.apache.james.util.watchdog.BytesReadResetInputStream.read(BytesReadReset > InputStream.java:96) > at > org.apache.james.util.DotStuffingInputStream.read(DotStuffingInputStream.jav > a:48) > at java.io.SequenceInputStream.read(SequenceInputStream.java:135) > at java.io.SequenceInputStream.read(SequenceInputStream.java:135) > at > org.apache.james.core.MimeMessageInputStreamSource.<init>(MimeMessageInputSt > reamSource.java:76) > ... 8 more > 27/08/06 04:10:58 ERROR smtpserver: Socket to 201.96.142.225 > (201.96.142.225) closed remotely. > java.net.SocketException: Connection reset > at java.net.SocketInputStream.read(SocketInputStream.java:168) > at java.io.BufferedInputStream.fill(BufferedInputStream.java:218) > at java.io.BufferedInputStream.read(BufferedInputStream.java:235) > at > org.apache.james.util.CRLFTerminatedReader.read(CRLFTerminatedReader.java:15 > 1) > at > org.apache.james.util.CRLFTerminatedReader.readLine(CRLFTerminatedReader.jav > a:111) > at > org.apache.james.smtpserver.SMTPHandler.readCommandLine(SMTPHandler.java:749 > ) > at > org.apache.james.smtpserver.SMTPHandler.handleConnection(SMTPHandler.java:37 > 0) > at > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner.run > (ServerConnection.java:422) > at > org.apache.excalibur.thread.impl.ExecutableRunnable.execute(ExecutableRunnab > le.java:55) > at > org.apache.excalibur.thread.impl.WorkerThread.run(WorkerThread.java:116) > 27/08/06 04:11:07 INFO smtpserver: Connection from > 200-122-123-81.dsl.prima.net.ar (200.122.123.81) > 27/08/06 04:11:23 INFO smtpserver: Connection from > bzq-84-109-17-148.red.bezeqint.net (84.109.17.148) > 27/08/06 04:11:31 INFO smtpserver: Connection from > 84-122-21-48.onocable.ono.com (84.122.21.48) > 27/08/06 04:11:46 INFO smtpserver: Connection from > host45-172.pool8257.interbusiness.it (82.57.172.45) > 27/08/06 04:11:53 INFO smtpserver: Connection from 58.230.81.192 > (58.230.81.192) > 27/08/06 04:12:22 INFO smtpserver: Connection from > 200-127-23-147.prima.net.ar (200.127.23.147) > 27/08/06 04:12:29 INFO smtpserver: Connection from 59.38.67.2 (59.38.67.2) > 27/08/06 04:12:31 INFO smtpserver: Connection from > bl5-213-143.dsl.telepac.pt (82.154.213.143) > 27/08/06 04:12:37 INFO smtpserver: Connection from > lns-bzn-31-82-252-239-226.adsl.proxad.net (82.252.239.226) > 27/08/06 04:12:57 INFO smtpserver: Connection from 59.38.67.2 (59.38.67.2) > 27/08/06 04:13:07 INFO smtpserver: Connection from bl7-44-82.dsl.telepac.pt > (85.240.44.82) > 27/08/06 04:13:13 INFO smtpserver: Connection from > cm-85-152-180-75.telecable.es (85.152.180.75) > 27/08/06 04:13:23 INFO smtpserver: Connection from 59.38.67.2 (59.38.67.2) > 27/08/06 04:13:30 INFO smtpserver: Connection from > adsl-69-224-54-89.dsl.irvnca.pacbell.net (69.224.54.89) > 27/08/06 04:13:48 INFO smtpserver: Connection from > CPE-65-28-109-55.kc.res.rr.com (65.28.109.55) > 27/08/06 04:13:50 INFO smtpserver: Connection from 59.38.67.2 (59.38.67.2) > 27/08/06 04:14:06 INFO smtpserver: Connection from > dyn-83-152-193-15.ppp.tiscali.fr (83.152.193.15) > 27/08/06 04:14:18 INFO smtpserver: Connection from > bzq-84-108-220-187.cablep.bezeqint.net (84.108.220.187) > 27/08/06 04:14:18 INFO smtpserver: Connection from 59.38.67.2 (59.38.67.2) > 27/08/06 04:14:19 INFO smtpserver: Connection from > CPE-65-28-109-55.kc.res.rr.com (65.28.109.55) > 27/08/06 04:14:37 INFO smtpserver: Connection from > 66.49.93.146.nw.nuvox.net (66.49.93.146) > 27/08/06 04:14:45 INFO smtpserver: Connection from 213.197.128.166 > (213.197.128.166) > 27/08/06 04:14:50 INFO smtpserver: Connection from > CPE-65-28-109-55.kc.res.rr.com (65.28.109.55) > 27/08/06 04:14:53 ERROR smtpserver: SMTP Connection has idled out. > 27/08/06 04:15:02 INFO smtpserver: Connection from > 173.41.187.220.broad.zs.zj.dynamic.cndata.com (220.187.41.173) > 27/08/06 04:15:04 ERROR smtpserver: Socket to > 173.41.187.220.broad.zs.zj.dynamic.cndata.com (220.187.41.173) closed > remotely. > java.net.SocketException: Connection reset > at java.net.SocketInputStream.read(SocketInputStream.java:168) > at java.io.BufferedInputStream.fill(BufferedInputStream.java:218) > at java.io.BufferedInputStream.read(BufferedInputStream.java:235) > at > org.apache.james.util.CRLFTerminatedReader.read(CRLFTerminatedReader.java:15 > 1) > at > org.apache.james.util.CRLFTerminatedReader.readLine(CRLFTerminatedReader.jav > a:111) > > POP3 Log: > > 27/08/06 03:52:14 INFO pop3server: Connection for > thorsten..famile-hinrichs.de from dslc-082-082-188-072.pools.arcor-ip.net > (82.82.188.72) closed. > 27/08/06 03:52:19 INFO pop3server: Connection for mail..famile-hinrichs.de > from dslc-082-082-188-072.pools.arcor-ip.net (82.82.188.72) closed. > 27/08/06 07:52:43 INFO pop3server: Connection from > dslb-082-083-225-217.pools.arcor-ip.net (82.83.225.217) > 27/08/06 07:56:43 ERROR pop3server: POP3 Connection has idled out. > 27/08/06 08:27:46 INFO pop3server: Connection from > dslb-082-083-225-217.pools.arcor-ip.net (82.83.225.217) > 27/08/06 08:31:46 ERROR pop3server: POP3 Connection has idled out. > 27/08/06 08:32:45 INFO pop3server: Connection from > dslb-082-083-225-217.pools.arcor-ip.net (82.83.225.217) > 27/08/06 08:36:45 ERROR pop3server: POP3 Connection has idled out. > > > Connection Log: > > 27/08/06 04:19:45 WARN connections: Maximum number of open connections > exceeded - refusing connection. Current number of connections is 60 > 27/08/06 04:19:45 INFO connections: Connections: > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=host109-57.pool8710.interbusiness.it/87.10.57.109,port=1652,loca > lport=25] on Thread[default Worker #11,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=lns-bzn-28-82-250-146-127.adsl.proxad.net/82.250.146.127,port=39 > 82,localport=25] on Thread[default Worker #23,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=renoirpc58.sdnet.com.br/200.195.3.58,port=3661,localport=25] on > Thread[default Worker #14,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=221.196.124.79/221.196.124.79,port=63592,localport=25] on > Thread[default Worker #21,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=85-250-132-198.bb.netvision.net.il/85.250.132.198,port=4595,loca > lport=25] on Thread[default Worker #7,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=221.139.120.41/221.139.120.41,port=2575,localport=25] on > Thread[default Worker #25,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=OL51-196.fibertel.com.ar/24.232.196.51,port=4833,localport=25] > on Thread[default Worker #19,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=189.166.102.207/189.166.102.207,port=62403,localport=25] on > Thread[default Worker #9,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=sal69-1-82-231-94-116.fbx.proxad.net/82.231.94.116,port=1961,loc > alport=25] on Thread[default Worker #16,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=201.254.209.149/201.254.209.149,port=1560,localport=25] on > Thread[default Worker #22,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=69.79.176.166/69.79.176.166,port=3683,localport=25] on > Thread[default Worker #24,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=24.49.116.62/24.49.116.62,port=4978,localport=25] on > Thread[default Worker #8,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=124.80.115.248/124.80.115.248,port=3764,localport=25] on > Thread[default Worker #13,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=pool-71-101-142-254.tampfl.dsl-w.verizon.net/71.101.142.254,port > =50681,localport=25] on Thread[default Worker #30,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=119.Red-83-46-39.dynamicIP.rima-tde.net/83.46.39.119,port=1870,l > ocalport=25] on Thread[default Worker #32,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=AAmiens-157-1-123-218.w86-215.abo.wanadoo.fr/86.215.182.218,port > =3238,localport=25] on Thread[default Worker #36,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=218.239.87.58/218.239.87.58,port=2982,localport=25] on > Thread[default Worker #38,5,default] > 27/08/06 04:19:45 INFO connections: > org.apache.james.util.connection.ServerConnection$ClientConnectionRunner for > Socket[addr=200-122-123-81.dsl.prima.net.ar/200.122.123.81,port=55451,localp > ort=25] on Thread[default Worker #35,5,default] > .... > > !EXCUBATOR:1,44f16cea45111065217252!
signature.asc
Description: Dies ist ein digital signierter Nachrichtenteil
