<div>
Hi All,
</div><div><br></div><div>Having a strange one with some lager logging, and hopping someone might have seen it before… In the last couple of days I've spotted a few crashes in my logs that I've not seen before. In my console log, I get:</div><div><br></div><div><snip></div><div><div><font face="Courier New" style="font-size: 12px;">2013-01-17 14:56:44.712 [error] <0.46.0> gen_server lager_crash_log terminated with reason: bad argument in call to lager_trunc_io:format("FORMAT ERROR: ~p ~p", ["** Generic server ~p terminating \</font></div><div><font face="Courier New" style="font-size: 12px;">\n** Last message in was ~p~n** When Server state == ~p~n** R...",...]) line 66 in lager_crash_log:do_log/2 line 189</font></div></div><div><font face="Courier New" style="font-size: 12px;"><br></font></div><div><div><font face="Courier New" style="font-size: 12px;">2013-01-17 14:56:44.820 [error] <0.46.0> CRASH REPORT Process lager_crash_log with 0 neighbours exited with reason: bad argument in call to lager_trunc_io:format("FORMAT ERROR: ~p ~p", ["** Generi\</font></div><div><font face="Courier New" style="font-size: 12px;">c server ~p terminating \n** Last message in was ~p~n** When Server state == ~p~n** R...",...]) line 66 in lager_crash_log:do_log/2 line 189 in gen_server:terminate/6 line 747</font></div><div><font face="Courier New" style="font-size: 12px;">2013-01-17 14:56:45.079 [error] <0.43.0> Supervisor lager_sup had child lager_crash_log started with lager_crash_log:start_link("log/crash.log", 65536, 65536, [{hour,0}], 5) at <0.46.0> exit with \</font></div><div><font face="Courier New" style="font-size: 12px;">reason bad argument in call to lager_trunc_io:format("FORMAT ERROR: ~p ~p", ["** Generic server ~p terminating \n** Last message in was ~p~n** When Server state == ~p~n** R...",...]) line 66 in la\</font></div><div><font face="Courier New" style="font-size: 12px;">ger_crash_log:do_log/2 line 189 in context child_terminated</font></div></div><div></snip></div><div><br></div><div>with a corresponding crash report in the crash log:</div><div><br></div><div><snip/></div><div><div><font face="Courier New" style="font-size: 12px;">013-01-17 14:56:45 =CRASH REPORT====</font></div><div><font face="Courier New" style="font-size: 12px;"> crasher:</font></div><div><font face="Courier New" style="font-size: 12px;"> initial call: lager_crash_log:init/1</font></div><div><font face="Courier New" style="font-size: 12px;"> pid: <0.2189.47></font></div><div><font face="Courier New" style="font-size: 12px;"> registered_name: lager_crash_log</font></div><div><font face="Courier New" style="font-size: 12px;"> exception exit: {{function_clause,[{lager_trunc_io,alist,[{<0.390.0>,left},64003,{print_options,-1,true,false}],[{file,"src/lager_trunc_io.erl"},{line,367}]},{lager_trunc_io,alist,3,[{file,"sr\</font></div><div><font face="Courier New" style="font-size: 12px;">c/lager_trunc_io.erl"},{line,382}]},{lager_trunc_io,alist_start,3,[{file,"src/lager_trunc_io.erl"},{line,355}]},{lager_trunc_io,list_body,4,[{file,"src/lager_trunc_io.erl"},{line,299}]},{lager_tru\</font></div><div><font face="Courier New" style="font-size: 12px;">nc_io,alist_start,3,[{file,"src/lager_trunc_io.erl"},{line,364}]},{lager_trunc_io,list_bodyc,4,[{file,"src/lager_trunc_io.erl"},{line,311}]},{lager_trunc_io,list_bodyc,4,[{file,"src/lager_trunc_io\</font></div><div><font face="Courier New" style="font-size: 12px;">.erl"},{line,312}]},{lager_trunc_io,list_body,4,[{file,"src/lager_trunc_io.erl"},{line,300}]}]},[{gen_server,terminate,6,[{file,"gen_server.erl"},{line,747}]},{proc_lib,init_p_do_apply,3,[{file,"p\</font></div><div><font face="Courier New" style="font-size: 12px;">roc_lib.erl"},{line,227}]}]}</font></div><div><font face="Courier New" style="font-size: 12px;"> ancestors: [lager_sup,<0.41.0>]</font></div><div><font face="Courier New" style="font-size: 12px;"> messages: []</font></div><div><font face="Courier New" style="font-size: 12px;"> links: [<0.43.0>,#Port<0.6132>]</font></div><div><font face="Courier New" style="font-size: 12px;"> dictionary: []</font></div><div><font face="Courier New" style="font-size: 12px;"> trap_exit: false</font></div><div><font face="Courier New" style="font-size: 12px;"> status: running</font></div><div><font face="Courier New" style="font-size: 12px;"> heap_size: 2584</font></div><div><font face="Courier New" style="font-size: 12px;"> stack_size: 24</font></div><div><font face="Courier New" style="font-size: 12px;"> reductions: 3739</font></div><div><font face="Courier New" style="font-size: 12px;"> neighbours:</font></div><div><font face="Courier New" style="font-size: 12px;">2013-01-17 14:56:46 =SUPERVISOR REPORT====</font></div><div><font face="Courier New" style="font-size: 12px;"> Supervisor: {local,lager_sup}</font></div><div><font face="Courier New" style="font-size: 12px;"> Context: child_terminated</font></div><div><font face="Courier New" style="font-size: 12px;"> Reason: {function_clause,[{lager_trunc_io,alist,[{<0.390.0>,left},64003,{print_options,-1,true,false}],[{file,"src/lager_trunc_io.erl"},{line,367}]},{lager_trunc_io,alist,3,[{file,"src/la\</font></div><div><font face="Courier New" style="font-size: 12px;">ger_trunc_io.erl"},{line,382}]},{lager_trunc_io,alist_start,3,[{file,"src/lager_trunc_io.erl"},{line,355}]},{lager_trunc_io,list_body,4,[{file,"src/lager_trunc_io.erl"},{line,299}]},{lager_trunc_i\</font></div><div><font face="Courier New" style="font-size: 12px;">o,alist_start,3,[{file,"src/lager_trunc_io.erl"},{line,364}]},{lager_trunc_io,list_bodyc,4,[{file,"src/lager_trunc_io.erl"},{line,311}]},{lager_trunc_io,list_bodyc,4,[{file,"src/lager_trunc_io.erl\</font></div><div><font face="Courier New" style="font-size: 12px;">"},{line,312}]},{lager_trunc_io,list_body,4,[{file,"src/lager_trunc_io.erl"},{line,300}]}]}</font></div><div><font face="Courier New" style="font-size: 12px;"> Offender: [{pid,<0.2189.47>},{name,lager_crash_log},{mfargs,{lager_crash_log,start_link,["log/crash.log",65536,65536,[{hour,0}],5]}},{restart_type,permanent},{shutdown,5000},{child_type,wor\</font></div><div><font face="Courier New" style="font-size: 12px;">ker}]</font></div></div>
<div><div></snip></div><div><br></div><div>The lager activity is, I think, due to one of my gen_servers crashing, but I've never seen lager exhibit this behaviour before. This is lager v1.2.1. Anyone seen this behaviour before? Any pointers as to how to track down the root cause?</div><div><br></div><div>Cheers,</div><div><br></div><div>Steve</div><div><br></div><div><br></div><div>-- </div><div>Steve Strong</div><div>Sent with <a href="http://www.sparrowmailapp.com/?sig">Sparrow</a></div><div><br></div></div>