Trace plugins fail with badarg
System: Ubuntu 12.10 64 bits with Eclipse 3.8, erlide release and Erlang R16B.
I am trying to make the tracing plugin works. I have a very simple module called dummy.erl that loops over a function for a long time with a sleep of on second. I am trying to get some traces but the plugins fail with the error:
Error
{badrpc,{'EXIT',{badarg,[{ttbe,stop_return,2,[]},{ttb_integration,stop,0,[]},{rpc,'-handle_call_call/6-fun-0-',5,[{file,"rpc.erl"},{line,205}]}]}}}
Maybe I am doing something wrong, here is what I am doing:
- Configure the erlang application:
- module: dummy
- function: paf
- node name: [email protected] (long name)
- cookie: dummy
- Start the application
- In the Erlang tracing control panel:
- Click "Add existing Nodes"
- Select [email protected]
- Set the cookie to dummy
- Select call in the "Process" tab
- Add a pattern
- Select "Enabled", "Local"
- Set the module name to dummy
- Click "Start Tracing"
- Wait for some time (Noting happen in any views)
- Click "Stop Tracing"
Console log when starting the application:
20:02:24,992 F: (ErlangLaunchDelegate.java:90) : doLaunch runtime r16b
20:02:24,992 F: (ErlangLaunchDelegate.java:91) : doLaunch cookie dummy (dummy)
20:02:24,993 I: (RuntimeData.java:307) : Data:: org.erlide.backend.BackendData
20:02:24,993 I: (RuntimeData.java:316) : beamLocator : org.erlide.model.BeamLocator@6dd81095
20:02:24,993 I: (RuntimeData.java:316) : launch : org.eclipse.debug.core.Launch@2b47ac1e
20:02:24,993 I: (RuntimeData.java:316) : projects : [P/test]
20:02:24,994 I: (RuntimeData.java:316) : cookie : dummy
20:02:24,994 I: (RuntimeData.java:316) : managed : true
20:02:24,994 I: (RuntimeData.java:316) : restartable : false
20:02:24,995 I: (RuntimeData.java:316) : startShell : true
20:02:24,995 I: (RuntimeData.java:316) : console : true
20:02:24,995 I: (RuntimeData.java:316) : interpretedModules : [test:dummy.erl]
20:02:24,995 I: (RuntimeData.java:316) : nodeName : dummy
20:02:24,996 I: (RuntimeData.java:316) : longName : true
20:02:24,996 I: (RuntimeData.java:316) : extraArgs :
20:02:24,996 I: (RuntimeData.java:316) : workingDir : .
20:02:24,996 I: (RuntimeData.java:316) : env : {}
20:02:24,997 I: (RuntimeData.java:316) : initialCall : dummy:paf
20:02:24,997 I: (RuntimeData.java:316) : debugFlags : [DISTRIBUTED_DEBUG, ATTACH_ON_BREAKPOINT]
20:02:24,997 I: (RuntimeData.java:316) : loadOnAllNodes : true
20:02:24,998 I: (RuntimeData.java:316) : internal : false
20:02:25,000 I: (RuntimeData.java:316) : runtimeInfo : Runtime
20:02:25,001 I: (RuntimeData.java:316) : debug : false
20:02:25,001 I: (RuntimeData.java:316) : reportErrors : false
20:02:25,001 I: (RuntimeData.java:326) : ---------------
20:02:25,001 F: (ErlangLaunchDelegate.java:164) : START node :> [/usr/local/otp/r16b/bin/erl, -name, [email protected], -setcookie, dummy] *** /opt
20:02:25,002 F: (ErlangLaunchDelegate.java:183) : process is running
20:02:25,005 F: (ErlangLaunchDelegate.java:143) : Started erts: dummy >> dummy
20:02:25,005 F: (BackendManager.java:134) : create execution backend dummy
20:02:25,005 F: (BackendFactory.java:81) : Create backend dummy
20:02:25,007 F: (ErlRuntime.java:383) : using cookie 'dummy...'5 (info: 'dummy')
20:02:25,007 F: (ErlRuntime.java:468) : [email protected]: waiting connection to peer...
20:02:25,110 F: (ErlRuntime.java:164) : # [email protected] Worker-6
20:02:25,117 F: (ErlRuntime.java:103) : Node [email protected] is up
20:02:25,117 F: (ErlRuntime.java:164) : # [email protected] Worker-6
20:02:25,330 F: (ErlRuntime.java:555) : code server started
20:02:25,330 F: (ErlRuntime.java:474) : connected!
20:02:25,339 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.test_support_0.20.2.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,348 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.erlang_0.2.8.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,354 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.ide_0.20.2.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,360 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.ttbe_0.1.6.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,366 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.builder_0.20.1.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,370 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.cover.erlang_0.2.4.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,376 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/ebin to code path for @302212330:: Runtime
20:02:25,381 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/app to code path for @302212330:: Runtime
20:02:25,387 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.debugger_0.20.1.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,395 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.common_0.20.1.201304230851/ebin to code path for @302212330:: Runtime
20:02:25,395 F: (Backend.java:180) : initialize [email protected]: true
20:02:25,408 F: (LogEventHandler.java:25) : info: {"Start monitor process: ",10000000,50000000}
20:02:25,413 F: (Backend.java:281) : backend [email protected]: add path /home/sylane/workspace/test/ebin
20:02:25,422 F: (Backend.java:407) : calling startup function dummy:paf
20:02:25,422 F: (ErlConsoleManager.java:42) : console ADDED to org.erlide.backend.BackendData@465466c3
20:02:26,522 F: (BackendFactory.java:72) : Create build backend R16
20:02:26,522 F: (BackendFactory.java:81) : Create backend R16_c3a79_sylane_f4f15a
20:02:26,523 F: (ErlangLaunchDelegate.java:90) : doLaunch runtime r16b
20:02:26,524 F: (ErlangLaunchDelegate.java:91) : doLaunch cookie erlide (erlide)
20:02:26,524 I: (RuntimeData.java:307) : Data:: org.erlide.backend.BackendData
20:02:26,524 I: (RuntimeData.java:316) : beamLocator : org.erlide.model.BeamLocator@57498098
20:02:26,525 I: (RuntimeData.java:316) : launch : org.eclipse.debug.core.Launch@1a99a7ed
20:02:26,525 I: (RuntimeData.java:316) : projects : []
20:02:26,525 I: (RuntimeData.java:316) : cookie : erlide
20:02:26,525 I: (RuntimeData.java:316) : managed : true
20:02:26,526 I: (RuntimeData.java:316) : restartable : false
20:02:26,526 I: (RuntimeData.java:316) : startShell : true
20:02:26,526 I: (RuntimeData.java:316) : console : true
20:02:26,526 I: (RuntimeData.java:316) : interpretedModules : []
20:02:26,527 I: (RuntimeData.java:316) : nodeName : R16_c3a79_sylane_f4f15a
20:02:26,527 I: (RuntimeData.java:316) : longName : true
20:02:26,527 I: (RuntimeData.java:316) : extraArgs :
20:02:26,527 I: (RuntimeData.java:316) : workingDir : .
20:02:26,528 I: (RuntimeData.java:316) : env : {}
20:02:26,528 I: (RuntimeData.java:316) : initialCall :
20:02:26,528 I: (RuntimeData.java:316) : debugFlags : [ATTACH_ON_BREAKPOINT]
20:02:26,529 I: (RuntimeData.java:316) : loadOnAllNodes : false
20:02:26,529 I: (RuntimeData.java:316) : internal : true
20:02:26,530 I: (RuntimeData.java:316) : runtimeInfo : Runtime
20:02:26,531 I: (RuntimeData.java:316) : debug : false
20:02:26,531 I: (RuntimeData.java:316) : reportErrors : false
20:02:26,531 I: (RuntimeData.java:326) : ---------------
20:02:26,531 F: (ErlangLaunchDelegate.java:164) : START node :> [/usr/local/otp/r16b/bin/erl, -name, [email protected], -setcookie, erlide] *** /opt
20:02:26,533 F: (ErlangLaunchDelegate.java:183) : process is running
20:02:26,534 F: (ErtsProcess.java:27) : # create ErtsProcess: R16_c3a79_sylane_f4f15a
20:02:26,534 F: (ErlangLaunchDelegate.java:143) : Started erts: R16_c3a79_sylane_f4f15a >> R16_c3a79_sylane_f4f15a
20:02:26,536 F: (ErlRuntime.java:383) : using cookie 'erlide...'6 (info: 'erlide')
20:02:26,537 F: (ErlRuntime.java:468) : [email protected]: waiting connection to peer...
20:02:26,637 F: (ErlRuntime.java:164) : # [email protected] Text Viewer Hover Presenter
20:02:27,039 F: (ErlRuntime.java:164) : # [email protected] Text Viewer Hover Presenter
20:02:27,043 F: (ErlRuntime.java:103) : Node [email protected] is up
20:02:27,043 F: (ErlRuntime.java:164) : # [email protected] Text Viewer Hover Presenter
20:02:27,245 F: (ErlRuntime.java:555) : code server started
20:02:27,245 F: (ErlRuntime.java:474) : connected!
20:02:27,251 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.test_support_0.20.2.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,257 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.erlang_0.2.8.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,262 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.ide_0.20.2.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,266 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.ttbe_0.1.6.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,270 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.builder_0.20.1.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,274 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.cover.erlang_0.2.4.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,279 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/ebin to code path for @1820095640:: Runtime
20:02:27,287 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/app to code path for @1820095640:: Runtime
20:02:27,293 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.debugger_0.20.1.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,302 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.common_0.20.1.201304230851/ebin to code path for @1820095640:: Runtime
20:02:27,303 F: (Backend.java:180) : initialize [email protected]: true
20:02:27,311 F: (LogEventHandler.java:25) : info: {"Start monitor process: ",10000000,50000000}
Console log when starting the tracer:
20:03:20,702 F: (BackendManager.java:134) : create execution backend tracing
20:03:20,703 F: (BackendFactory.java:81) : Create backend tracing
20:03:20,704 F: (ErlangLaunchDelegate.java:90) : doLaunch runtime r16b
20:03:20,704 F: (ErlangLaunchDelegate.java:91) : doLaunch cookie erlide (erlide)
20:03:20,704 I: (RuntimeData.java:307) : Data:: org.erlide.backend.BackendData
20:03:20,705 I: (RuntimeData.java:316) : beamLocator : org.erlide.model.BeamLocator@176f61bb
20:03:20,705 I: (RuntimeData.java:316) : launch : org.eclipse.debug.core.Launch@11794802
20:03:20,705 I: (RuntimeData.java:316) : projects : []
20:03:20,705 I: (RuntimeData.java:316) : cookie : erlide
20:03:20,706 I: (RuntimeData.java:316) : managed : true
20:03:20,706 I: (RuntimeData.java:316) : restartable : false
20:03:20,706 I: (RuntimeData.java:316) : startShell : true
20:03:20,706 I: (RuntimeData.java:316) : console : true
20:03:20,707 I: (RuntimeData.java:316) : interpretedModules : []
20:03:20,707 I: (RuntimeData.java:316) : nodeName : tracing
20:03:20,707 I: (RuntimeData.java:316) : longName : true
20:03:20,708 I: (RuntimeData.java:316) : extraArgs :
20:03:20,708 I: (RuntimeData.java:316) : workingDir : .
20:03:20,708 I: (RuntimeData.java:316) : env : {}
20:03:20,708 I: (RuntimeData.java:316) : initialCall :
20:03:20,709 I: (RuntimeData.java:316) : debugFlags : [ATTACH_ON_BREAKPOINT]
20:03:20,709 I: (RuntimeData.java:316) : loadOnAllNodes : false
20:03:20,709 I: (RuntimeData.java:316) : internal : false
20:03:20,712 I: (RuntimeData.java:316) : runtimeInfo : Runtime
20:03:20,713 I: (RuntimeData.java:316) : debug : false
20:03:20,713 I: (RuntimeData.java:316) : reportErrors : false
20:03:20,713 I: (RuntimeData.java:326) : ---------------
20:03:20,713 F: (ErlangLaunchDelegate.java:164) : START node :> [/usr/local/otp/r16b/bin/erl, -name, [email protected], -setcookie, erlide] *** /opt
20:03:20,715 F: (ErlangLaunchDelegate.java:183) : process is running
20:03:20,716 F: (ErtsProcess.java:27) : # create ErtsProcess: tracing
20:03:20,717 F: (ErlangLaunchDelegate.java:143) : Started erts: tracing >> tracing
20:03:20,718 F: (ErlRuntime.java:383) : using cookie 'erlide...'6 (info: 'erlide')
20:03:20,719 F: (ErlRuntime.java:468) : [email protected]: waiting connection to peer...
20:03:20,820 F: (ErlRuntime.java:164) : # [email protected] ModalContext
20:03:20,826 F: (ErlRuntime.java:103) : Node [email protected] is up
20:03:20,826 F: (ErlRuntime.java:164) : # [email protected] ModalContext
20:03:21,046 F: (ErlRuntime.java:555) : code server started
20:03:21,047 F: (ErlRuntime.java:474) : connected!
20:03:21,053 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.test_support_0.20.2.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,065 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.erlang_0.2.8.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,070 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.ide_0.20.2.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,075 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.tracing.ttbe_0.1.6.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,080 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.builder_0.20.1.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,085 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.cover.erlang_0.2.4.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,095 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/ebin to code path for @387837533:: Runtime
20:03:21,100 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.wrangler.core_0.9.9.201304230851/wrangler/app to code path for @387837533:: Runtime
20:03:21,105 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.debugger_0.20.1.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,112 F: (CodeManager.java:223) : adding /opt/eclipse/plugins/org.erlide.kernel.common_0.20.1.201304230851/ebin to code path for @387837533:: Runtime
20:03:21,113 F: (Backend.java:180) : initialize [email protected]: true
Console log when stopping the tracer:
20:04:25,907 F: (LogEventHandler.java:25) : info: no answer from ttbe:stop
20:04:25,907 S: (TraceBackend.java:308) : Could not stop tracing tool: {badrpc,{'EXIT',{badarg,[{ttbe,stop_return,2,[]},{ttb_integration,stop,0,[]},{rpc,'-handle_call_call/6-fun-0-',5,[{file,"rpc.erl"},{line,205}]}]}}}
I got exactly the same problem when running an external node.
Thanks for the report.
The tracing plugin needs some love, we didn't have enough users for it to get feedback and other things got higher priority.
https://erlide-tools.assembla.com/spaces/erlide/tickets/1217