This discussion has been locked.
You can no longer post new replies to this discussion. If you have a question you can start a new discussion

[9.105-9] Ctasd: Internal Server Error

Hi All

I have experienced the following issue on my pop3s configuration:

2013:08:21-16:18:53 ****** pop3proxy[22978]: Accepted client connection from 10.242.5.1 for 212.227.17.171 (GMX Servers server_id 6)
2013:08:21-16:18:53 ****** pop3proxy[22978]: ****@****.us logged in (account 6)
2013:08:21-16:18:54 ****** pop3proxy[22976]: ****@*****.gr logged in (account 7)
2013:08:21-16:18:54 ****** pop3proxy[22976]: Client 10.242.5.1 logged out (account=7, deleted=0)
2013:08:21-16:19:01 ****** pop3proxy[16262]: ctasd response: HTTP/1.0 500 Internal Server Error
2013:08:21-16:19:01 ****** pop3proxy[16262]: ctasd response: Cache-Control: private
2013:08:21-16:19:01 ****** pop3proxy[16262]: ctasd response: Server: CTCFC/1.0

2013:08:21-16:19:01 ****** pop3proxy[16262]: id="1100" severity="info" sys="SecureMail" sub="pop3" name="email passed" from="****@****.com" to="Undisclosed recipients: ;" subject="FW: How's your vision?" size="2826128" srcip="16.234.97.231" dstip="157.55.1.215" uid="CDF9940B-8471-11DF-A5FE-00215AD965B8" ident="0/16262-692-1377098332"
2013:08:21-16:19:05 ****** pop3proxy[16262]: ctasd response: HTTP/1.0 500 Internal Server Error
2013:08:21-16:19:05 ****** pop3proxy[16262]: ctasd response: Cache-Control: private
2013:08:21-16:19:05 ****** pop3proxy[16262]: ctasd response: Server: CTCFC/1.0

2013:08:21-16:19:05 ****** pop3proxy[16262]: id="1100" severity="info" sys="SecureMail" sub="pop3" name="email passed" from="****@****.com" to="Undisclosed recipients: ;" subject="FW: 8A FERW TO SPYRO!!!" size="1105247" srcip="16.234.97.230" dstip="157.55.1.215" uid="ABDDF0E8-84E1-11DF-8EDE-00215AD6A710" ident="0/16262-693-1377098342"
2013:08:21-16:19:06 ****** pop3proxy[16262]: ctasd response: HTTP/1.0 500 Internal Server Error
2013:08:21-16:19:06 ****** pop3proxy[16262]: ctasd response: Cache-Control: private
2013:08:21-16:19:06 ****** pop3proxy[16262]: ctasd response: Server: CTCFC/1.0


I believe ctasd connects to commtouch - maybe it couldn't cope with the amount of emails-I've just enabled prefetch for pop3s for on our my hotmail accounts
 1 028 emails processed, 7 emails blocked

faillback log

The issue seems to have started here

2013:08:21-14:44:19 ******** [local0:info]  [5356]: CIpRepCache::Save() - Saved to file /tmp/ctipd.cache_v6
2013:08:21-14:44:23 ******** [local0:info]  [5356]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-14:44:23 ******** [local0:info]  [5356]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-14:48:13 ******** [user:notice] shutdown[30462]:  shutting down for system reboot
2013:08:21-14:48:22 ******** [daemon:notice] acpid:  exiting
2013:08:21-14:48:37 smtpd [daemon:err]  [4922]: Cannot connect: Connection refused
2013:08:21-14:48:42 ******** [daemon:notice] haveged:  haveged stopping due to signal 15
2013:08:21-14:48:42 ******** [daemon:info] irqd[3053]:  received SIGTERM
2013:08:21-14:51:23 ******** [local0:info] ctasd[5318]:  Loading configuration file /etc/ctasd/ctasd.conf
2013:08:21-14:51:23 ******** [local0:info] ctasd[5354]:  Update pid file /var/run/ctasd.pid [pis 5354]
2013:08:21-14:51:23 ******** [daemon:info] cssd[5353]:  [     (nil)] main (cssd.c:318) starting up...
2013:08:21-14:51:23 ******** [daemon:info] cssd[5353]:  [     (nil)] read_config (cssd.c:115) reading config
2013:08:21-14:51:23 ******** [daemon:info] cssd[5353]:  [     (nil)] main (cssd.c:328) initializing Avira virus scanner engine
2013:08:21-14:51:23 ******** [local0[:D]ebug] ctasd:  ctasd started
2013:08:21-14:51:24 ******** [local0:err]  [5338]: Unable to connect to Data Center [SingleLicense] - Can't resolve host iprep1.t.ctmail.com
2013:08:21-14:51:24 ******** [local0:info]  [5338]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-14:51:25 ******** [local0:err] ctasd[5356]:  Comm error [SingleEngine] - Can't resolve host resolver1.ast.ctmail.com, daemon will retry in background
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Synchronize proactive patterns...
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Synchronize patterns finished
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Load cache...
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Http server listening on port 783
2013:08:21-14:51:25 ******** [local0:err] ctasd[5356]:  CEnginesContainer::LoadCache() - [00001000Q0066K138E1S] Can't access file /tmp/ctasd.cache - fopen failed (2)

2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Load cache finished
2013:08:21-14:51:25 ******** [local0:err]  [5338]: CEnginesContainer::UpdateSettings() - Still unable to connect to Datacenter
2013:08:21-14:51:25 ******** [local0:info]  [5338]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-14:51:25 ******** [local0:err] ctasd[5356]:  GetServices error - Still unable to connect to Datacenter
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Stat server listening on port /var/run/ctasd.stats
2013:08:21-14:51:25 ******** [local0:info] ctasd[5356]:  Ready
2013:08:21-15:06:26 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:11:26 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:16:26 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:21:27 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:26:27 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:31:27 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:36:28 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:41:28 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:46:28 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:49:50 ******** [daemon[:D]ebug] rrdcached[3472]:  flushing old values
2013:08:21-15:49:50 ******** [daemon[:D]ebug] rrdcached[3472]:  rotating journals
2013:08:21-15:49:50 ******** [daemon[:D]ebug] rrdcached[3472]:  started new journal /var/log/reporting/rrd/rrd.journal.1377096590.945551
2013:08:21-15:51:25 ******** [local0:info]  [5338]: CIpRepCache::Save() - Saved to file /tmp/ctipd.cache_v6
2013:08:21-15:51:25 ******** [local0:info]  [5338]: CIpRepCache::Save() - Saved to file /tmp/ctipd.cache
2013:08:21-15:51:29 ******** [local0:err]  [5338]: CEnginesContainer::GetCacheDelta - HttpError: 400
2013:08:21-15:51:29 ******** [local0:info]  [5338]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-15:51:29 ******** [local0:info]  [5338]: CEnginesContainer::UpdateSettings() - Updating
2013:08:21-15:51:30 ******** [local0:err]  [5338]: Counters - can't open cache file /tmp/ctipd.DM_counters
2013:08:21-15:51:30 ******** [local0:err]  [5338]: Counters - can't open cache file /tmp/ctipd.DM_counters_v6
2013:08:21-15:53:45 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - Request timeout
2013:08:21-15:53:45 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-15:53:45 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:03:55 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - Request timeout
2013:08:21-16:03:55 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:03:55 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:01 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:01 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:01 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:05 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:05 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:05 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:06 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:06 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:19:06 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - still unable to connect
2013:08:21-16:22:11 ******** [local0:err] ctasd[5356]:  CMsg::ScanMessage() - Request timeout


2013:08:21-16:52:09 ******** pop3proxy[29780]: Server doesn't support UIDL: -ERR Exceeded the login limit for a 15 minute period. Reduce the frequency of requests to the POP3 server.
2013:08:21-16:52:09 ******** pop3proxy[29780]: Prefetch: UIDL isn't working properly, prefetching doesn't work without it. Exiting prefetch run.
2013:08:21-16:52:09 ******** pop3proxy[29780]: Failed to shutdown SSL connection
2013:08:21-16:56:14 ******* pop3proxy[30252]: Fatal: Failed to accept SSL client


This thread was automatically locked due to age.