Mantis Bugtracker
  

Viewing Issue Simple Details Jump to Notes ] View Advanced ] Issue History ] Print ]
ID Category Severity Reproducibility Date Submitted Last Update
0004540 [Resin] major always 05-10-11 03:53 06-20-11 11:20
Reporter mros2stf View Status public  
Assigned To ferg
Priority normal Resolution fixed  
Status closed   Product Version 4.0.16
Summary 0004540: Access log rollover stops after a period of time
Description I've had 4.0.16 Pro up since 4/1/2011, and as of 5/4/2011, access log rollover isn't working properly.

I have this coded in my resin.xml file:
 <access-log path="log/access.log"
                format='%h %l %u %t "%r" %s %b "%{Referer}i" "%{User-Agent}i"'
                rollover-period="1D"
                rollover-size="-1"
                rollover-count="14"
                archive-format="access.log.%Y%m%d.gz"/>

I manually deleted one .gz file this morning hoping it would roll, but it didn't . Here is the contents of the /var/www/log directory.

francis@adczlnxsahp1:/var/www/log> ls -l
total 71688
-rw-r--r-- 1 webmstr www-data 59472968 2011-05-10 06:52 access.log
-rw-r--r-- 1 webmstr www-data 547656 2011-04-23 00:00 access.log.20110422.gz
-rw-r--r-- 1 webmstr www-data 765530 2011-04-24 00:00 access.log.20110423.gz
-rw-r--r-- 1 webmstr www-data 300961 2011-04-25 00:00 access.log.20110424.gz
-rw-r--r-- 1 webmstr www-data 938494 2011-04-26 00:00 access.log.20110425.gz
-rw-r--r-- 1 webmstr www-data 1018657 2011-04-27 00:00 access.log.20110426.gz
-rw-r--r-- 1 webmstr www-data 934099 2011-04-28 00:00 access.log.20110427.gz
-rw-r--r-- 1 webmstr www-data 919266 2011-04-29 00:00 access.log.20110428.gz
-rw-r--r-- 1 webmstr www-data 1056809 2011-04-30 00:00 access.log.20110429.gz
-rw-r--r-- 1 webmstr www-data 612133 2011-05-01 00:01 access.log.20110430.gz
-rw-r--r-- 1 webmstr www-data 564588 2011-05-02 00:00 access.log.20110501.gz
-rw-r--r-- 1 webmstr www-data 1135696 2011-05-03 00:00 access.log.20110502.gz
-rw-r--r-- 1 webmstr www-data 1024911 2011-05-04 00:00 access.log.20110503.gz
-rw-r--r-- 1 webmstr www-data 3966650 2011-05-09 07:23 access.log.20110504.gz
francis@adczlnxsahp1:/var/www/log>

Additional Information
Attached Files

- Relationships
related to 0004680closed ferg daily log rollover fails to rollover files 

- Notes
(0005231)
mros2stf
05-11-11 08:59

It continues to grow and has yet to roll again. This is filling up my file system. It hasn't switched since May 9th, and I even restarted Resin this morning hoping it would check the dates and roll it, but it didn't.

francis@adczlnxsahp1:/var/www/log> ls -l
total 122984
-rw-r--r-- 1 webmstr www-data 113474413 2011-05-11 11:58 access.log
 
(0005232)
ferg
05-11-11 10:03

Note: The date check on the restart is based on the last modified time of the file itself (it doesn't parse the file). So a restart should have a rollover at the next normal rollover time.

(The bug fix is unrelated to the comment above; it's a real bug. There are some cases where the alarm for the rollover could miss being rescheduled.)
 
(0005274)
cowan
05-24-11 08:16

Sorry guys, but this isn't fixed completely in 4.0.18 either. I have cron jobs that process the archive log that fail because it isn't there. There is plenty of activity in the log, so I'm not sure why it doesn't rollover. If your's is going to continue to break I may have to remove it from the configuration and create my own script to process this.

francis@adczlnxsahp1:/var/www/log> ls -l
total 65020
-rw-r--r-- 1 webmstr www-data 42172420 2011-05-24 06:33 access.log
-rw-r--r-- 1 webmstr www-data 98304 2011-05-11 06:19 access.log.20110509.gz
-rw-r--r-- 1 webmstr users 6716911 2011-05-11 12:44 access.log.20110510.gz
-rw-r--r-- 1 webmstr www-data 898281 2011-05-12 00:00 access.log.20110511.gz
-rw-r--r-- 1 webmstr www-data 1970158 2011-05-13 00:00 access.log.20110512.gz
-rw-r--r-- 1 webmstr www-data 1715788 2011-05-14 00:00 access.log.20110513.gz
-rw-r--r-- 1 webmstr www-data 1103944 2011-05-15 00:00 access.log.20110514.gz
-rw-r--r-- 1 webmstr www-data 1078825 2011-05-16 00:00 access.log.20110515.gz
-rw-r--r-- 1 webmstr www-data 1915350 2011-05-17 00:00 access.log.20110516.gz
-rw-r--r-- 1 webmstr www-data 1967415 2011-05-18 00:00 access.log.20110517.gz
-rw-r--r-- 1 webmstr www-data 1705271 2011-05-19 00:01 access.log.20110518.gz
-rw-r--r-- 1 webmstr www-data 1594003 2011-05-20 00:00 access.log.20110519.gz
-rw-r--r-- 1 webmstr www-data 1469069 2011-05-21 00:00 access.log.20110520.gz
-rw-r--r-- 1 webmstr www-data 1060138 2011-05-22 00:00 access.log.20110521.gz
-rw-r--r-- 1 webmstr www-data 971692 2011-05-23 00:00 access.log.20110522.gz
 
(0005304)
mros2stf
06-09-11 04:38
edited on: 06-09-11 04:41

I was correct, this isn't quite fixed in 4.0.18, as it failed to rollover last night. It also isn't getting rid of old logs either as you could see there were 15 logs, and it should have rolled making 16, and deleted 2 to only keep 14.

Resin Professional 4.0.18 (built Thu, 12 May 2011 01:39:03 PDT)
Copyright(c) 1998-2010 Caucho Technology. All rights reserved.

  1012731.license -- 128 Resin servers Intercontinental Hotel Groups (IHG)

Starting Resin Professional on Tue, 07 Jun 2011 11:57:33 -0400 (EDT)

OpenSSL support compiled for OpenSSL 0.9.8a 11 Oct 2005

francis@adczlnxsahp1:/var/www/log> ls -l
total 44804
-rw-r--r-- 1 webmstr www-data 25749665 2011-06-09 07:34 access.log
-rw-r--r-- 1 webmstr users 2321178 2011-05-24 06:49 access.log.20110523.gz
-rw-r--r-- 1 webmstr users 1750899 2011-05-25 06:26 access.log.20110524.gz
-rw-r--r-- 1 webmstr users 1596624 2011-05-26 06:22 access.log.20110525.gz
-rw-r--r-- 1 webmstr users 1393537 2011-05-27 06:27 access.log.20110526.gz
-rw-r--r-- 1 webmstr users 1579572 2011-05-28 14:57 access.log.20110527.gz
-rw-r--r-- 1 webmstr users 1592185 2011-05-30 09:08 access.log.20110529.gz
-rw-r--r-- 1 webmstr users 987957 2011-05-31 06:10 access.log.20110530.gz
-rw-r--r-- 1 webmstr users 1488068 2011-06-01 07:29 access.log.20110531.gz
-rw-r--r-- 1 webmstr users 1374771 2011-06-02 06:44 access.log.20110601.gz
-rw-r--r-- 1 webmstr www-data 374937 2011-06-03 06:53 access.log.20110602.gz
-rw-r--r-- 1 webmstr www-data 854937 2011-06-04 00:00 access.log.20110603.gz
-rw-r--r-- 1 webmstr www-data 776894 2011-06-05 00:00 access.log.20110604.gz
-rw-r--r-- 1 webmstr www-data 708811 2011-06-06 00:00 access.log.20110605.gz
-rw-r--r-- 1 webmstr www-data 1386206 2011-06-07 00:00 access.log.20110606.gz
-rw-r--r-- 1 webmstr users 1816621 2011-06-08 06:49 access.log.20110607.gz

 
(0005311)
mros2stf
06-10-11 03:54

In looking at all the different servers I have running 4.0.18, all have the issue but the one that doesn't have activity currently during the midnight time frame, from what I can tell. I'll look further, but I'm currently having to manually fix this daily so as to not fill my file system.
 
(0005331)
ferg
06-20-11 11:20

WeakAlarm in AbstractRolloverLog needs reference to the listener to avoid GC.
 

- Issue History
Date Modified Username Field Change
05-10-11 03:53 mros2stf New Issue
05-11-11 08:57 mros2stf Issue Monitored: mros2stf
05-11-11 08:59 mros2stf Note Added: 0005231
05-11-11 10:03 ferg Note Added: 0005232
05-11-11 10:03 ferg Assigned To  => ferg
05-11-11 10:03 ferg Status new => closed
05-11-11 10:03 ferg Resolution open => fixed
05-11-11 10:03 ferg Fixed in Version  => 4.0.18
05-24-11 08:16 cowan Assigned To ferg =>
05-24-11 08:16 cowan Status closed => feedback
05-24-11 08:16 cowan Resolution fixed => reopened
05-24-11 08:16 cowan Note Added: 0005274
06-09-11 04:38 mros2stf Note Added: 0005304
06-09-11 04:41 mros2stf Note Edited: 0005304
06-10-11 03:54 mros2stf Note Added: 0005311
06-20-11 11:20 ferg Note Added: 0005331
06-20-11 11:20 ferg Assigned To  => ferg
06-20-11 11:20 ferg Status feedback => closed
06-20-11 11:20 ferg Resolution reopened => fixed
06-20-11 11:20 ferg Fixed in Version 4.0.18 => 4.0.20
07-25-11 09:41 alex Relationship added related to 0004680


Mantis 1.0.0rc3[^]
Copyright © 2000 - 2005 Mantis Group
47 total queries executed.
35 unique queries executed.
Powered by Mantis Bugtracker