Hi Charles,<div><br></div><div>I guess if the log in TraceTime (hotspot/src/share/vm/runtime/timer.cpp) is printed out as a whole in TraceTime's destructor, then the log would look more "intact", but the ordering of events in the log would have changed.</div>
<div><br></div><div>Suppose TraceTime is modified this way, the GC log in your example, starting from line 14, would become:</div><div><br></div><div><div>0.782: [GC 0.782: [ParNew: 17039K->1K(19136K), 0.0009367 secs] 55740K->38701K(83008K), 0.0009757 secs] [Times: user=0.00 sys=0.00, real=0.00 secs] </div>
<div>0.883: [CMS-concurrent-abortable-preclean: 0.001/0.146 secs] [Times: user=0.14 sys=0.01, real=0.15 secs] </div><div>0.867: [GC 0.867: [ParNew: 17025K->2110K(19136K), 0.0540174 secs] 55725K->48933K(83008K), 0.0541048 secs] [Times: user=0.08 sys=0.02, real=0.06 secs] </div>
<div><br></div><div>Notice that because the ParNew collection ended later than the abortable-preclean phase, its log comes after, but it started earlier so now the timestamp ordering now looks weird. If that's okay with everyone, it'd be an easy fix.</div>
<div><br></div><div>Regards,</div><div>Kris Mok</div><br><div class="gmail_quote">On Tue, Nov 8, 2011 at 5:49 AM, Charles K Pepperdine <span dir="ltr"><<a href="mailto:kirk@kodewerk.com">kirk@kodewerk.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex;"><div style="word-wrap:break-word">Hi all,<div><br></div><div>Line 15 of this log file has a ParNew record split by the end or an abortable-preclean. Is there a way to prevent the gc log records from being corrupted in this way? This is not the only place it happens and it makes an already impossible task of scanning these things much harder.</div>
<div><br></div><div>Regards,</div><div>Kirk</div><div><br><div><br><div>Begin forwarded message:</div><br><blockquote type="cite"><span style="border-collapse:separate;font-family:Helvetica;font-style:normal;font-variant:normal;font-weight:normal;letter-spacing:normal;line-height:normal;text-align:-webkit-auto;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px;font-size:medium"></span></blockquote>
</div></div></div><br><div style="word-wrap:break-word"><div><div><blockquote type="cite"><span style="border-collapse:separate;font-family:Helvetica;font-style:normal;font-variant:normal;font-weight:normal;letter-spacing:normal;line-height:normal;text-align:-webkit-auto;text-indent:0px;text-transform:none;white-space:normal;word-spacing:0px;font-size:medium"></span></blockquote>
</div><br></div></div><br></blockquote></div><br></div>