0004821: daily rollover task blocked some times

Mantis - Resin
Viewing Issue Advanced Details

ID:	Category:	Severity:	Reproducibility:	Date Submitted:	Last Update:
4821		block	sometimes	10-22-11 08:08	06-11-12 14:52

Reporter:	imxylz	Platform:
Assigned To:	ferg	OS:
Priority:	normal	OS Version:
Status:	closed	Product Version:	3.1.11
Product Build:		Resolution:	fixed
Projection:	none
ETA:	none	Fixed in Version:	4.0.28

Summary:	0004821: daily rollover task blocked some times
Description:	"http--8080-545$1171904446" daemon prio=10 tid=0x00002aaab833c800 nid=0x7e08 waiting for monitor entry [0x000000007c27f000] java.lang.Thread.State: BLOCKED (on object monitor) at com.caucho.log.StreamHandler.publish(StreamHandler.java:107) - waiting to lock <0x0000000711d5ee58> (a com.caucho.vfs.WriteStream) at com.caucho.log.SubHandler.publish(SubHandler.java:60) at com.caucho.log.EnvironmentLogger.log(EnvironmentLogger.java:331) at java.util.logging.Logger.doLog(Logger.java:503) at java.util.logging.Logger.log(Logger.java:526) at com.caucho.server.webapp.ErrorPageManager.sendServletError(ErrorPageManager.java:329) at com.caucho.server.http.HttpRequest.handleRequest(HttpRequest.java:288) at com.caucho.server.port.TcpConnection.run(TcpConnection.java:682) - locked <0x000000071207c708> (a java.lang.Object) at com.caucho.util.ThreadPool$Item.runTasks(ThreadPool.java:743) at com.caucho.util.ThreadPool$Item.run(ThreadPool.java:662) at java.lang.Thread.run(Thread.java:662) "http--8080-46$437830282" daemon prio=10 tid=0x00002aaab87f6000 nid=0x7be3 in Object.wait() [0x000000005a967000] java.lang.Thread.State: TIMED_WAITING (on object monitor) at java.lang.Object.wait(Native Method) at com.caucho.util.ThreadPool.schedule(ThreadPool.java:529) - locked <0x00000007118d1ca8> (a java.lang.Object) at com.caucho.util.ThreadPool.startPriority(ThreadPool.java:418) at com.caucho.log.AbstractRolloverLog.rolloverLog(AbstractRolloverLog.java:457) at com.caucho.log.AbstractRolloverLog.rollover(AbstractRolloverLog.java:346) at com.caucho.log.RotateStream.write(RotateStream.java:243) at com.caucho.vfs.WriteStream.flush(WriteStream.java:355) at com.caucho.log.EnvironmentStream.flush(EnvironmentStream.java:170) - locked <0x0000000711d703e8> (a com.caucho.vfs.WriteStream) at com.caucho.vfs.WriteStream.flush(WriteStream.java:360) at java.io.PrintStream.write(PrintStream.java:432) - locked <0x00000007118bcf30> (a java.io.PrintStream) at com.caucho.vfs.StdoutStream.write(StdoutStream.java:80) at com.caucho.vfs.WriteStream.flush(WriteStream.java:355) at com.caucho.log.AbstractRolloverLog.flush(AbstractRolloverLog.java:394) - locked <0x0000000711d5dd10> (a com.caucho.log.AbstractRolloverLog) at com.caucho.log.RotateStream.flush(RotateStream.java:264) at com.caucho.vfs.WriteStream.flush(WriteStream.java:360) at com.caucho.log.TimestampFilter.flush(TimestampFilter.java:237) at com.caucho.vfs.WriteStream.flush(WriteStream.java:360) at com.caucho.log.StreamHandler.publish(StreamHandler.java:122) - locked <0x0000000711d5ee58> (a com.caucho.vfs.WriteStream) at com.caucho.log.SubHandler.publish(SubHandler.java:60) at com.caucho.log.EnvironmentLogger.log(EnvironmentLogger.java:331) at java.util.logging.Logger.doLog(Logger.java:503) at java.util.logging.Logger.log(Logger.java:526) at com.caucho.server.webapp.ErrorPageManager.sendServletError(ErrorPageManager.java:329) at com.caucho.server.http.HttpRequest.handleRequest(HttpRequest.java:288) at com.caucho.server.port.TcpConnection.run(TcpConnection.java:682) - locked <0x000000071253d290> (a java.lang.Object) at com.caucho.util.ThreadPool$Item.runTasks(ThreadPool.java:743) at com.caucho.util.ThreadPool$Item.run(ThreadPool.java:662) at java.lang.Thread.run(Thread.java:662)
Steps To Reproduce:
Additional Information:	log configuration: <stderr-log path='/opt/logs/resin/stderr-person.log' rollover-period="1D" archive-format="stderr-person.log.%Y%m%d" /> <stdout-log path='/opt/logs/resin/stdout-person.log' rollover-period="1D" archive-format="stdout-person.log.%Y%m%d"/> jvm configuration: <jvm-arg>-Xmx4g</jvm-arg> <jvm-arg>-Xms4g</jvm-arg> <jvm-arg>-Xss1m</jvm-arg> <jvm-arg>-XX:NewSize=400m</jvm-arg> <jvm-arg>-XX:PermSize=80m</jvm-arg> <jvm-arg>-XX:MaxPermSize=256m</jvm-arg> <jvm-arg>-XX:+UseConcMarkSweepGC</jvm-arg> <jvm-arg>-XX:CMSInitiatingOccupancyFraction=70</jvm-arg> <jvm-arg>-Dcom.sun.management.jmxremote</jvm-arg> <jvm-arg>-Xloggc:/opt/logs/resin/jvm-person.log</jvm-arg> We have changed '-XX:NewSize=400m' to 1024m.
Relationships
Attached Files:	suc-person.20111014.dump [^] (32,248 bytes) 10-22-11 08:09

Notes