> How does the mouse move trigger the sequence?
Sorry, I should have covered that before. This is a hover test, so I
use test_setmouse followed by:
feedkeys("\<MouseMove>\<Ignore>", "xt")
It's then the balloonexpr function that triggers the ch_evalexpr in
point 1 above.
I've attached the channel log file - that's probably more useful than
me attaching snippets.
You'll see that govim calls into Vim to schedule work (s:schedule
call); when it is safe to run that work, Vim calls back to govim
("schedule"). All of the "s:schedule" calls (with their respective ID)
are matched by "schedule" calls, apart from the last one:
0.700121 RECV on 0(sock): '[0,[47,"call","s:schedule",4]]
which is why we see things lock up.
Thanks
> It's when returning from
> this that SafeStateAgain should be triggered. But that currently only
> happens when checking channels for messages. That should be
> encountered, since you have channels, but perhaps the safe flag got
> reset without anything causing Vim to return to the main loop?
>
> Let me add some log statements so you can see what happens to the state.
--
--
You received this message from the "vim_dev" maillist.
Do not top-post! Type your reply below the text you are replying to.
For more information, visit http://www.vim.org/maillist.php
---
You received this message because you are subscribed to the Google Groups
"vim_dev" group.
To unsubscribe from this group and stop receiving emails from it, send an email
to [email protected].
To view this discussion on the web visit
https://groups.google.com/d/msgid/vim_dev/CACoUkn7%2BvD_rAZGhJ0YK6rtJWMAziCVdRGb-RLM8PbXCzEM9ag%40mail.gmail.com.
==== start log session ====
0.000011 : /tmp/go-test-script340064514/script-hover
0.000381 on 0: Created channel
0.003725 on 0: Connecting to 127.0.0.1 port 33637
0.003822 on 0: Waiting for connection (waiting 1 msec)...
0.003838 on 0: Connection made
0.004985 RECV on 0(sock): '[0,[1,"loaded"]]
'
0.005311 : Start triggering SafeState
0.005482 : looking for messages on channels
0.005499 on 0: Getting JSON message 0
0.005504 on 0: Invoking channel callback <SNR>17_define
0.005604 SEND on 0(sock): '[1,["callback",1,[""]]]
'
0.005640 : Leaving unsafe area, triggering SafeStateAgain
0.009821 RECV on 0(sock): '[0,[2,"expr","{\"VersionLong\":
exists(\"v:versionlong\")?v:versionlong:-1, \"GuiRunning\":
has(\"gui_running\")}"]]
'
0.009827 : looking for messages on channels
0.009854 on 0: Getting JSON message 0
0.009861 on 0: Invoking channel callback <SNR>17_define
0.010013 SEND on 0(sock):
'[2,["callback",2,["",{"VersionLong":8012051,"GuiRunning":0}]]]
'
0.010071 : Leaving unsafe area, triggering SafeStateAgain
0.010579 RECV on 0(sock): '[0,[3,"ex","augroup govim"]]
'
0.010584 : looking for messages on channels
0.010603 on 0: Getting JSON message 0
0.010615 on 0: Invoking channel callback <SNR>17_define
0.010927 SEND on 0(sock): '[3,["callback",3,[""]]]
'
0.010971 : Leaving unsafe area, triggering SafeStateAgain
0.011251 RECV on 0(sock): '[0,[4,"ex","augroup END"]]
'
0.011255 : looking for messages on channels
0.011279 on 0: Getting JSON message 0
0.011287 on 0: Invoking channel callback <SNR>17_define
0.011397 SEND on 0(sock): '[4,["callback",4,[""]]]
'
0.011436 : Leaving unsafe area, triggering SafeStateAgain
0.011731 RECV on 0(sock): '[0,[5,"function","GOVIM_internal_BalloonExpr",[]]]
'
0.011735 : looking for messages on channels
0.011753 on 0: Getting JSON message 0
0.011759 on 0: Invoking channel callback <SNR>17_define
0.012161 SEND on 0(sock): '[5,["callback",5,[""]]]
'
0.012529 : Leaving unsafe area, triggering SafeStateAgain
0.012559 RECV on 0(sock): '[0,[6,"autocmd","autocommand:0"," govim
BufNewFile,BufRead *.go",["{\"Num\": eval(expand('\u003cabuf\u003e')),
\"Name\": fnamemodify(bufname(eval(expand('\u003cabuf\u003e'))),':p'),
\"Contents\": join(getbufline(eval(expand('\u003cabuf\u003e')), 0, \"$\"),
\"\\n\").\"\\n\"}"]]]
'
0.012562 : looking for messages on channels
0.012600 on 0: Getting JSON message 0
0.012611 on 0: Invoking channel callback <SNR>17_define
0.013080 SEND on 0(sock): '[6,["callback",6,[""]]]
'
0.013481 : Leaving unsafe area, triggering SafeStateAgain
0.013512 RECV on 0(sock): '[0,[7,"autocmd","autocommand:1"," govim
BufWritePre *.go",["eval(expand('\u003cabuf\u003e'))"]]]
'
0.013515 : looking for messages on channels
0.013545 on 0: Getting JSON message 0
0.013556 on 0: Invoking channel callback <SNR>17_define
0.013728 SEND on 0(sock): '[7,["callback",7,[""]]]
'
0.014040 : Leaving unsafe area, triggering SafeStateAgain
0.014075 RECV on 0(sock):
'[0,[8,"function","GOVIM_internal_Complete",["findarg","base"]]]
'
0.014078 : looking for messages on channels
0.014340 on 0: Getting JSON message 0
0.014353 on 0: Invoking channel callback <SNR>17_define
0.014572 SEND on 0(sock): '[8,["callback",8,[""]]]
'
0.014618 : Leaving unsafe area, triggering SafeStateAgain
0.014949 RECV on 0(sock):
'[0,[9,"command","GOVIMGoToDef",{"nargs":"-nargs=?"}]]
'
0.014953 : looking for messages on channels
0.014974 on 0: Getting JSON message 0
0.014981 on 0: Invoking channel callback <SNR>17_define
0.015178 SEND on 0(sock): '[9,["callback",9,[""]]]
'
0.015215 : Leaving unsafe area, triggering SafeStateAgain
0.015536 RECV on 0(sock):
'[0,[10,"command","GOVIMGoToPrevDef",{"count":"-count=1","nargs":"-nargs=?"}]]
'
0.015540 : looking for messages on channels
0.015565 on 0: Getting JSON message 0
0.015571 on 0: Invoking channel callback <SNR>17_define
0.015788 SEND on 0(sock): '[10,["callback",10,[""]]]
'
0.015832 : Leaving unsafe area, triggering SafeStateAgain
0.016151 RECV on 0(sock): '[0,[11,"function","GOVIMHover",[]]]
'
0.016156 : looking for messages on channels
0.016176 on 0: Getting JSON message 0
0.016182 on 0: Invoking channel callback <SNR>17_define
0.016352 SEND on 0(sock): '[11,["callback",11,[""]]]
'
0.016394 : Leaving unsafe area, triggering SafeStateAgain
0.017093 RECV on 0(sock): '[0,[12,"autocmd","autocommand:2"," govim BufDelete
*.go",["eval(expand('\u003cabuf\u003e'))"]]]
'
0.017097 : looking for messages on channels
0.017138 on 0: Getting JSON message 0
0.017167 on 0: Invoking channel callback <SNR>17_define
0.017331 SEND on 0(sock): '[12,["callback",12,[""]]]
'
0.017370 : Leaving unsafe area, triggering SafeStateAgain
0.020774 RECV on 0(sock): '[0,[13,"command","GOVIMGoFmt",{}]]
'
0.020778 : looking for messages on channels
0.020799 on 0: Getting JSON message 0
0.020804 on 0: Invoking channel callback <SNR>17_define
0.021001 SEND on 0(sock): '[13,["callback",13,[""]]]
'
0.021043 : Leaving unsafe area, triggering SafeStateAgain
0.021396 RECV on 0(sock): '[0,[14,"command","GOVIMGoImports",{}]]
'
0.021400 : looking for messages on channels
0.021419 on 0: Getting JSON message 0
0.021424 on 0: Invoking channel callback <SNR>17_define
0.021632 SEND on 0(sock): '[14,["callback",14,[""]]]
'
0.021676 : Leaving unsafe area, triggering SafeStateAgain
0.022186 RECV on 0(sock): '[0,[15,"command","GOVIMQuickfixDiagnostics",{}]]
'
0.022190 : looking for messages on channels
0.022211 on 0: Getting JSON message 0
0.022217 on 0: Invoking channel callback <SNR>17_define
0.022416 SEND on 0(sock): '[15,["callback",15,[""]]]
'
0.022460 : Leaving unsafe area, triggering SafeStateAgain
0.023064 RECV on 0(sock):
'[0,[16,"function","GOVIM_internal_BufChanged",["bufnr","start","end","added","changes"]]]
'
0.023068 : looking for messages on channels
0.023087 on 0: Getting JSON message 0
0.023093 on 0: Invoking channel callback <SNR>17_define
0.023309 SEND on 0(sock): '[16,["callback",16,[""]]]
'
0.023639 : Leaving unsafe area, triggering SafeStateAgain
0.023662 RECV on 0(sock):
'[0,[17,"function","GOVIM_internal_SetConfig",["config"]]]
'
0.023664 : looking for messages on channels
0.023686 on 0: Getting JSON message 0
0.023702 on 0: Invoking channel callback <SNR>17_define
0.023890 SEND on 0(sock): '[17,["callback",17,[""]]]
'
0.023945 : Leaving unsafe area, triggering SafeStateAgain
0.026574 RECV on 0(sock): '[0,[18,"ex","call
govim#config#Set(\"_internal_Func\", function(\"GOVIM_internal_SetConfig\"))"]]
'
0.026579 : looking for messages on channels
0.026605 on 0: Getting JSON message 0
0.026611 on 0: Invoking channel callback <SNR>17_define
0.027113 SEND on 0(sock):
'[18,["function","function:GOVIM_internal_SetConfig",[{"FormatOnSave":"goimports"}]]]
'
0.027147 on 0: Blocking read JSON for id 18
0.027184 : looking for messages on channels
0.027197 on 0: Waiting for up to 30000 msec
0.033826 RECV on 0(sock): '[18,["",null]]
'
0.033836 on 0: Getting JSON message 18
0.033859 on 0: Received JSON for id 18
0.033943 SEND on 0(sock): '[19,["callback",18,[""]]]
'
0.033989 : Leaving unsafe area, triggering SafeStateAgain
0.035600 RECV on 0(sock):
'[0,[19,"function","GOVIM_internal_SetUserBusy",["isBusy"]]]
'
0.035605 : looking for messages on channels
0.035630 on 0: Getting JSON message 0
0.035636 on 0: Invoking channel callback <SNR>17_define
0.036073 SEND on 0(sock): '[20,["callback",19,[""]]]
'
0.036110 : Leaving unsafe area, triggering SafeStateAgain
0.036207 RECV on 0(sock): '[0,[20,"command","GOVIMReferences",{}]]
'
0.036216 : looking for messages on channels
0.036234 on 0: Getting JSON message 0
0.036240 on 0: Invoking channel callback <SNR>17_define
0.036624 SEND on 0(sock): '[21,["callback",20,[""]]]
'
0.036931 : Leaving unsafe area, triggering SafeStateAgain
0.036955 RECV on 0(sock):
'[0,[21,"command","GOVIMRename",{"nargs":"-nargs=?"}]]
'
0.036958 : looking for messages on channels
0.037262 on 0: Getting JSON message 0
0.037277 on 0: Invoking channel callback <SNR>17_define
0.037790 SEND on 0(sock): '[22,["callback",21,[""]]]
'
0.038158 : Leaving unsafe area, triggering SafeStateAgain
0.038193 RECV on 0(sock):
'[0,[22,"command","GOVIMStringFn",{"complete":"-complete=customlist,GOVIM_internal_StringFnComplete","nargs":"-nargs=+","range":"-range"}]]
'
0.038250 : looking for messages on channels
0.038275 on 0: Getting JSON message 0
0.038289 on 0: Invoking channel callback <SNR>17_define
0.038554 SEND on 0(sock): '[23,["callback",22,[""]]]
'
0.038601 : Leaving unsafe area, triggering SafeStateAgain
0.038986 RECV on 0(sock):
'[0,[23,"function","GOVIM_internal_StringFnComplete",["ArgLead","CmdLine","CursorPos"]]]
'
0.038994 : looking for messages on channels
0.039056 on 0: Getting JSON message 0
0.039069 on 0: Invoking channel callback <SNR>17_define
0.039263 SEND on 0(sock): '[24,["callback",23,[""]]]
'
0.039310 : Leaving unsafe area, triggering SafeStateAgain
0.039939 RECV on 0(sock):
'[0,[24,"call","sign_define","govimerr",{"text":"\u003e\u003e","texthl":"Error"}]]
'
0.039944 : looking for messages on channels
0.039966 on 0: Getting JSON message 0
0.039972 on 0: Invoking channel callback <SNR>17_define
0.040222 SEND on 0(sock): '[25,["callback",24,["",0]]]
'
0.040585 : Leaving unsafe area, triggering SafeStateAgain
0.040608 RECV on 0(sock):
'[0,[25,"function","GOVIMMotion",["direction","target"]]]
'
0.040610 : looking for messages on channels
0.040622 on 0: Getting JSON message 0
0.040688 on 0: Invoking channel callback <SNR>17_define
0.040856 SEND on 0(sock): '[26,["callback",25,[""]]]
'
0.040884 : Leaving unsafe area, triggering SafeStateAgain
0.041190 RECV on 0(sock): '[0,[26,"function","GOVIMHello",[]]]
'
0.041193 : looking for messages on channels
0.041225 on 0: Getting JSON message 0
0.041231 on 0: Invoking channel callback <SNR>17_define
0.041331 SEND on 0(sock): '[27,["callback",26,[""]]]
'
0.041363 : Leaving unsafe area, triggering SafeStateAgain
0.043236 RECV on 0(sock):
'[0,[27,"command","GOVIMHello",{"nargs":"-nargs=?"}]]
'
0.043242 : looking for messages on channels
0.043276 on 0: Getting JSON message 0
0.043283 on 0: Invoking channel callback <SNR>17_define
0.043507 SEND on 0(sock): '[28,["callback",27,[""]]]
'
0.043592 : Leaving unsafe area, triggering SafeStateAgain
0.043755 RECV on 0(sock): '[0,[28,"function","GOVIM_internal_DumpPopups",[]]]
'
0.043761 : looking for messages on channels
0.043782 on 0: Getting JSON message 0
0.043787 on 0: Invoking channel callback <SNR>17_define
0.043949 SEND on 0(sock): '[29,["callback",28,[""]]]
'
0.044002 : Leaving unsafe area, triggering SafeStateAgain
0.044234 RECV on 0(sock):
'[0,[29,"function","GOVIM_internal_ShowMessagePopup",[]]]
'
0.044246 : looking for messages on channels
0.044288 on 0: Getting JSON message 0
0.044297 on 0: Invoking channel callback <SNR>17_define
0.044469 SEND on 0(sock): '[30,["callback",29,[""]]]
'
0.044515 : Leaving unsafe area, triggering SafeStateAgain
0.044719 RECV on 0(sock): '[0,[30,"function","GOVIMSimpleBatch",[]]]
'
0.044725 : looking for messages on channels
0.044767 on 0: Getting JSON message 0
0.044775 on 0: Invoking channel callback <SNR>17_define
0.044922 SEND on 0(sock): '[31,["callback",30,[""]]]
'
0.044976 : Leaving unsafe area, triggering SafeStateAgain
0.045177 RECV on 0(sock): '[0,[31,"function","GOVIMCancelBatch",[]]]
'
0.045187 : looking for messages on channels
0.045225 on 0: Getting JSON message 0
0.045234 on 0: Invoking channel callback <SNR>17_define
0.045379 SEND on 0(sock): '[32,["callback",31,[""]]]
'
0.045437 : Leaving unsafe area, triggering SafeStateAgain
0.046968 RECV on 0(sock): '[0,[32,"function","GOVIMBadBatch",[]]]
'
0.046976 : looking for messages on channels
0.047022 on 0: Getting JSON message 0
0.047033 on 0: Invoking channel callback <SNR>17_define
0.047204 SEND on 0(sock): '[33,["callback",32,[""]]]
'
0.047248 : Leaving unsafe area, triggering SafeStateAgain
0.047566 RECV on 0(sock): '[0,[33,"function","GOVIMAssertFailedBatch",[]]]
'
0.047572 : looking for messages on channels
0.047597 on 0: Getting JSON message 0
0.047607 on 0: Invoking channel callback <SNR>17_define
0.047774 SEND on 0(sock): '[34,["callback",33,[""]]]
'
0.047813 : Leaving unsafe area, triggering SafeStateAgain
0.048343 RECV on 0(sock): '[0,[34,"function","GOVIMNonBatchCallInBatch",[]]]
'
0.048348 : looking for messages on channels
0.048366 on 0: Getting JSON message 0
0.048371 on 0: Invoking channel callback <SNR>17_define
0.048529 SEND on 0(sock): '[35,["callback",34,[""]]]
'
0.048561 : Leaving unsafe area, triggering SafeStateAgain
0.049338 RECV on 0(sock): '[0,[35,"expr","has(\"gui_running\")"]]
'
0.049344 : looking for messages on channels
0.049366 on 0: Getting JSON message 0
0.049370 on 0: Invoking channel callback <SNR>17_define
0.049456 SEND on 0(sock): '[36,["callback",35,["",0]]]
'
0.049505 : Leaving unsafe area, triggering SafeStateAgain
0.049710 RECV on 0(sock): '[0,[36,"ex","let
s:gopls_logfile=\"/tmp/gopls_log_20190917_2102_59_191323725\""]]
'
0.049714 : looking for messages on channels
0.049740 on 0: Getting JSON message 0
0.049747 on 0: Invoking channel callback <SNR>17_define
0.049821 SEND on 0(sock): '[37,["callback",36,[""]]]
'
0.049863 : Leaving unsafe area, triggering SafeStateAgain
0.053352 RECV on 0(sock): '[0,[37,"call","getcwd",-1]]
'
0.053358 : looking for messages on channels
0.053378 on 0: Getting JSON message 0
0.053382 on 0: Invoking channel callback <SNR>17_define
0.053477 SEND on 0(sock):
'[38,["callback",37,["","/tmp/go-test-script340064514/script-hover"]]]
'
0.053513 : Leaving unsafe area, triggering SafeStateAgain
0.124333 RECV on 0(sock): '[0,[38,"initcomplete"]]
'
0.124339 : looking for messages on channels
0.124363 on 0: Getting JSON message 0
0.124368 on 0: Invoking channel callback <SNR>17_define
0.126165 SEND on 0(sock): '[39,["callback",38,[""]]]
'
0.126267 : Leaving unsafe area, triggering SafeStateAgain
0.151904 RECV on 0(sock): '[0,[39,"call","s:schedule",1]]
'
0.151911 : looking for messages on channels
0.151935 on 0: Getting JSON message 0
0.151941 on 0: Invoking channel callback <SNR>17_define
0.152056 : state() = 'c'
0.152118 SEND on 0(sock): '[40,["schedule",1]]
'
0.152146 on 0: Blocking read JSON for id 40
0.152155 : looking for messages on channels
0.152159 on 0: Waiting for up to 30000 msec
0.153545 RECV on 0(sock): '[0,[40,"ex","e main.go"]]
'
0.153563 : looking for messages on channels
0.153579 on 0: Getting JSON message 0
0.153584 on 0: Invoking channel callback <SNR>17_define
0.155914 SEND on 0(sock):
'[41,["function","autocommand:0",[{"Num":1,"Name":"/tmp/go-test-script340064514/script-hover/main.go","Contents":"package
main\n\nimport \"fmt\"\n\nfunc main() {\n\tfmt.Println(\"Hello,
world\")\n}\n"}]]]
'
0.155965 on 0: Blocking read JSON for id 41
0.155973 : looking for messages on channels
0.155977 on 0: Waiting for up to 30000 msec
0.157159 RECV on 0(sock):
'[0,[41,"call","listener_add","GOVIM_internal_EnrichDelta",1]]
'
0.157171 : looking for messages on channels
0.157185 on 0: Getting JSON message 0
0.157190 on 0: Invoking channel callback <SNR>17_define
0.157317 SEND on 0(sock): '[42,["callback",41,["",1]]]
'
0.157347 : looking for messages on channels
0.157354 on 0: Waiting for up to 30000 msec
0.157944 RECV on 0(sock): '[41,["",null]]
'
0.157957 on 0: Getting JSON message 41
0.157974 on 0: Received JSON for id 41
0.160387 SEND on 0(sock): '[43,["callback",40,[""]]]
'
0.160432 : looking for messages on channels
0.160441 on 0: Waiting for up to 30000 msec
0.160748 RECV on 0(sock): '[40,["",""]]
'
0.160758 on 0: Getting JSON message 40
0.160768 on 0: Received JSON for id 40
0.160824 SEND on 0(sock): '[44,["callback",39,["",0]]]
'
0.161155 : Leaving unsafe area, triggering SafeStateAgain
0.168784 RECV on 0(sock): '[0,[42,"call","s:schedule",2]]
'
0.168797 : looking for messages on channels
0.168821 on 0: Getting JSON message 0
0.168827 on 0: Invoking channel callback <SNR>17_define
0.168948 : state() = 'c'
0.169043 SEND on 0(sock): '[45,["schedule",2]]
'
0.169082 on 0: Blocking read JSON for id 45
0.169089 : looking for messages on channels
0.169094 on 0: Waiting for up to 30000 msec
0.169246 RECV on 0(sock): '[0,[43,"ex","call
test_setmouse(screenpos(bufwinid(\"main.go\"),6,13)[\"row\"],screenpos(bufwinid(\"main.go\"),6,13)[\"col\"])"]]
'
0.169270 : looking for messages on channels
0.169285 on 0: Getting JSON message 0
0.169290 on 0: Invoking channel callback <SNR>17_define
0.169446 SEND on 0(sock): '[46,["callback",43,[""]]]
'
0.169483 : looking for messages on channels
0.169490 on 0: Waiting for up to 30000 msec
0.169739 RECV on 0(sock): '[45,["",""]]
'
0.169749 on 0: Getting JSON message 45
0.169780 on 0: Received JSON for id 45
0.169870 SEND on 0(sock): '[47,["callback",42,["",0]]]
'
0.169918 : Leaving unsafe area, triggering SafeStateAgain
0.180101 RECV on 0(sock): '[0,[44,"call","s:schedule",3]]
'
0.180107 : looking for messages on channels
0.180145 on 0: Getting JSON message 0
0.180152 on 0: Invoking channel callback <SNR>17_define
0.180492 : state() = 'c'
0.180705 SEND on 0(sock): '[48,["schedule",3]]
'
0.180752 on 0: Blocking read JSON for id 48
0.180817 : looking for messages on channels
0.180826 on 0: Waiting for up to 30000 msec
0.180915 RECV on 0(sock): '[0,[45,"ex","call
feedkeys(\"\\\u003cMouseMove\u003e\\\u003cIgnore\u003e\", \"xt\")"]]
'
0.180927 : looking for messages on channels
0.180940 on 0: Getting JSON message 0
0.180945 on 0: Invoking channel callback <SNR>17_define
0.181045 : safe state reset
0.181146 SEND on 0(sock): '[49,["callback",45,[""]]]
'
0.181190 : looking for messages on channels
0.181202 on 0: Waiting for up to 30000 msec
0.181486 RECV on 0(sock): '[48,["",""]]
'
0.181495 on 0: Getting JSON message 48
0.181510 on 0: Received JSON for id 48
0.181588 SEND on 0(sock): '[50,["callback",44,["",0]]]
'
0.181629 : Leaving unsafe area, not triggering SafeStateAgain
0.181646 : looking for messages on channels
0.181652 : Leaving unsafe area, not triggering SafeStateAgain
0.282108 : looking for messages on channels
0.282130 : Leaving unsafe area, not triggering SafeStateAgain
0.382269 : looking for messages on channels
0.382289 : Leaving unsafe area, not triggering SafeStateAgain
0.438333 SEND on 0(sock):
'[51,["function","function:GOVIM_internal_BalloonExpr",[]]]
'
0.438376 on 0: Blocking read JSON for id 51
0.438386 : looking for messages on channels
0.438390 on 0: Waiting for up to 30000 msec
0.438676 RECV on 0(sock): '[0,[46,"expr","{\"bufnum\": v:beval_bufnr,
\"line\": v:beval_lnum, \"col\": v:beval_col, \"screenpos\":
screenpos(v:beval_winid, v:beval_lnum, v:beval_col)}"]]
'
0.438688 : looking for messages on channels
0.438702 on 0: Getting JSON message 0
0.438707 on 0: Invoking channel callback <SNR>17_define
0.438896 SEND on 0(sock):
'[52,["callback",46,["",{"bufnum":1,"col":13,"line":6,"screenpos":{"col":22,"row":6,"endcol":22,"curscol":22}}]]]
'
0.438948 : looking for messages on channels
0.438957 on 0: Waiting for up to 30000 msec
0.700121 RECV on 0(sock): '[0,[47,"call","s:schedule",4]]
'
0.700142 : looking for messages on channels
0.700165 on 0: Getting JSON message 0
0.700171 on 0: Invoking channel callback <SNR>17_define
0.700300 : state() = 'wc'
0.700321 : enqueuing work
0.700373 SEND on 0(sock): '[53,["callback",47,["",0]]]
'
0.700419 : looking for messages on channels
0.700426 on 0: Waiting for up to 30000 msec
0.994181 RECV on 0(sock): '[0,[48,"call","popup_create",["func fmt.Println(a
...interface{}) (n int, err error)","Println formats using the default formats
for its operands and writes to standard output.","Spaces are always added
between operands and a newline is appended.","It returns the number of bytes
written and any write error
encountered."],{"close":"click","col":22,"line":5,"mousemoved":"any","moved":"any","padding":[0,1,0,1],"pos":"botleft","wrap":false}]]
'
0.994218 : looking for messages on channels
0.994238 on 0: Getting JSON message 0
0.994243 on 0: Invoking channel callback <SNR>17_define
0.994468 SEND on 0(sock): '[54,["callback",48,["",1001]]]
'
0.994521 : looking for messages on channels
0.994527 on 0: Waiting for up to 30000 msec
0.994686 RECV on 0(sock): '[0,[49,"redraw",""]]
'
0.994705 : looking for messages on channels
0.994717 on 0: Getting JSON message 0
0.994722 on 0: Invoking channel callback <SNR>17_define
0.995167 SEND on 0(sock): '[55,["callback",49,[""]]]
'
0.995222 : looking for messages on channels
0.995237 on 0: Waiting for up to 30000 msec
0.995369 RECV on 0(sock): '[51,["",""]]
'
0.995380 on 0: Getting JSON message 51
0.995393 on 0: Received JSON for id 51
1.047531 : looking for messages on channels
1.047546 : Leaving unsafe area, not triggering SafeStateAgain
1.047613 : looking for messages on channels
1.047634 : Leaving unsafe area, not triggering SafeStateAgain
307.702322 on 0: channel_select_check(): Read EOF from ch_part[0], closing
307.702691 : Exiting...
307.703064 on 0: Closing channel
307.703142 on 0: Clearing channel
