我有以下程序。但是,在追踪生成的进程时,我会看到一条带有超时的跟踪消息,如以下跟踪中所示。Erlang - 调用io时接收超时消息:格式
start() ->
register(addone, spawn(addone, loop, [])).
loop() ->
receive
{request, Pid, Msg} ->
io:format("log ~n", []),
loop();
{stop, _Reason} ->
stop
end.
我执行这个过程具有以下功能:观察
run() ->
addone:start(),
dbg:start(),
dbg:tracer(),
dbg:p(whereis(addone), [c,m]),
dbg:tpl({'_','_','_'},[{'_',['true'],[{'silent', 'false'}]}]),
addone:request(4).
跟踪如下:
1> addone_scenarios:run().
log
(<0.32.0>) << {request,<0.30.0>,4}
(<0.32.0>) call io:format("log ~n",[])
(<0.32.0>) call io:default_output()
(<0.32.0>) call erlang:group_leader()
(<0.32.0>) call io:format(<0.23.0>,"log ~n",[])
(<0.32.0>) call io:o_request(<0.23.0>,{format,"log ~n",[]},format)
(<0.32.0>) call io:request(<0.23.0>,{format,"log ~n",[]})
(<0.32.0>) call io:io_request(<0.23.0>,{format,"log ~n",[]})
(<0.32.0>) call io:bc_req(<0.23.0>,{put_chars,unicode,io_lib,format,["log ~n",[]]},false)
(<0.32.0>) call net_kernel:dflag_unicode_io(<0.23.0>)
(<0.32.0>) call io:execute_request(<0.23.0>,{false,{put_chars,unicode,io_lib,format,["log ~n",[]]}})
(<0.32.0>) call erlang:monitor(process,<0.23.0>)
(<0.32.0>) <0.23.0> ! {io_request,<0.32.0>,<0.23.0>,
{put_chars,unicode,io_lib,format,["log ~n",[]]}}
(<0.32.0>) call io:wait_io_mon_reply(<0.23.0>,#Ref<0.0.0.29>)
(<0.32.0>) << {io_reply,<0.23.0>,ok}
(<0.32.0>) call erlang:demonitor(#Ref<0.0.0.29>)
(<0.32.0>) << timeout
(<0.32.0>) call addone:loop()
什么奇怪的是,收到超时跟踪消息。当我删除io:format(...)
时,未收到此消息。有人可以指出什么是可能的原因吗?
编辑:我已更新跟踪以包含所有功能的调用,也许它可能有所帮助。
我忽略这个跟踪消息的问题是,我正在构建一个工具来分析程序的痕迹,并根据它收到的内容采取行动..所以我不能选择哪些超时消息我可以忽略,哪些不是不幸的 – aseychell 2012-02-14 18:09:38