Cache Flush reported excessively

[GoogleCodeExporter]

Creating a 'cache.flush' file results in [warn] level errors:

[Tue Nov 13 11:08:07 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @5177] Cache 
Flush 0
[Tue Nov 13 11:08:08 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @3209] Cache 
Flush 0
[Tue Nov 13 11:08:08 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @5841] Cache 
Flush 0
[Tue Nov 13 11:08:09 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @5087] Cache 
Flush 0
[Tue Nov 13 11:08:09 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @5801] Cache 
Flush 0
...
[Tue Nov 13 11:12:27 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @8107] Cache 
Flush 0
[Tue Nov 13 11:12:28 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @8110] Cache 
Flush 0
[Tue Nov 13 11:12:28 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @8111] Cache 
Flush 0
[Tue Nov 13 11:12:29 2012] [error] [mod_pagespeed 1.1.23.1-2169 @8112] Shutting 
down mod_pagespeed child
[Tue Nov 13 11:12:30 2012] [error] [mod_pagespeed 1.1.23.1-2169 @8113] Shutting 
down mod_pagespeed child
[Tue Nov 13 11:12:31 2012] [error] [mod_pagespeed 1.1.23.1-2169 @7746] Shutting 
down mod_pagespeed child
[Tue Nov 13 11:12:31 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @7725] Cache 
Flush 0
[Tue Nov 13 11:12:32 2012] [error] [mod_pagespeed 1.1.23.1-2169 @7425] Shutting 
down mod_pagespeed child
[Tue Nov 13 11:12:33 2012] [error] [mod_pagespeed 1.1.23.1-2169 @8109] Shutting 
down mod_pagespeed child
[Tue Nov 13 11:12:34 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @8017] Cache 
Flush 0


While our main server is repeating "Cache Flush 0" ad infinitum (600+ already), 
another (VPS) server is counting up:

[Tue Nov 13 11:26:14 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19810] Cache 
Flush 21
[Tue Nov 13 11:26:17 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19813] Cache 
Flush 22
[Tue Nov 13 11:26:18 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19814] Cache 
Flush 23
[Tue Nov 13 11:26:28 2012] [error] [mod_pagespeed 1.1.23.1-2169 @19813] 
Shutting down mod_pagespeed child
[Tue Nov 13 11:26:32 2012] [error] [mod_pagespeed 1.1.23.1-2169 @19809] 
Shutting down mod_pagespeed child
[Tue Nov 13 11:26:33 2012] [error] [mod_pagespeed 1.1.23.1-2169 @19672] 
Shutting down mod_pagespeed child
[Tue Nov 13 11:26:34 2012] [error] [mod_pagespeed 1.1.23.1-2169 @19792] 
Shutting down mod_pagespeed child
[Tue Nov 13 11:26:35 2012] [error] [mod_pagespeed 1.1.23.1-2169 @19528] 
Shutting down mod_pagespeed child
[Tue Nov 13 11:26:38 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19807] Cache 
Flush 24
...
[Tue Nov 13 11:27:47 2012] [notice] caught SIGTERM, shutting down
[Tue Nov 13 11:27:48 2012] [notice] Apache/2.2.16 (Debian) configured -- 
resuming normal operations
[Tue Nov 13 11:27:53 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19864] Cache 
Flush 1
[Tue Nov 13 11:27:54 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19866] Cache 
Flush 2
[Tue Nov 13 11:28:01 2012] [warn] [mod_pagespeed 1.1.23.1-2169 @19867] Cache 
Flush 3

Original issue reported on code.google.com by jmara...@google.com on 13 Nov 2012 at 1:47

[GoogleCodeExporter]

OK here is my theory about the "ad infinitum" problems in your 'main server' -- 
your server is receiving sufficient traffic that Apache shuts down & restarts 
child processes regularly.  Each new process separately recognizes the 
cache.flush file (even though it hasn't changed) and "acknowledges" that with 
the warning.


I think I'd like to keep the warning, but avoid printing it more than once per 
server each time the file is touched.

Original comment by jmara...@google.com on 13 Nov 2012 at 1:50

• Changed state: Started

[GoogleCodeExporter]

Server #1, physical server, 200+ websites and a lot of traffic.  Still 
repeating "Cache Flush 0" with ~1k log entries per hour.
Server #2, virtual server, 1 website, minimal traffic.  "Cache Flush" value 
incrementing each time - counter now approaching 100.
Server #3, virtual server, 1 website, little or no traffic.  No "Cache Flush" 
reported in error.log.

Original comment by dun...@chirp.com.au on 13 Nov 2012 at 1:59

[GoogleCodeExporter]

Fixed in http://code.google.com/p/modpagespeed/source/detail?r=2182

Original comment by jmara...@google.com on 14 Nov 2012 at 12:31

• Changed state: Fixed

[GoogleCodeExporter]

Original comment by j...@google.com on 14 Nov 2012 at 9:51

• Added labels: Milestone-v23