search

enso-org / enso

Enso Analytics is a self-service data prep and analysis platform designed for data teams.
https://ensoanalytics.com
Apache License 2.0
7.37k stars 323 forks source link

When picking a Boolean value via the dropdown doesn't recalculate correctly. #6221

Closed jdunkerley closed 1 year ago

jdunkerley commented 1 year ago

https://user-images.githubusercontent.com/4699705/230432487-76f9bfb8-25c2-4083-98a8-7e4325729018.mp4

When I choose a Boolean value from a dropdown it doesn't appear to recalculate correctly. When I then change the value it then recalculates correctly. And when I change back to the first value it calculates fine.

farmaazon commented 1 year ago
  1. To be checked if it's fixed by #6209
  2. If not, check if the engine is sending us the update.
sylwiabr commented 1 year ago

it's still valid in the package from 912556853f17325f37287f791f418831eb53c479 commit. This issue appear just when user is choosing the value from the drop-down for the first time.

MichaelMauderer commented 1 year ago

@sylwiabr @jdunkerley: Do you have a full minimal example of this? I just want to double-check that I am looking at the right behaviour, as it seems, the API used in the original video has been changed.

MichaelMauderer commented 1 year ago

My reproduction with the node "A B X".words seems to indicate an issue on the engine side. After selecting a boolean from the widget, the widget disappears and the engine no longer evaluates the graph. The error message that appears in the dev console is: 

[[warn] [2023-04-21T14:46:02.574Z] [enso] Execution of function main failed (class org.enso.interpreter.runtime.callable.atom.BoxingAtom cannot be cast to class java.lang.Boolean (org.enso.interpreter.runtime.callable.atom.BoxingAtom is in unnamed module of loader com.oracle.graalvm.locator.GraalVMLocator$GuestLangToolsLoader @4fe875be; java.lang.Boolean is in module java.base of loader 'bootstrap')).](<Execution failed in context eeee848a-fd67-41dc-8fd6-2148ec9e8be6. Error: Execution of function main failed (class org.enso.interpreter.runtime.callable.atom.BoxingAtom cannot be cast to class java.lang.Boolean (org.enso.interpreter.runtime.callable.atom.BoxingAtom is in unnamed module of loader com.oracle.graalvm.locator.GraalVMLocator$GuestLangToolsLoader @30b2b76f; java.lang.Boolean is in module java.base of loader 'bootstrap'))..>)

https://user-images.githubusercontent.com/1428930/233843349-fb38059e-d1f1-4825-be54-50ae9a9da162.mp4

@JaroslavTulach @4e6

JaroslavTulach commented 1 year ago

[[warn] ...BoxingAtom cannot be cast to class java.lang.Boolean

Yes, that message indicates the problem is in some builtin. Too bad we don't have a JVM stacktrace. It'd be better if such errors didn't get "swallowed". Is there an option to use in the IDE to run the engine in more verbose mode, @4e6? Or did you copy just the message and not the stacktrace, Michael?

Michael, what's your final Enso code? Simple:

from Standard.Base import all

main = "A B C".words Boolean.True

runs OK for me from CLI and produces ['A', ' ', 'B', ' ', 'C']. Do you get the same error when you run your code from CLI or when you restart the IDE?

sylwiabr commented 1 year ago

@MichaelMauderer The API is still the same. I can not unfortunately reproduce it with dev console opened.

Zrzut ekranu 2023-04-24 o 08 22 21 Zrzut ekranu 2023-04-24 o 08 23 58

@JaroslavTulach this is happening just in IDE I think.

sylwiabr commented 1 year ago

https://user-images.githubusercontent.com/12892578/233916074-84446a8b-a458-4be8-8b0c-62b6baf7589b.mov

Here is the video with console opened @MichaelMauderer (starts around 55s - sorry for not cutting it)

JaroslavTulach commented 1 year ago

Another thought: I am surprised the IDE uses Boolean.True and not just True. There should be little difference since

got fixed, but if there is from Standard.Base import all, then simple True shall be available and certainly more readable than Boolean.True.

MichaelMauderer commented 1 year ago

@JaroslavTulach Sorry this was a false alarm. My dev build was stuck with an old engine (which is also why I saw a different API for replace). The IDE still uses Boolean.True/Boolean.False though.

I can repro this now, and it seems the IDE is not sending a message to the backend. So investigating this on the IDE side now.

JaroslavTulach commented 1 year ago

this was a false alarm. My dev build was stuck with an old engine

Probably it was an older engine than 2023.1.1-nightly.2023.3.28 when #6090 got fixed. Good to know this is not an issue.

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new STANDUP for the provided date (2023-04-21):

Progress: Applied review feedback for #6341. Started investigating issue about Boolean not correctly updating node output. It should be finished by 2023-04-26.

Next Day: Next day I will be working on the #6221 task. Get repro to work and investigate the cause of behavior.

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new STANDUP for today (2023-04-24):

Progress: Failed to repro the described issue and after some investigation noticed that the default “latest” backend used in our build script is quite old. Managed to repro and found that no updates are sent to the engine after the widget item is selected. Started digging into the internal functionality / FRP events. It should be finished by 2023-04-26.

Next Day: Next day I will be working on the #6221 task. Investigbate root cause of the issue.

vitvakatu commented 1 year ago

@MichaelMauderer, please sync with @Frizi on the widget's FRP because the implementation is heavily changed in #6347 (it might make sense to check this issue on that branch first)

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new STANDUP for yesterday (2023-04-25):

Progress: Applied QA feedback for #6341. Updated integration and created PR for follow-up task #6179. It should be finished by 2023-04-26.

Next Day: Next day I will be working on the #6221 task. Check whether the widget update changes behavior if not, investigate the root cause.

MichaelMauderer commented 1 year ago

This does not seem to be affected by https://github.com/enso-org/enso/pull/6347, as I just reproduced the behaviour on that branch.

MichaelMauderer commented 1 year ago

So, I've traced what happens from the IDE side, and it seems this is an engine issue after all.

When looking at the following project

image

from Standard.Base import all
from Standard.Base.Data.Boolean import Boolean
import Standard.Visualization

main = 
    text2 = "  B   B   B   "
    text1 = "B"
    text3 = "@"
    operator2 = text2.replace text1 text3 (Case_Sensitivity.Insensitive)

when I choose True from the dropdown for only_first, the IDE sends a text edit to the engine that looks like this: 

{
  "jsonrpc": "2.0",
  "id": 19,
  "method": "text/applyEdit",
  "params": {
    "edit": {
      "edits": [
        {
          "range": {
            "end": {
              "character": 4663,
              "line": 16
            },
            "start": {
              "character": 4326,
              "line": 16
            }
          },
          "text": "74c31314-e1ed-4ce2-b425-7d25d18b6ef7\"],[{\"index\":{\"value\":251},\"size\":{\"value\":7}},\"c4a1412c-50dc-4b1a-bdd2-0533e2dc5a65\"],[{\"index\":{\"value\":258},\"size\":{\"value\":1}},\"b6137c2e-dc95-4929-8271-b312636e69a1\"],[{\"index\":{\"value\":259},\"size\":{\"value\":4}},\"eeee2098-f25d-4453-ac5a-7bb9a82e8a3d\"],[{\"index\":{\"value\":251},\"size\":{\"value\":12}},\"a5b1358a-c151-4b33-a1a6-f1f89ddcb929\"],[{\"index\":{\"value\":194},\"size\":{\"value\":69}},\"a8d000c2-2494-44e0-91ad-b1c83a14a396\"],[{\"index\":{\"value\":182},\"size\":{\"value\":81}},\"a29e59ad-010f-46be-ae5a-f2d7fae91bc0\"],[{\"index\":{\"value\":116},\"size\":{\"value\":147}},\"8d3c24b0-8bbd-44a0-a527-0dc646a1a513\"],[{\"index\":{\"value\":109},\"size\":{\"value\":154}},\"9f904285-40a4-49a2-8a84-c2b824e12867\"],[{\"index\":{\"value\":0},\"size\":{\"value\":266"
        },
        {
          "range": {
            "end": {
              "character": 72,
              "line": 9
            },
            "start": {
              "character": 72,
              "line": 9
            }
          },
          "text": " Boolean.True"
        }
      ],
      "newVersion": "db09b1b2004180e39729ee5ec307bb79feb2aa4a7986570c6b161656",
      "oldVersion": "c2f4e894a32141c8a7ed26fb4594ad9de62ab9932bd815c284180cc5",
      "path": {
        "rootId": "43625384-ee22-4e5f-a3a0-a3a22087926e",
        "segments": [
          "src",
          "Main.enso"
        ]
      }
    },
    "execute": true
  }
}

Which looks fine to me.

But after execution ends, we only get an expression update that looks like this

{
  "jsonrpc": "2.0",
  "method": "executionContext/expressionUpdates",
  "params": {
    "contextId": "522248c3-09a3-45cb-a79b-5e29132800ed",
    "updates": [
      {
        "expressionId": "7140479b-b697-4418-ae59-ad36b25fe8ee",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 372677
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "a647c160-59e7-43b7-810b-40b7a95b687e",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 245446
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "678ba098-e18a-4440-a82b-cc51b6f9a602",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 243812
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "a29e59ad-010f-46be-ae5a-f2d7fae91bc0",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 278809
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "8d3c24b0-8bbd-44a0-a527-0dc646a1a513",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 4070250
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      }
    ]
  }
}

Which does not seem quite right as everything in there is Nothing.

Also, when I then remove the Boolean.True via dropdown, the IDE sends the following edit to the engine

{
  "jsonrpc": "2.0",
  "id": 17,
  "method": "text/applyEdit",
  "params": {
    "edit": {
      "edits": [
        {
          "range": {
            "end": {
              "character": 5041,
              "line": 16
            },
            "start": {
              "character": 4326,
              "line": 16
            }
          },
          "text": "a8d000c2-2494-44e0-91ad-b1c83a14a396\"],[{\"index\":{\"value\":182},\"size\":{\"value\":68}},\"a29e59ad-010f-46be-ae5a-f2d7fae91bc0\"],[{\"index\":{\"value\":116},\"size\":{\"value\":134}},\"3205bba4-575f-45d3-a6b7-8fbfca891309\"],[{\"index\":{\"value\":109},\"size\":{\"value\":141}},\"9f904285-40a4-49a2-8a84-c2b824e12867\"],[{\"index\":{\"value\":0},\"size\":{\"value\":253}},\"0d710679-2158-495c-9bb8-5529efc0cc23"
        },
        {
          "range": {
            "end": {
              "character": 85,
              "line": 9
            },
            "start": {
              "character": 72,
              "line": 9
            }
          },
          "text": ""
        }
      ],
      "newVersion": "c2f4e894a32141c8a7ed26fb4594ad9de62ab9932bd815c284180cc5",
      "oldVersion": "2c0ec4f8dd119551f2cae295c286ecd0c8e991f7749a816b08444743",
      "path": {
        "rootId": "43625384-ee22-4e5f-a3a0-a3a22087926e",
        "segments": [
          "src",
          "Main.enso"
        ]
      }
    },
    "execute": true
  }
}

which then results in the following expression update

{
  "jsonrpc": "2.0",
  "method": "executionContext/expressionUpdates",
  "params": {
    "contextId": "522248c3-09a3-45cb-a79b-5e29132800ed",
    "updates": [
      {
        "expressionId": "9f904285-40a4-49a2-8a84-c2b824e12867",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "a29e59ad-010f-46be-ae5a-f2d7fae91bc0",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "0691e0c9-bba2-43bb-b5e3-04ad53cfe2f9",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "9a52a7b6-6efd-48c4-88dc-8e9ee6664602",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "a8d000c2-2494-44e0-91ad-b1c83a14a396",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "9033b653-c992-461f-9407-6226c5d84be3",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "c860fadd-17a9-4856-ac5d-5531ba04379d",
        "type": null,
        "methodPointer": null,
        "profilingInfo": [],
        "fromCache": true,
        "payload": {
          "type": "Pending",
          "message": null,
          "progress": null
        }
      },
      {
        "expressionId": "7140479b-b697-4418-ae59-ad36b25fe8ee",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 294759
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "a647c160-59e7-43b7-810b-40b7a95b687e",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 173789
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "678ba098-e18a-4440-a82b-cc51b6f9a602",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 183017
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "e9ee4d72-6cbb-4f52-a929-f4061aa56966",
        "type": "Standard.Builtins.Main.Unresolved_Symbol",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 3266
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "481e6db2-7e1a-4535-9ceb-ffa1935997ea",
        "type": "Standard.Base.Data.Text.Text",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 78439
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "6038638a-c32b-48de-97ee-313c18c8e2df",
        "type": "Standard.Base.Data.Text.Text",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 117082
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "b923f692-1b33-4cd6-8c1f-bc0d1b346a12",
        "type": "Standard.Base.Data.Text.Text",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 51989
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "38c97975-c992-47e0-8eeb-218b2b8c4701",
        "type": "Standard.Builtins.Main.Unresolved_Symbol",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 4478
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "dbc2c858-3cfd-47b0-8c9c-f36041ec19a3",
        "type": "Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 4048
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "05b4147b-2e78-4ae6-81a1-7c65f5588ca2",
        "type": "Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity",
        "methodPointer": {
          "module": "Standard.Base.Data.Text.Case_Sensitivity",
          "definedOnType": "Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity",
          "name": "Insensitive"
        },
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 11988137
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "a8d000c2-2494-44e0-91ad-b1c83a14a396",
        "type": "Standard.Base.Data.Text.Text",
        "methodPointer": {
          "module": "Standard.Base.Data.Text.Extensions",
          "definedOnType": "Standard.Base.Data.Text.Text",
          "name": "replace"
        },
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 41558841
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "a29e59ad-010f-46be-ae5a-f2d7fae91bc0",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 47208055
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      },
      {
        "expressionId": "3205bba4-575f-45d3-a6b7-8fbfca891309",
        "type": "Standard.Base.Nothing.Nothing",
        "methodPointer": null,
        "profilingInfo": [
          {
            "ExecutionTime": {
              "nanoTime": 51503232
            }
          }
        ],
        "fromCache": false,
        "payload": {
          "type": "Value",
          "warnings": null
        }
      }
    ]
  }
}

Which looks more sensible as it actually contains type information.

Unfortunately, I'm not sure how to debug from here, as it appears that something is going when applying the edit on the engine side. Any ideas @JaroslavTulach @4e6 ?

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new 🔴 DELAY for yesterday (2023-04-26):

Summary: There is 2 days delay in implementation of the When picking a Boolean value via the dropdown doesn't recalculate correctly. (#6221) task. It will cause 0 days delay for the delivery of this weekly plan.

Delay Cause: Delayed due to work on other tasks (integration of Execution Environment and Triage)

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new STANDUP for yesterday (2023-04-26):

Progress: Updated PR for #6179, created followup integration PR 6434. Worked on Triage and reproducing issues. Found that #6347 does not resolve this issue. It should be finished by 2023-04-28.

Next Day: Next day I will be working on the #6221 task. Finalize previous PRs and get back to investigating this issue.

enso-bot[bot] commented 1 year ago

Michael Mauderer reports a new STANDUP for today (2023-04-27):

Progress: Worked on Triage. Continued investigation and traced the issue to (probably) the engine. Updated the task and requested help from the engine team. It should be finished by 2023-04-28.

Next Day: Next day I will be working on the #6221 task. Either continue investigation or choose next task if this has to go to the engine team.

MichaelMauderer commented 1 year ago

This is the verbose log from the LS console when choosing the True value from the widget, when before nothing was selected. @4e6 @JaroslavTulach 

debug] [2023-04-28T10:34:15.967Z] [org.enso.projectmanager.infrastructure.languageserver.LanguageServerSupervisor] now supervising Actor[akka://project-manager/user/language-server-registry/language-server-controller-306aec02-8554-4da8-86a7-0c8681f1bc5a/supervisor-language-server-306aec02-8554-4da8-86a7-0c8681f1bc5a/heartbeat-6b078c05-9a4e-473f-9122-f9598014778d#-1154945066]
[debug] [2023-04-28T10:34:15.967Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] started (org.enso.projectmanager.infrastructure.http.FanOutReceiver@2df0ab1f)
[debug] [2023-04-28T10:34:15.97Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Heartbeat connection initialized [Socket(127.0.0.1,49467)].
[debug] [2023-04-28T10:34:15.971Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] started (org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession@15329fbe)
[debug] [2023-04-28T10:34:15.971Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] now watched by Actor[akka://project-manager/system/Materializers/StreamSupervisor-0/$$Bc#-19996995]
[debug] [2023-04-28T10:34:15.977Z] [org.enso.jsonrpc.MessageHandlerSupervisor] started (org.enso.jsonrpc.MessageHandlerSupervisor@226c3963)
[debug] [2023-04-28T10:34:15.977Z] [org.enso.languageserver.protocol.json.JsonConnectionController] started (org.enso.languageserver.protocol.json.JsonConnectionController@535f3640)
[debug] [2023-04-28T10:34:15.977Z] [org.enso.jsonrpc.MessageHandler] started (org.enso.jsonrpc.MessageHandler@62cf2a03)
[debug] [2023-04-28T10:34:15.978Z] [org.enso.jsonrpc.MessageHandlerSupervisor] now supervising Actor[akka://language-server/user/message-handler-supervisor-3360b37d-d848-4cca-a9ff-95a18bad21e2/message-handler-d9dd51f7-6609-4658-94fb-16ae37d8e9d3#374782907]
[debug] [2023-04-28T10:34:15.98Z] [org.enso.jsonrpc.MessageHandlerSupervisor] now watched by Actor[akka://language-server/system/Materializers/StreamSupervisor-0/$$Tb#-243416273]
[debug] [2023-04-28T10:34:15.982Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Sending ping message to Socket(127.0.0.1,49467).
[trace] [2023-04-28T10:34:15.984Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: 
{ 
   "jsonrpc": "2.0",
   "method": "heartbeat/ping",
   "id": "5cb59688-1f68-4cae-886a-8609a9b29eca",
   "params": null
}
.
[debug] [2023-04-28T10:34:15.984Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-d9dd51f7-6609-4658-94fb-16ae37d8e9d3/$a#1729831693]
[debug] [2023-04-28T10:34:15.984Z] [org.enso.languageserver.requesthandler.monitoring.PingHandler] started (org.enso.languageserver.requesthandler.monitoring.PingHandler@e6fd5e0)
[debug] [2023-04-28T10:34:15.985Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Received correct pong message from Socket(127.0.0.1,49467).
[trace] [2023-04-28T10:34:15.984Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":"5cb59688-1f68-4cae-886a-8609a9b29eca","result":null}.
[debug] [2023-04-28T10:34:15.984Z] [org.enso.languageserver.requesthandler.monitoring.PingHandler] stopped
[debug] [2023-04-28T10:34:15.987Z] [org.enso.languageserver.protocol.json.JsonConnectionController] stopped
[debug] [2023-04-28T10:34:15.987Z] [org.enso.jsonrpc.MessageHandler] stopped
[debug] [2023-04-28T10:34:15.987Z] [org.enso.jsonrpc.MessageHandlerSupervisor] no longer watched by Actor[akka://language-server/system/Materializers/StreamSupervisor-0/$$Tb#-243416273]
[trace] [2023-04-28T10:34:16.8Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: {"jsonrpc":"2.0","id":20,"method":"text/applyEdit","params":{"edit":{"edits":[{"range":{"end":{"character":4663,"line":16},"start":{"character":4326,"line":16}},"text":"784e7fd6-c07c-4eeb-92cb-d696e07edbc8\"],[{\"index\":{\"value\":251},\"size\":{\"value\":7}},\"411db538-670d-49a7-81c4-e6d172db12fa\"],[{\"index\":{\"value\":258},\"size\":{\"value\":1}},\"a83f6213-5b8a-45ae-9034-b6d09cd1bbbc\"],[{\"index\":{\"value\":259},\"size\":{\"value\":4}},\"623c3592-3a03-4b39-8baf-f43140b8c59c\"],[{\"index\":{\"value\":251},\"size\":{\"value\":12}},\"b0a4429d-57d5-4e70-91da-1105c39403e6\"],[{\"index\":{\"value\":194},\"size\":{\"value\":69}},\"a8d000c2-2494-44e0-91ad-b1c83a14a396\"],[{\"index\":{\"value\":182},\"size\":{\"value\":81}},\"a29e59ad-010f-46be-ae5a-f2d7fae91bc0\"],[{\"index\":{\"value\":116},\"size\":{\"value\":147}},\"0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27\"],[{\"index\":{\"value\":109},\"size\":{\"value\":154}},\"9f904285-40a4-49a2-8a84-c2b824e12867\"],[{\"index\":{\"value\":0},\"size\":{\"value\":266"},{"range":{"end":{"character":72,"line":9},"start":{"character":72,"line":9}},"text":" Boolean.True"}],"newVersion":"20d155336daf651c7276b79c1fd324b614f89277f03b95f8ac7c0537","oldVersion":"455821208119e6ec832f2dfe3157f00a276bcfacfdd370a4c59d084f","path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]}},"execute":true}}.
[trace] [2023-04-28T10:34:16.801Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled Request(ApplyEdit,Number(20),Params(FileEdit(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso)),List(TextEdit(Range(Position(16,4326),Position(16,4663)),784e7fd6-c07c-4eeb-92cb-d696e07edbc8"],[{"index":{"value":251},"size":{"value":7}},"411db538-670d-49a7-81c4-e6d172db12fa"],[{"index":{"value":258},"size":{"value":1}},"a83f6213-5b8a-45ae-9034-b6d09cd1bbbc"],[{"index":{"value":259},"size":{"value":4}},"623c3592-3a03-4b39-8baf-f43140b8c59c"],[{"index":{"value":251},"size":{"value":12}},"b0a4429d-57d5-4e70-91da-1105c39403e6"],[{"index":{"value":194},"size":{"value":69}},"a8d000c2-2494-44e0-91ad-b1c83a14a396"],[{"index":{"value":182},"size":{"value":81}},"a29e59ad-010f-46be-ae5a-f2d7fae91bc0"],[{"index":{"value":116},"size":{"value":147}},"0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27"],[{"index":{"value":109},"size":{"value":154}},"9f904285-40a4-49a2-8a84-c2b824e12867"],[{"index":{"value":0},"size":{"value":266), TextEdit(Range(Position(9,72),Position(9,72)), Boolean.True)),455821208119e6ec832f2dfe3157f00a276bcfacfdd370a4c59d084f,20d155336daf651c7276b79c1fd324b614f89277f03b95f8ac7c0537),Some(true))) from Actor[akka://language-server/user/message-handler-supervisor-038d1851-4e45-4f12-a32a-a612e5cc34cf/message-handler-6a53da52-7eb1-4841-87ab-2c70e9199256#2139308755]
[debug] [2023-04-28T10:34:16.801Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-6a53da52-7eb1-4841-87ab-2c70e9199256/request-handler-ApplyEdit-f0c03e54-6a0f-4a22-9736-fc9f5099220e#-619780956]
[debug] [2023-04-28T10:34:16.801Z] [org.enso.languageserver.requesthandler.text.ApplyEditHandler] started (org.enso.languageserver.requesthandler.text.ApplyEditHandler@43aa4ae8)
[trace] [2023-04-28T10:34:16.803Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled Request(None,EditFileNotification(/home/michael/enso/projects/Namwd/src/Main.enso,List(TextEdit(Range(Position(16,4326),Position(16,4663)),784e7fd6-c07c-4eeb-92cb-d696e07edbc8"],[{"index":{"value":251},"size":{"value":7}},"411db538-670d-49a7-81c4-e6d172db12fa"],[{"index":{"value":258},"size":{"value":1}},"a83f6213-5b8a-45ae-9034-b6d09cd1bbbc"],[{"index":{"value":259},"size":{"value":4}},"623c3592-3a03-4b39-8baf-f43140b8c59c"],[{"index":{"value":251},"size":{"value":12}},"b0a4429d-57d5-4e70-91da-1105c39403e6"],[{"index":{"value":194},"size":{"value":69}},"a8d000c2-2494-44e0-91ad-b1c83a14a396"],[{"index":{"value":182},"size":{"value":81}},"a29e59ad-010f-46be-ae5a-f2d7fae91bc0"],[{"index":{"value":116},"size":{"value":147}},"0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27"],[{"index":{"value":109},"size":{"value":154}},"9f904285-40a4-49a2-8a84-c2b824e12867"],[{"index":{"value":0},"size":{"value":266), TextEdit(Range(Position(9,72),Position(9,72)), Boolean.True)),true)) from Actor[akka://language-server/user/buffer-registry/collaborative-buffer-89f5f818-a4db-4f4c-b9de-54e2b648e590#-734177692]
[debug] [2023-04-28T10:34:16.803Z] [org.enso.languageserver.requesthandler.text.ApplyEditHandler] stopped
[trace] [2023-04-28T10:34:16.803Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":20,"result":null}.
[debug] [2023-04-28T10:34:16.805Z] [enso] Executing command: EditFileCmd...
[debug] [2023-04-28T10:34:16.805Z] [enso] Submitting job: org.enso.interpreter.instrument.job.EnsureCompiledJob@103649aa...
[debug] [2023-04-28T10:34:16.806Z] [enso] Executing job: org.enso.interpreter.instrument.job.EnsureCompiledJob@103649aa...
[debug] [2023-04-28T10:34:16.806Z] [enso] Submitting job: org.enso.interpreter.instrument.job.ExecuteJob@7d6535e6...
[debug] [2023-04-28T10:34:16.806Z] [enso] Command EditFileCmd finished.
[trace] [2023-04-28T10:34:16.809Z] [enso] Compiling local.Namd.Main.
[debug] [2023-04-28T10:34:16.81Z] [enso.org.enso.compiler.Compiler] Parsing module [local.Namd.Main].
[trace] [2023-04-28T10:34:16.81Z] [enso.org.enso.compiler.ModuleCache] One or more digests did not match for the cache for [local.Namd.Main].
[trace] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.ModuleCache] Invalidated the cache at [***/Main.meta].
[trace] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.ModuleCache] Invalidated the cache at [***/Main.ir].
[trace] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.ModuleCache] Could not load the cache metadata at [***/Main.meta].
[trace] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.ModuleCache] Unable to load a cache [local.Namd.Main]
[debug] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.SerializationManager] Unable to load a cache for module [local.Namd.Main].
[debug] [2023-04-28T10:34:16.811Z] [enso.org.enso.compiler.Compiler] Loading module [local.Namd.Main] from source.
[trace] [2023-04-28T10:34:16.816Z] [enso.org.enso.compiler.ImportExportCache] Could not load the cache metadata at [***/Namd.bindings.meta].
[trace] [2023-04-28T10:34:16.817Z] [enso.org.enso.compiler.ImportExportCache] Could not load the cache metadata at [***/Namd.bindings.meta].
[trace] [2023-04-28T10:34:16.817Z] [enso.org.enso.compiler.ImportExportCache] Unable to load a cache [local.Namd]
[trace] [2023-04-28T10:34:16.817Z] [enso.org.enso.compiler.SerializationManager] Unable to load bindings for library [local.Namd].
[debug] [2023-04-28T10:34:16.84Z] [enso.org.enso.compiler.Compiler] Generating code for module [local.Namd.Main].
[debug] [2023-04-28T10:34:16.84Z] [enso] Executing command: SerializeModuleCommand...
[debug] [2023-04-28T10:34:16.841Z] [enso] Submitting job: org.enso.interpreter.instrument.job.SerializeModuleJob@17d590a9...
[debug] [2023-04-28T10:34:16.841Z] [enso] Executing job: org.enso.interpreter.instrument.job.SerializeModuleJob@17d590a9...
[debug] [2023-04-28T10:34:16.841Z] [enso] Command SerializeModuleCommand finished.
[debug] [2023-04-28T10:34:16.846Z] [enso] Submitting job: AnalyzeModuleJob(local.Namd.Main, ...)...
[trace] [2023-04-28T10:34:16.847Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExecutionUpdate(10c1f90c-70cc-4f9b-b435-047420407611,List(Diagnostic(Warning(),Some(Unused variable operator2.),Some(/home/michael/enso/projects/Namwd/src/Main.enso),Some(Range(Position(9,4),Position(9,13))),Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),Vector()))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.847Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExecutionUpdate(contextId=10c1f90c-70cc-4f9b-b435-047420407611,diagnostics=List(Diagnostic(kind=Warning(),message=Some(***),file=Some(***/Main.enso),location=Some(Range(Position(9,4),Position(9,13))),expressionId=Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),stack=Vector()))) from Actor[akka://language-server/deadLetters]
[debug] [2023-04-28T10:34:16.848Z] [enso] Job org.enso.interpreter.instrument.job.EnsureCompiledJob@103649aa finished in 42 ms.
[debug] [2023-04-28T10:34:16.848Z] [enso.org.enso.compiler.SerializationManager] Requesting serialization for module [local.Namd.Main].
[debug] [2023-04-28T10:34:16.848Z] [enso] Executing job: org.enso.interpreter.instrument.job.ExecuteJob@7d6535e6...
[trace] [2023-04-28T10:34:16.848Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExecutionDiagnosticNotification(10c1f90c-70cc-4f9b-b435-047420407611,List(ExecutionDiagnostic(Warning,Some(Unused variable operator2.),Some(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso))),Some(Range(Position(9,4),Position(9,13))),Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),Vector()))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:34:16.848Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/executionStatus","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611","diagnostics":[{"kind":"Warning","message":"Unused variable operator2.","path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]},"location":{"start":{"line":9,"character":4},"end":{"line":9,"character":13}},"expressionId":"f1a6e471-4274-493c-9ba5-52564b86aa1b","stack":[]}]}}.
[debug] [2023-04-28T10:34:16.85Z] [enso.org.enso.compiler.SerializationManager] Running serialization for module [local.Namd.Main].
[trace] [2023-04-28T10:34:16.862Z] [enso.org.enso.compiler.ModuleCache] Written cache data [local.Namd.Main] to [***/Namd].
[debug] [2023-04-28T10:34:16.862Z] [enso] Job org.enso.interpreter.instrument.job.SerializeModuleJob@17d590a9 finished in 21 ms.
[trace] [2023-04-28T10:34:16.863Z] [enso] Run program 10c1f90c-70cc-4f9b-b435-047420407611
[debug] [2023-04-28T10:34:16.863Z] [enso] Executing job: AnalyzeModuleJob(local.Namd.Main, ...)...
[trace] [2023-04-28T10:34:16.863Z] [enso] Analyzing indexed module local.Namd.Main
[debug] [2023-04-28T10:34:16.867Z] [enso] Job AnalyzeModuleJob(local.Namd.Main, ...) finished in 4 ms.
[trace] [2023-04-28T10:34:16.868Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,SuggestionsDatabaseModuleUpdateNotification(local.Namd.Main,Vector(),Vector(),Root(Vector(Node(SuggestionUpdate(Method(Some(448992c0-f650-4404-ad72-637553a70477),local.Namd.Main,main,List(),local.Namd.Main,Standard.Base.Any.Any,true,None,None),Modify(Some(Some(0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27)),None,None,None,None,None)),Vector(Node(SuggestionUpdate(Local(Some(d5cb58c5-45c7-4223-bdc9-5477fdd6e6e0),local.Namd.Main,text2,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,72)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(0236ab58-fc0d-4af1-b2e1-8835b801980d),local.Namd.Main,text1,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,72)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(641c7f6d-15f5-4375-b698-a0926818dd3e),local.Namd.Main,text3,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,72)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(a8d000c2-2494-44e0-91ad-b1c83a14a396),local.Namd.Main,operator2,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,72)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector())))))))) from Actor[akka://language-server/deadLetters]
[debug] [2023-04-28T10:34:16.868Z] [org.enso.languageserver.search.SuggestionsHandler] Got module update [local.Namd.Main].
[trace] [2023-04-28T10:34:16.869Z] [enso] ON_CACHED_VALUE d5cb58c5-45c7-4223-bdc9-5477fdd6e6e0
[trace] [2023-04-28T10:34:16.869Z] [enso] ON_COMPUTED 7140479b-b697-4418-ae59-ad36b25fe8ee
[trace] [2023-04-28T10:34:16.87Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(384262)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.87Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(384262)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.87Z] [enso] ON_CACHED_VALUE 0236ab58-fc0d-4af1-b2e1-8835b801980d
[trace] [2023-04-28T10:34:16.87Z] [enso] ON_COMPUTED a647c160-59e7-43b7-810b-40b7a95b687e
[trace] [2023-04-28T10:34:16.871Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(285627)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.871Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(285627)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.871Z] [enso] ON_CACHED_VALUE 641c7f6d-15f5-4375-b698-a0926818dd3e
[trace] [2023-04-28T10:34:16.871Z] [enso] ON_COMPUTED 678ba098-e18a-4440-a82b-cc51b6f9a602
[trace] [2023-04-28T10:34:16.872Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(275438)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.872Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(275438)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.872Z] [enso] ON_CACHED_VALUE a8d000c2-2494-44e0-91ad-b1c83a14a396
[trace] [2023-04-28T10:34:16.872Z] [enso] ON_COMPUTED a29e59ad-010f-46be-ae5a-f2d7fae91bc0
[trace] [2023-04-28T10:34:16.873Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(268846)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.873Z] [enso] ON_COMPUTED 0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27
[trace] [2023-04-28T10:34:16.873Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(268846)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.873Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(4094051)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.873Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(4094051)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.874Z] [enso] ON_CACHED_CALL a8d000c2-2494-44e0-91ad-b1c83a14a396
[trace] [2023-04-28T10:34:16.874Z] [enso] ON_CACHED_CALL 05b4147b-2e78-4ae6-81a1-7c65f5588ca2
[trace] [2023-04-28T10:34:16.874Z] [enso] Execution finished: Right(())
[debug] [2023-04-28T10:34:16.875Z] [enso] Job org.enso.interpreter.instrument.job.ExecuteJob@7d6535e6 finished in 27 ms.
[trace] [2023-04-28T10:34:16.875Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExecutionComplete(10c1f90c-70cc-4f9b-b435-047420407611))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.875Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExecutionComplete(10c1f90c-70cc-4f9b-b435-047420407611) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:34:16.875Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExecutionCompleteNotification(10c1f90c-70cc-4f9b-b435-047420407611) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:34:16.875Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/executionComplete","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611"}}.
[debug] [2023-04-28T10:34:16.932Z] [org.enso.languageserver.search.SuggestionsHandler] Complete module update [local.Namd.Main].
[debug] [2023-04-28T10:34:16.932Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing)))].
[trace] [2023-04-28T10:34:16.932Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled SuggestionsDatabaseUpdateNotification(36,List(Modify(2,Some(FieldUpdate(Set,Some(0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27))),None,None,None,None,None,None,None), Modify(3,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(4,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(5,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(6,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:34:16.933Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"search/suggestionsDatabaseUpdates","params":{"updates":[{"type":"Modify","id":2,"externalId":{"tag":"Set","value":"0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27"}},{"type":"Modify","id":3,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":4,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":5,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":6,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}}],"currentVersion":36}}.
[debug] [2023-04-28T10:34:16.939Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing)))].
[debug] [2023-04-28T10:34:16.946Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing)))].
[debug] [2023-04-28T10:34:16.952Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing)))].
[debug] [2023-04-28T10:34:16.957Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27,Some(Standard.Base.Nothing.Nothing)))].
[trace] [2023-04-28T10:34:16.962Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled SuggestionsDatabaseUpdateNotification(37,List(Modify(2,None,None,None,None,Some(FieldUpdate(Set,Some(Standard.Base.Nothing.Nothing))),None,None,None))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:34:16.962Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"search/suggestionsDatabaseUpdates","params":{"updates":[{"type":"Modify","id":2,"returnType":{"tag":"Set","value":"Standard.Base.Nothing.Nothing"}}],"currentVersion":37}}.
[trace] [2023-04-28T10:34:17.758Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExpressionUpdatesNotification(10c1f90c-70cc-4f9b-b435-047420407611,Vector(ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(384262)),false,Value(None)), ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(285627)),false,Value(None)), ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(275438)),false,Value(None)), ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(268846)),false,Value(None)), ExpressionUpdate(0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(4094051)),false,Value(None)))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:34:17.758Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/expressionUpdates","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611","updates":[{"expressionId":"7140479b-b697-4418-ae59-ad36b25fe8ee","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":384262}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"a647c160-59e7-43b7-810b-40b7a95b687e","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":285627}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"678ba098-e18a-4440-a82b-cc51b6f9a602","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":275438}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"a29e59ad-010f-46be-ae5a-f2d7fae91bc0","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":268846}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"0c0cdfd2-8ecd-4d17-80e3-4e0a6f9c2a27","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":4094051}}],"fromCache":false,"payload":{"type":"Value","warnings":null}}]}}.
[debug] [2023-04-28T10:34:19.227Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] no longer watched by Actor[akka://project-manager/system/Materializers/StreamSupervisor-0/$$Bc#-19996995]
[debug] [2023-04-28T10:34:19.227Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] stopped
^A[trace] [2023-04-28T10:34:22.82Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled FileAutoSaved(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso))) from Actor[akka://language-server/user/buffer-registry/collaborative-buffer-89f5f818-a4db-4f4c-b9de-54e2b648e590#-734177692]
[trace] [2023-04-28T10:34:22.821Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"text/autoSave","params":{"path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]}}}.
[trace] [2023-04-28T10:34:22.83Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: {"jsonrpc":"2.0","id":21,"method":"vcs/status","params":{"root":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[]}}}.
[trace] [2023-04-28T10:34:22.83Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled Request(StatusVcs,Number(21),Params(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector()))) from Actor[akka://language-server/user/message-handler-supervisor-038d1851-4e45-4f12-a32a-a612e5cc34cf/message-handler-6a53da52-7eb1-4841-87ab-2c70e9199256#2139308755]
[debug] [2023-04-28T10:34:22.831Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-6a53da52-7eb1-4841-87ab-2c70e9199256/request-handler-StatusVcs-bed3e90a-cda6-4acd-99f5-6bc149bbf417#1069765990]
[debug] [2023-04-28T10:34:22.831Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] started (org.enso.languageserver.requesthandler.vcs.StatusVcsHandler@1ef9a26f)
[debug] [2023-04-28T10:34:22.844Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] stopped
[trace] [2023-04-28T10:34:22.844Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":21,"result":{"dirty":true,"changed":[{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]},{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[".enso"]}],"lastSave":{"commitId":"16aa0b750d4da0bf08216edbc713e07879ca42c2","message":"2023-04-24T14:22:32.288282Z"}}}.
MichaelMauderer commented 1 year ago

And this is the log when switching from “False” to “True” (which results in the correct evaluation)

[trace] [2023-04-28T10:43:43.51Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled FileAutoSaved(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso))) from Actor[akka://language-server/user/buffer-registry/collaborative-buffer-89f5f818-a4db-4f4c-b9de-54e2b648e590#-734177692]
[trace] [2023-04-28T10:43:43.511Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"text/autoSave","params":{"path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]}}}.
[trace] [2023-04-28T10:43:43.535Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: {"jsonrpc":"2.0","id":29,"method":"vcs/status","params":{"root":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[]}}}.
[trace] [2023-04-28T10:43:43.536Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled Request(StatusVcs,Number(29),Params(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector()))) from Actor[akka://language-server/user/message-handler-supervisor-038d1851-4e45-4f12-a32a-a612e5cc34cf/message-handler-6a53da52-7eb1-4841-87ab-2c70e9199256#2139308755]
[debug] [2023-04-28T10:43:43.536Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-6a53da52-7eb1-4841-87ab-2c70e9199256/request-handler-StatusVcs-ee3ce797-36da-4489-be37-50bfffebeafb#-1407187538]
[debug] [2023-04-28T10:43:43.536Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] started (org.enso.languageserver.requesthandler.vcs.StatusVcsHandler@33dc7059)
[debug] [2023-04-28T10:43:43.545Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] stopped
[trace] [2023-04-28T10:43:43.545Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":29,"result":{"dirty":true,"changed":[{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]},{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[".enso"]}],"lastSave":{"commitId":"16aa0b750d4da0bf08216edbc713e07879ca42c2","message":"2023-04-24T14:22:32.288282Z"}}}.
[trace] [2023-04-28T10:43:45.029Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: {"jsonrpc":"2.0","id":30,"method":"text/applyEdit","params":{"edit":{"edits":[{"range":{"end":{"character":5085,"line":16},"start":{"character":4410,"line":16}},"text":"1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4\"],[{\"index\":{\"value\":258},\"size\":{\"value\":1}},\"4cd6d2a4-aa52-4fc2-837f-f203a4da5f48\"],[{\"index\":{\"value\":259},\"size\":{\"value\":4}},\"4df6ac87-16b6-417a-9217-840a328c0da5\"],[{\"index\":{\"value\":251},\"size\":{\"value\":12}},\"67ac7090-3f3f-46cc-8436-7c28a65cfba3\"],[{\"index\":{\"value\":194},\"size\":{\"value\":69}},\"a8d000c2-2494-44e0-91ad-b1c83a14a396\"],[{\"index\":{\"value\":182},\"size\":{\"value\":81}},\"a29e59ad-010f-46be-ae5a-f2d7fae91bc0\"],[{\"index\":{\"value\":116},\"size\":{\"value\":147}},\"82431656-f471-4640-b8aa-0ebf6a127127\"],[{\"index\":{\"value\":109},\"size\":{\"value\":154}},\"9f904285-40a4-49a2-8a84-c2b824e12867\"],[{\"index\":{\"value\":0},\"size\":{\"value\":266"},{"range":{"end":{"character":85,"line":9},"start":{"character":81,"line":9}},"text":"Tru"}],"newVersion":"796f1f73e1b06db7c0879be0a9d53caa518ac2efef6a6fa37b81a408","oldVersion":"d04c47f414b530c34f058bd359a85d377b36cb39a5a0a0398f367b7c","path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]}},"execute":true}}.
[trace] [2023-04-28T10:43:45.031Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled Request(ApplyEdit,Number(30),Params(FileEdit(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso)),List(TextEdit(Range(Position(16,4410),Position(16,5085)),1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4"],[{"index":{"value":258},"size":{"value":1}},"4cd6d2a4-aa52-4fc2-837f-f203a4da5f48"],[{"index":{"value":259},"size":{"value":4}},"4df6ac87-16b6-417a-9217-840a328c0da5"],[{"index":{"value":251},"size":{"value":12}},"67ac7090-3f3f-46cc-8436-7c28a65cfba3"],[{"index":{"value":194},"size":{"value":69}},"a8d000c2-2494-44e0-91ad-b1c83a14a396"],[{"index":{"value":182},"size":{"value":81}},"a29e59ad-010f-46be-ae5a-f2d7fae91bc0"],[{"index":{"value":116},"size":{"value":147}},"82431656-f471-4640-b8aa-0ebf6a127127"],[{"index":{"value":109},"size":{"value":154}},"9f904285-40a4-49a2-8a84-c2b824e12867"],[{"index":{"value":0},"size":{"value":266), TextEdit(Range(Position(9,81),Position(9,85)),Tru)),d04c47f414b530c34f058bd359a85d377b36cb39a5a0a0398f367b7c,796f1f73e1b06db7c0879be0a9d53caa518ac2efef6a6fa37b81a408),Some(true))) from Actor[akka://language-server/user/message-handler-supervisor-038d1851-4e45-4f12-a32a-a612e5cc34cf/message-handler-6a53da52-7eb1-4841-87ab-2c70e9199256#2139308755]
[debug] [2023-04-28T10:43:45.031Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-6a53da52-7eb1-4841-87ab-2c70e9199256/request-handler-ApplyEdit-fdcf52c5-4141-47a5-997e-d04b30d97979#1384243635]
[debug] [2023-04-28T10:43:45.031Z] [org.enso.languageserver.requesthandler.text.ApplyEditHandler] started (org.enso.languageserver.requesthandler.text.ApplyEditHandler@3bc3fa65)
[trace] [2023-04-28T10:43:45.033Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled Request(None,EditFileNotification(/home/michael/enso/projects/Namwd/src/Main.enso,List(TextEdit(Range(Position(16,4410),Position(16,5085)),1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4"],[{"index":{"value":258},"size":{"value":1}},"4cd6d2a4-aa52-4fc2-837f-f203a4da5f48"],[{"index":{"value":259},"size":{"value":4}},"4df6ac87-16b6-417a-9217-840a328c0da5"],[{"index":{"value":251},"size":{"value":12}},"67ac7090-3f3f-46cc-8436-7c28a65cfba3"],[{"index":{"value":194},"size":{"value":69}},"a8d000c2-2494-44e0-91ad-b1c83a14a396"],[{"index":{"value":182},"size":{"value":81}},"a29e59ad-010f-46be-ae5a-f2d7fae91bc0"],[{"index":{"value":116},"size":{"value":147}},"82431656-f471-4640-b8aa-0ebf6a127127"],[{"index":{"value":109},"size":{"value":154}},"9f904285-40a4-49a2-8a84-c2b824e12867"],[{"index":{"value":0},"size":{"value":266), TextEdit(Range(Position(9,81),Position(9,85)),Tru)),true)) from Actor[akka://language-server/user/buffer-registry/collaborative-buffer-89f5f818-a4db-4f4c-b9de-54e2b648e590#-734177692]
[trace] [2023-04-28T10:43:45.033Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":30,"result":null}.
[debug] [2023-04-28T10:43:45.033Z] [org.enso.languageserver.requesthandler.text.ApplyEditHandler] stopped
[debug] [2023-04-28T10:43:45.034Z] [enso] Executing command: EditFileCmd...
[debug] [2023-04-28T10:43:45.034Z] [enso] Submitting job: org.enso.interpreter.instrument.job.EnsureCompiledJob@47919ca0...
[debug] [2023-04-28T10:43:45.034Z] [enso] Executing job: org.enso.interpreter.instrument.job.EnsureCompiledJob@47919ca0...
[debug] [2023-04-28T10:43:45.035Z] [enso] Submitting job: org.enso.interpreter.instrument.job.ExecuteJob@3a64844...
[debug] [2023-04-28T10:43:45.035Z] [enso] Command EditFileCmd finished.
[trace] [2023-04-28T10:43:45.038Z] [enso] Compiling local.Namd.Main.
[debug] [2023-04-28T10:43:45.038Z] [enso.org.enso.compiler.Compiler] Parsing module [local.Namd.Main].
[trace] [2023-04-28T10:43:45.038Z] [enso.org.enso.compiler.ModuleCache] One or more digests did not match for the cache for [local.Namd.Main].
[trace] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.ModuleCache] Invalidated the cache at [***/Main.meta].
[trace] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.ModuleCache] Invalidated the cache at [***/Main.ir].
[trace] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.ModuleCache] Could not load the cache metadata at [***/Main.meta].
[trace] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.ModuleCache] Unable to load a cache [local.Namd.Main]
[debug] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.SerializationManager] Unable to load a cache for module [local.Namd.Main].
[debug] [2023-04-28T10:43:45.039Z] [enso.org.enso.compiler.Compiler] Loading module [local.Namd.Main] from source.
[trace] [2023-04-28T10:43:45.042Z] [enso.org.enso.compiler.ImportExportCache] Could not load the cache metadata at [***/Namd.bindings.meta].
[trace] [2023-04-28T10:43:45.042Z] [enso.org.enso.compiler.ImportExportCache] Could not load the cache metadata at [***/Namd.bindings.meta].
[trace] [2023-04-28T10:43:45.042Z] [enso.org.enso.compiler.ImportExportCache] Unable to load a cache [local.Namd]
[trace] [2023-04-28T10:43:45.042Z] [enso.org.enso.compiler.SerializationManager] Unable to load bindings for library [local.Namd].
[debug] [2023-04-28T10:43:45.054Z] [enso.org.enso.compiler.Compiler] Generating code for module [local.Namd.Main].
[debug] [2023-04-28T10:43:45.055Z] [enso] Executing command: SerializeModuleCommand...
[debug] [2023-04-28T10:43:45.055Z] [enso] Submitting job: org.enso.interpreter.instrument.job.SerializeModuleJob@278921a3...
[debug] [2023-04-28T10:43:45.055Z] [enso] Executing job: org.enso.interpreter.instrument.job.SerializeModuleJob@278921a3...
[debug] [2023-04-28T10:43:45.055Z] [enso] Command SerializeModuleCommand finished.
[debug] [2023-04-28T10:43:45.057Z] [enso] Submitting job: AnalyzeModuleJob(local.Namd.Main, ...)...
[trace] [2023-04-28T10:43:45.058Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,HashSet(ExpressionUpdate(9f904285-40a4-49a2-8a84-c2b824e12867,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(8f0fc0a2-6a6c-4425-93d2-02c257c4a718,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(c6c3bf31-1cb3-46b8-89f7-805c978fd522,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(4c06c832-230a-4dbd-ab4b-7949bad72330,None,None,Vector(),true,Pending(None,None)))))) from Actor[akka://language-server/deadLetters]
[debug] [2023-04-28T10:43:45.058Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [HashSet((a29e59ad-010f-46be-ae5a-f2d7fae91bc0,None), (9f904285-40a4-49a2-8a84-c2b824e12867,None), (4c06c832-230a-4dbd-ab4b-7949bad72330,None), (8f0fc0a2-6a6c-4425-93d2-02c257c4a718,None), (a8d000c2-2494-44e0-91ad-b1c83a14a396,None), (c6c3bf31-1cb3-46b8-89f7-805c978fd522,None))].
[trace] [2023-04-28T10:43:45.058Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,HashSet(ExpressionUpdate(9f904285-40a4-49a2-8a84-c2b824e12867,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(8f0fc0a2-6a6c-4425-93d2-02c257c4a718,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(c6c3bf31-1cb3-46b8-89f7-805c978fd522,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(4c06c832-230a-4dbd-ab4b-7949bad72330,None,None,Vector(),true,Pending(None,None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.058Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExecutionUpdate(10c1f90c-70cc-4f9b-b435-047420407611,List(Diagnostic(Warning(),Some(Unused variable operator2.),Some(/home/michael/enso/projects/Namwd/src/Main.enso),Some(Range(Position(9,4),Position(9,13))),Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),Vector()))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.058Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExecutionUpdate(contextId=10c1f90c-70cc-4f9b-b435-047420407611,diagnostics=List(Diagnostic(kind=Warning(),message=Some(***),file=Some(***/Main.enso),location=Some(Range(Position(9,4),Position(9,13))),expressionId=Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),stack=Vector()))) from Actor[akka://language-server/deadLetters]
[debug] [2023-04-28T10:43:45.059Z] [enso] Job org.enso.interpreter.instrument.job.EnsureCompiledJob@47919ca0 finished in 25 ms.
[debug] [2023-04-28T10:43:45.059Z] [enso.org.enso.compiler.SerializationManager] Requesting serialization for module [local.Namd.Main].
[debug] [2023-04-28T10:43:45.059Z] [enso] Executing job: org.enso.interpreter.instrument.job.ExecuteJob@3a64844...
[trace] [2023-04-28T10:43:45.059Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExecutionDiagnosticNotification(10c1f90c-70cc-4f9b-b435-047420407611,List(ExecutionDiagnostic(Warning,Some(Unused variable operator2.),Some(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso))),Some(Range(Position(9,4),Position(9,13))),Some(f1a6e471-4274-493c-9ba5-52564b86aa1b),Vector()))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.059Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/executionStatus","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611","diagnostics":[{"kind":"Warning","message":"Unused variable operator2.","path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]},"location":{"start":{"line":9,"character":4},"end":{"line":9,"character":13}},"expressionId":"f1a6e471-4274-493c-9ba5-52564b86aa1b","stack":[]}]}}.
[debug] [2023-04-28T10:43:45.06Z] [enso.org.enso.compiler.SerializationManager] Running serialization for module [local.Namd.Main].
[trace] [2023-04-28T10:43:45.068Z] [enso.org.enso.compiler.ModuleCache] Written cache data [local.Namd.Main] to [***/Namd].
[debug] [2023-04-28T10:43:45.069Z] [enso] Job org.enso.interpreter.instrument.job.SerializeModuleJob@278921a3 finished in 14 ms.
[trace] [2023-04-28T10:43:45.069Z] [enso] Run program 10c1f90c-70cc-4f9b-b435-047420407611
[debug] [2023-04-28T10:43:45.069Z] [enso] Executing job: AnalyzeModuleJob(local.Namd.Main, ...)...
[trace] [2023-04-28T10:43:45.069Z] [enso] Analyzing indexed module local.Namd.Main
[debug] [2023-04-28T10:43:45.071Z] [enso] Job AnalyzeModuleJob(local.Namd.Main, ...) finished in 2 ms.
[trace] [2023-04-28T10:43:45.072Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,SuggestionsDatabaseModuleUpdateNotification(local.Namd.Main,Vector(),Vector(),Root(Vector(Node(SuggestionUpdate(Method(Some(8f0fc0a2-6a6c-4425-93d2-02c257c4a718),local.Namd.Main,main,List(),local.Namd.Main,Standard.Base.Any.Any,true,None,None),Modify(Some(Some(82431656-f471-4640-b8aa-0ebf6a127127)),None,None,None,None,None)),Vector(Node(SuggestionUpdate(Local(Some(d5cb58c5-45c7-4223-bdc9-5477fdd6e6e0),local.Namd.Main,text2,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,86)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(0236ab58-fc0d-4af1-b2e1-8835b801980d),local.Namd.Main,text1,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,86)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(641c7f6d-15f5-4375-b698-a0926818dd3e),local.Namd.Main,text3,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,86)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector()), Node(SuggestionUpdate(Local(Some(a8d000c2-2494-44e0-91ad-b1c83a14a396),local.Namd.Main,operator2,Standard.Base.Any.Any,Scope(Position(5,7),Position(9,86)),None),Modify(None,None,None,None,Some(Scope(Position(5,7),Position(9,85))),None)),Vector())))))))) from Actor[akka://language-server/deadLetters]
[debug] [2023-04-28T10:43:45.072Z] [org.enso.languageserver.search.SuggestionsHandler] Got module update [local.Namd.Main].
[trace] [2023-04-28T10:43:45.072Z] [enso] ON_CACHED_VALUE d5cb58c5-45c7-4223-bdc9-5477fdd6e6e0
[trace] [2023-04-28T10:43:45.072Z] [enso] ON_COMPUTED 7140479b-b697-4418-ae59-ad36b25fe8ee
[trace] [2023-04-28T10:43:45.073Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(241253)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.073Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(241253)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.073Z] [enso] ON_CACHED_VALUE 0236ab58-fc0d-4af1-b2e1-8835b801980d
[trace] [2023-04-28T10:43:45.073Z] [enso] ON_COMPUTED a647c160-59e7-43b7-810b-40b7a95b687e
[trace] [2023-04-28T10:43:45.074Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(218510)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.074Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(218510)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.074Z] [enso] ON_CACHED_VALUE 641c7f6d-15f5-4375-b698-a0926818dd3e
[trace] [2023-04-28T10:43:45.074Z] [enso] ON_COMPUTED 678ba098-e18a-4440-a82b-cc51b6f9a602
[trace] [2023-04-28T10:43:45.074Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(107542)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.074Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(107542)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.074Z] [enso] ON_COMPUTED e9ee4d72-6cbb-4f52-a929-f4061aa56966
[trace] [2023-04-28T10:43:45.075Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(e9ee4d72-6cbb-4f52-a929-f4061aa56966,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3036)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.075Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(e9ee4d72-6cbb-4f52-a929-f4061aa56966,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3036)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.075Z] [enso] ON_COMPUTED 481e6db2-7e1a-4535-9ceb-ffa1935997ea
[debug] [2023-04-28T10:43:45.075Z] [enso] Executing visualisation 481e6db2-7e1a-4535-9ceb-ffa1935997ea
[trace] [2023-04-28T10:43:45.075Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(481e6db2-7e1a-4535-9ceb-ffa1935997ea,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(75232)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.075Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(481e6db2-7e1a-4535-9ceb-ffa1935997ea,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(75232)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.078Z] [enso] Visualisation computed 481e6db2-7e1a-4535-9ceb-ffa1935997ea.
[trace] [2023-04-28T10:43:45.079Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,VisualisationUpdate(VisualisationContext(4b72dc3d-c380-499f-846d-6e898a2fa2c4,10c1f90c-70cc-4f9b-b435-047420407611,481e6db2-7e1a-4535-9ceb-ffa1935997ea),[B@620d18c4))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.079Z] [org.enso.languageserver.runtime.ContextRegistry] received handled VisualisationUpdate(visualisationContext=VisualisationContext(4b72dc3d-c380-499f-846d-6e898a2fa2c4,10c1f90c-70cc-4f9b-b435-047420407611,481e6db2-7e1a-4535-9ceb-ffa1935997ea),data=***) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.079Z] [enso] ON_COMPUTED 6038638a-c32b-48de-97ee-313c18c8e2df
[trace] [2023-04-28T10:43:45.08Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(6038638a-c32b-48de-97ee-313c18c8e2df,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(89939)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.08Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(6038638a-c32b-48de-97ee-313c18c8e2df,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(89939)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.08Z] [enso] ON_COMPUTED b923f692-1b33-4cd6-8c1f-bc0d1b346a12
[trace] [2023-04-28T10:43:45.081Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(b923f692-1b33-4cd6-8c1f-bc0d1b346a12,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(90720)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.081Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(b923f692-1b33-4cd6-8c1f-bc0d1b346a12,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(90720)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.082Z] [enso] ON_COMPUTED 38c97975-c992-47e0-8eeb-218b2b8c4701
[trace] [2023-04-28T10:43:45.082Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(38c97975-c992-47e0-8eeb-218b2b8c4701,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3777)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.082Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(38c97975-c992-47e0-8eeb-218b2b8c4701,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3777)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.083Z] [enso] ON_COMPUTED dbc2c858-3cfd-47b0-8c9c-f36041ec19a3
[debug] [2023-04-28T10:43:45.083Z] [enso] Executing visualisation dbc2c858-3cfd-47b0-8c9c-f36041ec19a3
[trace] [2023-04-28T10:43:45.083Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(dbc2c858-3cfd-47b0-8c9c-f36041ec19a3,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type),None,Vector(ExecutionTime(4198)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.083Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(dbc2c858-3cfd-47b0-8c9c-f36041ec19a3,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type),None,Vector(ExecutionTime(4198)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.086Z] [enso] Visualisation computed dbc2c858-3cfd-47b0-8c9c-f36041ec19a3.
[trace] [2023-04-28T10:43:45.086Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,VisualisationUpdate(VisualisationContext(4d02fa62-c7a0-42bd-b3fa-80ef4a40cee7,10c1f90c-70cc-4f9b-b435-047420407611,dbc2c858-3cfd-47b0-8c9c-f36041ec19a3),[B@7b95c21b))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.086Z] [org.enso.languageserver.runtime.ContextRegistry] received handled VisualisationUpdate(visualisationContext=VisualisationContext(4d02fa62-c7a0-42bd-b3fa-80ef4a40cee7,10c1f90c-70cc-4f9b-b435-047420407611,dbc2c858-3cfd-47b0-8c9c-f36041ec19a3),data=***) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.087Z] [enso] ON_COMPUTED 05b4147b-2e78-4ae6-81a1-7c65f5588ca2
[trace] [2023-04-28T10:43:45.087Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(05b4147b-2e78-4ae6-81a1-7c65f5588ca2,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity),Some(MethodPointer(Standard.Base.Data.Text.Case_Sensitivity,Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity,Insensitive)),Vector(ExecutionTime(4969585)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.087Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(05b4147b-2e78-4ae6-81a1-7c65f5588ca2,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity),Some(MethodPointer(Standard.Base.Data.Text.Case_Sensitivity,Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity,Insensitive)),Vector(ExecutionTime(4969585)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.088Z] [enso] ON_COMPUTED 4df6ac87-16b6-417a-9217-840a328c0da5
[trace] [2023-04-28T10:43:45.088Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(4df6ac87-16b6-417a-9217-840a328c0da5,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(2184)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.088Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(4df6ac87-16b6-417a-9217-840a328c0da5,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(2184)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.088Z] [enso] ON_COMPUTED 1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4
[trace] [2023-04-28T10:43:45.089Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4,Some(Standard.Base.Data.Boolean.Boolean.type),None,Vector(ExecutionTime(2524)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.089Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4,Some(Standard.Base.Data.Boolean.Boolean.type),None,Vector(ExecutionTime(2524)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.089Z] [enso] ON_COMPUTED 67ac7090-3f3f-46cc-8436-7c28a65cfba3
[trace] [2023-04-28T10:43:45.089Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(67ac7090-3f3f-46cc-8436-7c28a65cfba3,Some(Standard.Base.Data.Boolean.Boolean),Some(MethodPointer(Standard.Builtins.Main,Standard.Base.Data.Boolean.Boolean,True)),Vector(ExecutionTime(1236631)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.09Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(67ac7090-3f3f-46cc-8436-7c28a65cfba3,Some(Standard.Base.Data.Boolean.Boolean),Some(MethodPointer(Standard.Builtins.Main,Standard.Base.Data.Boolean.Boolean,True)),Vector(ExecutionTime(1236631)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.091Z] [enso] ON_COMPUTED a8d000c2-2494-44e0-91ad-b1c83a14a396
[debug] [2023-04-28T10:43:45.091Z] [enso] Executing visualisation a8d000c2-2494-44e0-91ad-b1c83a14a396
[trace] [2023-04-28T10:43:45.091Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,Some(Standard.Base.Data.Text.Text),Some(MethodPointer(Standard.Base.Data.Text.Extensions,Standard.Base.Data.Text.Text,replace)),Vector(ExecutionTime(16129906)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.091Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,Some(Standard.Base.Data.Text.Text),Some(MethodPointer(Standard.Base.Data.Text.Extensions,Standard.Base.Data.Text.Text,replace)),Vector(ExecutionTime(16129906)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.093Z] [enso] Visualisation computed a8d000c2-2494-44e0-91ad-b1c83a14a396.
[trace] [2023-04-28T10:43:45.093Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,VisualisationUpdate(VisualisationContext(f58b780c-87f1-4446-9fab-d31a36d4fc71,10c1f90c-70cc-4f9b-b435-047420407611,a8d000c2-2494-44e0-91ad-b1c83a14a396),[B@73731ea7))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.093Z] [org.enso.languageserver.runtime.ContextRegistry] received handled VisualisationUpdate(visualisationContext=VisualisationContext(f58b780c-87f1-4446-9fab-d31a36d4fc71,10c1f90c-70cc-4f9b-b435-047420407611,a8d000c2-2494-44e0-91ad-b1c83a14a396),data=***) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.093Z] [enso] ON_COMPUTED a29e59ad-010f-46be-ae5a-f2d7fae91bc0
[trace] [2023-04-28T10:43:45.093Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(18684248)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.094Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(18684248)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.094Z] [enso] ON_COMPUTED 82431656-f471-4640-b8aa-0ebf6a127127
[trace] [2023-04-28T10:43:45.094Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(82431656-f471-4640-b8aa-0ebf6a127127,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(21491596)),false,Value(None)))))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.094Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExpressionUpdates(10c1f90c-70cc-4f9b-b435-047420407611,Set(ExpressionUpdate(82431656-f471-4640-b8aa-0ebf6a127127,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(21491596)),false,Value(None)))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.095Z] [enso] ON_CACHED_CALL da068482-37f0-41f7-bf3a-6ea624a99953
[trace] [2023-04-28T10:43:45.095Z] [enso] ON_CACHED_CALL d06d9ff5-06ac-4d95-af5b-314db608bb13
[trace] [2023-04-28T10:43:45.095Z] [enso] ON_CACHED_CALL c6c3bf31-1cb3-46b8-89f7-805c978fd522
[trace] [2023-04-28T10:43:45.095Z] [enso] Execution finished: Right(())
[debug] [2023-04-28T10:43:45.095Z] [enso] Job org.enso.interpreter.instrument.job.ExecuteJob@3a64844 finished in 36 ms.
[trace] [2023-04-28T10:43:45.095Z] [org.enso.languageserver.runtime.RuntimeConnector] received handled MessageFromRuntime(Response(None,ExecutionComplete(10c1f90c-70cc-4f9b-b435-047420407611))) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.095Z] [org.enso.languageserver.runtime.ContextRegistry] received handled ExecutionComplete(10c1f90c-70cc-4f9b-b435-047420407611) from Actor[akka://language-server/deadLetters]
[trace] [2023-04-28T10:43:45.095Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExecutionCompleteNotification(10c1f90c-70cc-4f9b-b435-047420407611) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.096Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/executionComplete","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611"}}.
[debug] [2023-04-28T10:43:45.118Z] [org.enso.languageserver.search.SuggestionsHandler] Complete module update [local.Namd.Main].
[debug] [2023-04-28T10:43:45.118Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing)))].
[trace] [2023-04-28T10:43:45.118Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled SuggestionsDatabaseUpdateNotification(76,List(Modify(2,Some(FieldUpdate(Set,Some(82431656-f471-4640-b8aa-0ebf6a127127))),None,None,None,None,None,None,None), Modify(3,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(4,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(5,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None), Modify(6,None,None,None,None,None,None,Some(FieldUpdate(Set,Some(Scope(Position(5,7),Position(9,85))))),None))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.119Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"search/suggestionsDatabaseUpdates","params":{"updates":[{"type":"Modify","id":2,"externalId":{"tag":"Set","value":"82431656-f471-4640-b8aa-0ebf6a127127"}},{"type":"Modify","id":3,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":4,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":5,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}},{"type":"Modify","id":6,"scope":{"tag":"Set","value":{"start":{"line":5,"character":7},"end":{"line":9,"character":85}}}}],"currentVersion":76}}.
[debug] [2023-04-28T10:43:45.123Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing)))].
[debug] [2023-04-28T10:43:45.128Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing)))].
[debug] [2023-04-28T10:43:45.133Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((e9ee4d72-6cbb-4f52-a929-f4061aa56966,Some(Standard.Builtins.Main.Unresolved_Symbol)))].
[debug] [2023-04-28T10:43:45.137Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((481e6db2-7e1a-4535-9ceb-ffa1935997ea,Some(Standard.Base.Data.Text.Text)))].
[debug] [2023-04-28T10:43:45.142Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((6038638a-c32b-48de-97ee-313c18c8e2df,Some(Standard.Base.Data.Text.Text)))].
[debug] [2023-04-28T10:43:45.145Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((b923f692-1b33-4cd6-8c1f-bc0d1b346a12,Some(Standard.Base.Data.Text.Text)))].
[debug] [2023-04-28T10:43:45.148Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((38c97975-c992-47e0-8eeb-218b2b8c4701,Some(Standard.Builtins.Main.Unresolved_Symbol)))].
[debug] [2023-04-28T10:43:45.15Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((dbc2c858-3cfd-47b0-8c9c-f36041ec19a3,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type)))].
[debug] [2023-04-28T10:43:45.154Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((05b4147b-2e78-4ae6-81a1-7c65f5588ca2,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity)))].
[debug] [2023-04-28T10:43:45.158Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((4df6ac87-16b6-417a-9217-840a328c0da5,Some(Standard.Builtins.Main.Unresolved_Symbol)))].
[debug] [2023-04-28T10:43:45.162Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4,Some(Standard.Base.Data.Boolean.Boolean.type)))].
[debug] [2023-04-28T10:43:45.166Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((67ac7090-3f3f-46cc-8436-7c28a65cfba3,Some(Standard.Base.Data.Boolean.Boolean)))].
[debug] [2023-04-28T10:43:45.171Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((a8d000c2-2494-44e0-91ad-b1c83a14a396,Some(Standard.Base.Data.Text.Text)))].
[debug] [2023-04-28T10:43:45.177Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing)))].
[trace] [2023-04-28T10:43:45.177Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled SuggestionsDatabaseUpdateNotification(77,List(Modify(6,None,None,None,None,Some(FieldUpdate(Set,Some(Standard.Base.Data.Text.Text))),None,None,None))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.178Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"search/suggestionsDatabaseUpdates","params":{"updates":[{"type":"Modify","id":6,"returnType":{"tag":"Set","value":"Standard.Base.Data.Text.Text"}}],"currentVersion":77}}.
[debug] [2023-04-28T10:43:45.182Z] [org.enso.languageserver.search.SuggestionsHandler] Received expression updates [Set((82431656-f471-4640-b8aa-0ebf6a127127,Some(Standard.Base.Nothing.Nothing)))].
[trace] [2023-04-28T10:43:45.188Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled SuggestionsDatabaseUpdateNotification(78,List(Modify(2,None,None,None,None,Some(FieldUpdate(Set,Some(Standard.Base.Nothing.Nothing))),None,None,None))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.188Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"search/suggestionsDatabaseUpdates","params":{"updates":[{"type":"Modify","id":2,"returnType":{"tag":"Set","value":"Standard.Base.Nothing.Nothing"}}],"currentVersion":78}}.
[trace] [2023-04-28T10:43:45.897Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled ExpressionUpdatesNotification(10c1f90c-70cc-4f9b-b435-047420407611,Vector(ExpressionUpdate(9f904285-40a4-49a2-8a84-c2b824e12867,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(8f0fc0a2-6a6c-4425-93d2-02c257c4a718,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(c6c3bf31-1cb3-46b8-89f7-805c978fd522,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(4c06c832-230a-4dbd-ab4b-7949bad72330,None,None,Vector(),true,Pending(None,None)), ExpressionUpdate(7140479b-b697-4418-ae59-ad36b25fe8ee,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(241253)),false,Value(None)), ExpressionUpdate(a647c160-59e7-43b7-810b-40b7a95b687e,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(218510)),false,Value(None)), ExpressionUpdate(678ba098-e18a-4440-a82b-cc51b6f9a602,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(107542)),false,Value(None)), ExpressionUpdate(e9ee4d72-6cbb-4f52-a929-f4061aa56966,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3036)),false,Value(None)), ExpressionUpdate(481e6db2-7e1a-4535-9ceb-ffa1935997ea,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(75232)),false,Value(None)), ExpressionUpdate(6038638a-c32b-48de-97ee-313c18c8e2df,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(89939)),false,Value(None)), ExpressionUpdate(b923f692-1b33-4cd6-8c1f-bc0d1b346a12,Some(Standard.Base.Data.Text.Text),None,Vector(ExecutionTime(90720)),false,Value(None)), ExpressionUpdate(38c97975-c992-47e0-8eeb-218b2b8c4701,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(3777)),false,Value(None)), ExpressionUpdate(dbc2c858-3cfd-47b0-8c9c-f36041ec19a3,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type),None,Vector(ExecutionTime(4198)),false,Value(None)), ExpressionUpdate(05b4147b-2e78-4ae6-81a1-7c65f5588ca2,Some(Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity),Some(MethodPointer(Standard.Base.Data.Text.Case_Sensitivity,Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity,Insensitive)),Vector(ExecutionTime(4969585)),false,Value(None)), ExpressionUpdate(4df6ac87-16b6-417a-9217-840a328c0da5,Some(Standard.Builtins.Main.Unresolved_Symbol),None,Vector(ExecutionTime(2184)),false,Value(None)), ExpressionUpdate(1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4,Some(Standard.Base.Data.Boolean.Boolean.type),None,Vector(ExecutionTime(2524)),false,Value(None)), ExpressionUpdate(67ac7090-3f3f-46cc-8436-7c28a65cfba3,Some(Standard.Base.Data.Boolean.Boolean),Some(MethodPointer(Standard.Builtins.Main,Standard.Base.Data.Boolean.Boolean,True)),Vector(ExecutionTime(1236631)),false,Value(None)), ExpressionUpdate(a8d000c2-2494-44e0-91ad-b1c83a14a396,Some(Standard.Base.Data.Text.Text),Some(MethodPointer(Standard.Base.Data.Text.Extensions,Standard.Base.Data.Text.Text,replace)),Vector(ExecutionTime(16129906)),false,Value(None)), ExpressionUpdate(a29e59ad-010f-46be-ae5a-f2d7fae91bc0,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(18684248)),false,Value(None)), ExpressionUpdate(82431656-f471-4640-b8aa-0ebf6a127127,Some(Standard.Base.Nothing.Nothing),None,Vector(ExecutionTime(21491596)),false,Value(None)))) from Actor[akka://language-server/user/session-router#-1360238726]
[trace] [2023-04-28T10:43:45.898Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"executionContext/expressionUpdates","params":{"contextId":"10c1f90c-70cc-4f9b-b435-047420407611","updates":[{"expressionId":"9f904285-40a4-49a2-8a84-c2b824e12867","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"a29e59ad-010f-46be-ae5a-f2d7fae91bc0","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"a8d000c2-2494-44e0-91ad-b1c83a14a396","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"8f0fc0a2-6a6c-4425-93d2-02c257c4a718","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"c6c3bf31-1cb3-46b8-89f7-805c978fd522","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"4c06c832-230a-4dbd-ab4b-7949bad72330","type":null,"methodPointer":null,"profilingInfo":[],"fromCache":true,"payload":{"type":"Pending","message":null,"progress":null}},{"expressionId":"7140479b-b697-4418-ae59-ad36b25fe8ee","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":241253}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"a647c160-59e7-43b7-810b-40b7a95b687e","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":218510}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"678ba098-e18a-4440-a82b-cc51b6f9a602","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":107542}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"e9ee4d72-6cbb-4f52-a929-f4061aa56966","type":"Standard.Builtins.Main.Unresolved_Symbol","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":3036}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"481e6db2-7e1a-4535-9ceb-ffa1935997ea","type":"Standard.Base.Data.Text.Text","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":75232}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"6038638a-c32b-48de-97ee-313c18c8e2df","type":"Standard.Base.Data.Text.Text","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":89939}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"b923f692-1b33-4cd6-8c1f-bc0d1b346a12","type":"Standard.Base.Data.Text.Text","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":90720}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"38c97975-c992-47e0-8eeb-218b2b8c4701","type":"Standard.Builtins.Main.Unresolved_Symbol","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":3777}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"dbc2c858-3cfd-47b0-8c9c-f36041ec19a3","type":"Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity.type","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":4198}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"05b4147b-2e78-4ae6-81a1-7c65f5588ca2","type":"Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity","methodPointer":{"module":"Standard.Base.Data.Text.Case_Sensitivity","definedOnType":"Standard.Base.Data.Text.Case_Sensitivity.Case_Sensitivity","name":"Insensitive"},"profilingInfo":[{"ExecutionTime":{"nanoTime":4969585}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"4df6ac87-16b6-417a-9217-840a328c0da5","type":"Standard.Builtins.Main.Unresolved_Symbol","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":2184}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"1fd1720e-58f6-4ba2-928d-0bfb4a51d2a4","type":"Standard.Base.Data.Boolean.Boolean.type","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":2524}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"67ac7090-3f3f-46cc-8436-7c28a65cfba3","type":"Standard.Base.Data.Boolean.Boolean","methodPointer":{"module":"Standard.Builtins.Main","definedOnType":"Standard.Base.Data.Boolean.Boolean","name":"True"},"profilingInfo":[{"ExecutionTime":{"nanoTime":1236631}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"a8d000c2-2494-44e0-91ad-b1c83a14a396","type":"Standard.Base.Data.Text.Text","methodPointer":{"module":"Standard.Base.Data.Text.Extensions","definedOnType":"Standard.Base.Data.Text.Text","name":"replace"},"profilingInfo":[{"ExecutionTime":{"nanoTime":16129906}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"a29e59ad-010f-46be-ae5a-f2d7fae91bc0","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":18684248}}],"fromCache":false,"payload":{"type":"Value","warnings":null}},{"expressionId":"82431656-f471-4640-b8aa-0ebf6a127127","type":"Standard.Base.Nothing.Nothing","methodPointer":null,"profilingInfo":[{"ExecutionTime":{"nanoTime":21491596}}],"fromCache":false,"payload":{"type":"Value","warnings":null}}]}}.
[debug] [2023-04-28T10:43:45.968Z] [org.enso.projectmanager.infrastructure.languageserver.LanguageServerSupervisor] now supervising Actor[akka://project-manager/user/language-server-registry/language-server-controller-306aec02-8554-4da8-86a7-0c8681f1bc5a/supervisor-language-server-306aec02-8554-4da8-86a7-0c8681f1bc5a/heartbeat-e5cce8d5-3394-4bae-825a-f9b2fca68885#-880025034]
[debug] [2023-04-28T10:43:45.968Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] started (org.enso.projectmanager.infrastructure.http.FanOutReceiver@5456e201)
[debug] [2023-04-28T10:43:45.971Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Heartbeat connection initialized [Socket(127.0.0.1,49467)].
[debug] [2023-04-28T10:43:45.971Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] started (org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession@4ab0a493)
[debug] [2023-04-28T10:43:45.971Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] now watched by Actor[akka://project-manager/system/Materializers/StreamSupervisor-0/$$ne#1529743927]
[debug] [2023-04-28T10:43:45.976Z] [org.enso.jsonrpc.MessageHandlerSupervisor] started (org.enso.jsonrpc.MessageHandlerSupervisor@14985abd)
[debug] [2023-04-28T10:43:45.977Z] [org.enso.jsonrpc.MessageHandler] started (org.enso.jsonrpc.MessageHandler@39d055eb)
[debug] [2023-04-28T10:43:45.977Z] [org.enso.languageserver.protocol.json.JsonConnectionController] started (org.enso.languageserver.protocol.json.JsonConnectionController@1eea004a)
[debug] [2023-04-28T10:43:45.984Z] [org.enso.jsonrpc.MessageHandlerSupervisor] now supervising Actor[akka://language-server/user/message-handler-supervisor-a5bf4c7f-2420-4eae-aaa6-09e459a8b7a1/message-handler-bafc4f53-df2e-4d10-9662-14dc3a9d524f#1834671724]
[debug] [2023-04-28T10:43:45.989Z] [org.enso.jsonrpc.MessageHandlerSupervisor] now watched by Actor[akka://language-server/system/Materializers/StreamSupervisor-0/$$Fd#2104703007]
[debug] [2023-04-28T10:43:45.99Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Sending ping message to Socket(127.0.0.1,49467).
[trace] [2023-04-28T10:43:45.992Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: 
{ 
   "jsonrpc": "2.0",
   "method": "heartbeat/ping",
   "id": "da332cfe-c6f9-41b1-b194-6dfe038ac8f4",
   "params": null
}
.
[debug] [2023-04-28T10:43:45.992Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-bafc4f53-df2e-4d10-9662-14dc3a9d524f/$a#-1527119543]
[debug] [2023-04-28T10:43:45.992Z] [org.enso.languageserver.requesthandler.monitoring.PingHandler] started (org.enso.languageserver.requesthandler.monitoring.PingHandler@57ec4a63)
[debug] [2023-04-28T10:43:45.993Z] [org.enso.languageserver.requesthandler.monitoring.PingHandler] stopped
[trace] [2023-04-28T10:43:45.993Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":"da332cfe-c6f9-41b1-b194-6dfe038ac8f4","result":null}.
[debug] [2023-04-28T10:43:45.993Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] Received correct pong message from Socket(127.0.0.1,49467).
[debug] [2023-04-28T10:43:45.995Z] [org.enso.jsonrpc.MessageHandler] stopped
[debug] [2023-04-28T10:43:45.995Z] [org.enso.jsonrpc.MessageHandlerSupervisor] no longer watched by Actor[akka://language-server/system/Materializers/StreamSupervisor-0/$$Fd#2104703007]
[debug] [2023-04-28T10:43:45.995Z] [org.enso.languageserver.protocol.json.JsonConnectionController] stopped
^A[trace] [2023-04-28T10:43:51.05Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled FileAutoSaved(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector(src, Main.enso))) from Actor[akka://language-server/user/buffer-registry/collaborative-buffer-89f5f818-a4db-4f4c-b9de-54e2b648e590#-734177692]
[trace] [2023-04-28T10:43:51.051Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","method":"text/autoSave","params":{"path":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]}}}.
[trace] [2023-04-28T10:43:51.068Z] [org.enso.jsonrpc.JsonRpcServer] Received text message: {"jsonrpc":"2.0","id":31,"method":"vcs/status","params":{"root":{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[]}}}.
[trace] [2023-04-28T10:43:51.069Z] [org.enso.languageserver.protocol.json.JsonConnectionController] received handled Request(StatusVcs,Number(31),Params(Path(1c89091f-eb5a-4419-bfda-2b54f1f432c2,Vector()))) from Actor[akka://language-server/user/message-handler-supervisor-038d1851-4e45-4f12-a32a-a612e5cc34cf/message-handler-6a53da52-7eb1-4841-87ab-2c70e9199256#2139308755]
[debug] [2023-04-28T10:43:51.069Z] [org.enso.languageserver.protocol.json.JsonConnectionController] now supervising Actor[akka://language-server/user/json-connection-controller-6a53da52-7eb1-4841-87ab-2c70e9199256/request-handler-StatusVcs-d0840817-c15d-4827-893b-565fc1f32870#-16659101]
[debug] [2023-04-28T10:43:51.069Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] started (org.enso.languageserver.requesthandler.vcs.StatusVcsHandler@7395f26e)
[debug] [2023-04-28T10:43:51.077Z] [org.enso.languageserver.requesthandler.vcs.StatusVcsHandler] stopped
[trace] [2023-04-28T10:43:51.078Z] [org.enso.jsonrpc.JsonRpcServer] Sent text message {"jsonrpc":"2.0","id":31,"result":{"dirty":true,"changed":[{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":["src","Main.enso"]},{"rootId":"1c89091f-eb5a-4419-bfda-2b54f1f432c2","segments":[".enso"]}],"lastSave":{"commitId":"16aa0b750d4da0bf08216edbc713e07879ca42c2","message":"2023-04-24T14:22:32.288282Z"}}}.
[debug] [2023-04-28T10:43:52.247Z] [org.enso.projectmanager.infrastructure.languageserver.HeartbeatSession] stopped
[debug] [2023-04-28T10:43:52.247Z] [org.enso.projectmanager.infrastructure.http.FanOutReceiver] no longer watc
vitvakatu commented 1 year ago

@JaroslavTulach returning to triage as it seems to be an engine issue.

MichaelMauderer commented 1 year ago

I don't think it needs to be triage, just re-distributed.

JaroslavTulach commented 1 year ago

Thanks for the reproducer. I'll start from it early next week. Tuesday follow up: I can reproduce the problem:

I believe this will have something to do with start/end offset of the expression. When the edit adds something at the end of the replace expression, the cache isn't invalidated. When there is a trailing use_regexp... and the edit is before, the cache gets invalidated. Such an extra text has to be on the same line. Following workaround fixes the behavior:

enso$ git diff
diff --git engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
index 5445e48fec..ebaa6d8fe3 100644
--- engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
+++ engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
@@ -402,10 +402,10 @@ object ChangesetBuilder {
     * @return true if the node and edit locations are intersecting
     */
   private def intersect(edit: Location, node: Location): Boolean = {
-    inside(node.start, edit) ||
-    inside(node.end, edit) ||
-    inside(edit.start, node) ||
-    inside(edit.end, node)
+    inside(node.start - 1, edit) ||
+    inside(node.end + 1, edit) ||
+    inside(edit.start - 1, node) ||
+    inside(edit.end + 1, node)
   }

   /** Check if the character position index is inside the location.

Conclusion: Probably caused by "off-by-one" error introduced when "switching to the new parser" - an adjustment of possitions like in CodeLocationsTest - I believe previously the end of line was part of the text2.replace ... invocation. These days the end of line isn't included - e.g. when adding text to the end of line, it is not treated as a change to the text2.replace ... invocation. CCing @kazcw, @4e6

enso-bot[bot] commented 1 year ago

Jaroslav Tulach reports a new 🔴 DELAY for yesterday (2023-05-02):

Summary: There is 9 days delay in implementation of the When picking a Boolean value via the dropdown doesn't recalculate correctly. (#6221) task. It will cause 0 days delay for the delivery of this weekly plan.

I've just got assigned to the issue

Delay Cause: Restarting work after transfer of the issue

Possible solutions: Transfer the issue sooner than the original estimate "time outs"

enso-bot[bot] commented 1 year ago

Jaroslav Tulach reports a new STANDUP for yesterday (2023-05-02):

Progress: - investigation of Boolean default argument value: https://github.com/enso-org/enso/issues/6221#issuecomment-1527714175

Next Day: Fixing boolean default argument & other bugfixes

JaroslavTulach commented 1 year ago

Probably caused by "off-by-one" error

I am not sure anymore it is "off-by-one" error. We are talking about IDE requesting an edit to

 operator2 = text2.replace text1 text3 (Case_Sensitivity.Insensitive)

line trying to change into 

 operator2 = text2.replace text1 text3 (Case_Sensitivity.Insensitive) Boolean.True

the edit is happening after the closing ) however nobody "listens" on whole expression assigned to operator2. The closest section being observed represents Insensitive - and that is clearly not changing. The IDE is observing at this particular line:

I guess the engine should somehow figure out that by adding one more parameter to the line, the value of operator2 is supposed to be changed, but I believe it doesn't find that out. @4e6?

4e6 commented 1 year ago

Even if the edit does not affect other function arguments, the engine should detect that the Boolean.True expression has changed (appeared), and invalidate all the transitive dependencies, including the operator2 value.

JaroslavTulach commented 1 year ago

I see there is a RuntimeCache entry for text2.replace text1 text3 (Case_Sensitivity.Insensitive) Boolean.True - but it hasn't been iterated over in ChangesetBuilder.invalidated for some reason... clearly the UUID is present in "metadata" section, but it is not in the tree used by ChangesetBuilder.

4e6 commented 1 year ago

My guess would be that the UUID is updated after the edit. But I don't think it's the issue. Instead, we should make sure that in the scenario, given

foo a=1 b=1 = a + b

main = foo 1

when changing foo 1 to foo 1 2,

then engine invalidates dependencies of the 2 expression.

Right now we use the ChngesetBuilder to get all the expressions that were affected by the change in the existing IR (before applying the change). In this case, it's not enough. We should also detect all the new expressions that appeared after the edit (after applying the change), and invalidate their dependencies as well.

4e6 commented 1 year ago

You may wrap the first expression in the brackets to reproduce the issue, i.e.

changing foo (1) to foo (1) 2

enso-bot[bot] commented 1 year ago

Jaroslav Tulach reports a new STANDUP for yesterday (2023-05-03):

Progress: - debugging Boolean: https://github.com/enso-org/enso/issues/6221#issuecomment-1533244729

Next Day: Fixing boolean default argument & other bugfixes

Discord
Discord - A New Way to Chat with Friends & Communities
Discord is the easiest way to communicate over voice, video, and text. Chat, hang out, and stay close with your friends and communities.
Discord
Discord - A New Way to Chat with Friends & Communities
Discord is the easiest way to communicate over voice, video, and text. Chat, hang out, and stay close with your friends and communities.
JaroslavTulach commented 1 year ago

This is the correct fix:

diff --git engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
index 5445e48fec..1783f1772f 100644
--- engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
+++ engine/runtime/src/main/scala/org/enso/compiler/context/ChangesetBuilder.scala
@@ -341,9 +341,7 @@ object ChangesetBuilder {
       if (input.isEmpty) acc
       else {
         val ir = input.dequeue()
-        if (ir.children.isEmpty) {
-          Node.fromIr(ir).foreach(acc.add)
-        }
+        Node.fromIr(ir).foreach(acc.add)
         go(input ++= ir.children, acc)
       }
     go(mutable.Queue(ir), mutable.TreeSet())

the UUID for text2.replace text1 text3 (Case_Sensitivity.Insensitive) expression is in the metadata, is in the generated IR, but the node in IR.Application.Prefix has children - as such the current version of ChangesetBuilder skips the creation of the Node for that expression. That means it forgets to invalidate cache for that UUID later.

enso-bot[bot] commented 1 year ago

Jaroslav Tulach reports a new STANDUP for yesterday (2023-05-04):

Progress: - defaulted Boolean dropdown: https://github.com/enso-org/enso/pull/6548#discussion_r1184966111

Next Day: Polishing boolean default argument & other bugfixes

enso-bot[bot] commented 1 year ago

Jaroslav Tulach reports a new STANDUP for the last Friday (2023-05-05):

Progress: - defaulted Boolean dropdown integrated: https://github.com/enso-org/enso/pull/6548

Next Day: Bugfixing