Expressions timings in the browser console

[wylieconlon]

This is a PR that lets you see how many milliseconds each expression function takes, for visualize, lens, and canvas. For example:

[kibanamachine]

💔 Build Failed

• continuous-integration/kibana-ci/pull-request
• Commit: d7f62ae
• Pipeline Steps (look for red circles / failed steps)
• Interpreting CI Failures

Failed CI Steps

• Check Types
• Check Doc API Changes
• Lint: eslint
• Jest Unit Tests

---

Test Failures

Jest Tests.src/plugins/expressions/common/execution.Execution debug mode when functions succeed stores output of each function

Link to Jenkins

Standard Out

Failed Tests Reporter:
  - Test has not failed recently on tracked branches

Stack Trace

Error: expect(received).toEqual(expected) // deep equality

Expected: {"type": "num", "value": 0}
Received: undefined
    at Object.test (/dev/shm/workspace/parallel/5/kibana/src/plugins/expressions/common/execution/execution.test.ts:546:40)

---

Jest Tests.src/plugins/expressions/common/execution.Execution debug mode when functions succeed stores resolved arguments of a function

Link to Jenkins

Standard Out

Failed Tests Reporter:
  - Test has not failed recently on tracked branches

Stack Trace

Error: expect(received).toEqual(expected) // deep equality

Expected: {"val": 5}
Received: undefined
    at Object.test (/dev/shm/workspace/parallel/5/kibana/src/plugins/expressions/common/execution/execution.test.ts:571:38)

---

Jest Tests.src/plugins/expressions/common/execution.Execution debug mode when functions succeed store debug information about sub-expressions

Link to Jenkins

Standard Out

Failed Tests Reporter:
  - Test has not failed recently on tracked branches

Stack Trace

Error: expect(received).toBe(expected) // Object.is equality

Expected: 0
Received: undefined
    at Object.test (/dev/shm/workspace/parallel/5/kibana/src/plugins/expressions/common/execution/execution.test.ts:601:40)

---

Metrics [docs]

async chunks size

id	value	diff	baseline
canvas	1.4MB	+959.0B	1.4MB
lens	995.6KB	+11.0B	995.6KB
total		+970.0B

page load bundle size

id	value	diff	baseline
expressions	205.2KB	+1.0KB	204.2KB
lens	139.6KB	+11.0B	139.6KB
visualizations	272.7KB	+22.0B	272.7KB
total		+1.0KB

To update your PR or re-run it, just comment with:
@elasticmachine merge upstream

[ppisljar]

how is this different from passing debug parameter to createExecution ?

• not logging anything else but execution times ... that seems useful, but could be made configurable on the original createExecution debug parameter

is there something i am missing ?

[wylieconlon]

@ppisljar This PR is the first step towards a "debug timing collector", there's a separate PR which lets us enable debug mode from client apps like Lens and Canvas. This is a separate chunk of work that could let us track and report on timing in an automated way.