• Bug
  • Status: Open
  • 2 Major
  • Resolution:
  • eng group
  • Reporter: fuzy
  • May 14, 2008
  • 1
  • Watchers: 1
  • July 23, 2008

Description

The produced log file, due to a misconfigured application, needed more than 8GB after 2 hours (and would probably be even bigger). I think the reason is a class that is not instrumented within a object graph, which causes the whole object graph to be logged. However, this object graph did contain some *big* byte arrays that made the log file explode:

[SNIP] 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2344] = 0 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2345] = 0 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2346] = 1 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2347] = 7 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2348] = 2 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2349] = 3 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2350] = 6 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2351] = 3 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2352] = 6 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2353] = 0 2008-05-14 13:38:48,745 [btpool0-5] WARN com.terracottatech.dso.runtime - [2354] = 7 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2355] = 3 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2356] = 1 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2357] = 1 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2358] = 2 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2359] = 2 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2360] = 3 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2361] = 1 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2362] = 2 2008-05-14 13:38:48,746 [btpool0-5] WARN com.terracottatech.dso.runtime - [2363] = 2 [SNIP]

I doubt, that this behavior (which filled my disk and rendered my system useless) is desired. well, you could argue, that log files should be on a separate partition and I would totally agree. However, most of the information in the log is useless and extremely verbose (> 150 characters to display each byte in a byte array), so it would probably make sense to improve logging.

Comments

Stefan F 2008-05-14

JIRA removed all the white spaces from every log-line. see http://forums.terracotta.org/forums/posts/list/0/1055.page

Tim Eck 2008-05-14

yeah, we’re probably a bit verbose in this logging. I think maybe not printing every element of primitive arrays and only on a single log line could go a long way here. It’s a trade off of course, but I think we’ve erred providing too much detail here.

You can disable it if you’d like (it is on by default). More info here: http://www.terracotta.org/confluence/display/docs1/Configuration+Guide+and+Reference#ConfigurationGuideandReference-tc%3Atcconfig%2Fclients%2Fdso%2Fdebugging%2Fruntimelogg…

Your application should have been receiving TCNonPortableObjectErrors at this time too