update elastic-charts to 38.0.1

[nickofthyme]

Summary

Closes #111938

Updates @elastic/charts to 38.0.1.

Checklist

• Unit or functional tests were updated or added to match the most common scenarios

[nickofthyme]

@elasticmachine run elasticsearch-ci/docs

[stratoula]

I haven't tested it locally but why do we have these changes in the functional tests?

[nickofthyme]

We changed the tick generation logic to have a semi-fix for #108260 in elastic/elastic-charts#1420. @monfera might have a better explanation as to what the reason is for the change.

[kibanamachine]

💛 Build succeeded, but was flaky

• continuous-integration/kibana-ci/pull-request
• Commit: 0da3033
• Storybooks Preview
• Documentation Changes
• Flaky suites:
  • xpack-kibana-ciGroup3

---

Test Failures

Kibana Pipeline / general / Chrome X-Pack UI Functional Tests.x-pack/test/functional/apps/ml/data_frame_analytics/feature_importance·ts.machine learning data frame analytics total feature importance panel and decision path popover multi class classification job should display the feature importance decision path in the data grid

Link to Jenkins

Standard Out

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

[00:00:00]     │
[00:00:00]       └-: machine learning
[00:00:00]         └-> "before all" hook in "machine learning"
[00:00:00]         └-: 
[00:00:00]           └-> "before all" hook in ""
[00:00:00]           └-> "before all" hook in ""
[00:00:00]             │ debg creating role ft_ml_source
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_ml_source]
[00:00:00]             │ debg creating role ft_ml_source_readonly
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_ml_source_readonly]
[00:00:00]             │ debg creating role ft_ml_dest
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_ml_dest]
[00:00:00]             │ debg creating role ft_ml_dest_readonly
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_ml_dest_readonly]
[00:00:00]             │ debg creating role ft_ml_ui_extras
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_ml_ui_extras]
[00:00:00]             │ debg creating role ft_default_space_ml_all
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_default_space_ml_all]
[00:00:00]             │ debg creating role ft_default_space1_ml_all
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_default_space1_ml_all]
[00:00:00]             │ debg creating role ft_all_spaces_ml_all
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_all_spaces_ml_all]
[00:00:00]             │ debg creating role ft_default_space_ml_read
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_default_space_ml_read]
[00:00:00]             │ debg creating role ft_default_space1_ml_read
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_default_space1_ml_read]
[00:00:00]             │ debg creating role ft_all_spaces_ml_read
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_all_spaces_ml_read]
[00:00:00]             │ debg creating role ft_default_space_ml_none
[00:00:00]             │ info [o.e.x.s.a.r.TransportPutRoleAction] [node-01] added role [ft_default_space_ml_none]
[00:00:00]             │ debg creating user ft_ml_poweruser
[00:00:00]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_poweruser]
[00:00:00]             │ debg created user ft_ml_poweruser
[00:00:00]             │ debg creating user ft_ml_poweruser_spaces
[00:00:00]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_poweruser_spaces]
[00:00:00]             │ debg created user ft_ml_poweruser_spaces
[00:00:00]             │ debg creating user ft_ml_poweruser_space1
[00:00:00]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_poweruser_space1]
[00:00:00]             │ debg created user ft_ml_poweruser_space1
[00:00:00]             │ debg creating user ft_ml_poweruser_all_spaces
[00:00:00]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_poweruser_all_spaces]
[00:00:00]             │ debg created user ft_ml_poweruser_all_spaces
[00:00:00]             │ debg creating user ft_ml_viewer
[00:00:00]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_viewer]
[00:00:00]             │ debg created user ft_ml_viewer
[00:00:00]             │ debg creating user ft_ml_viewer_spaces
[00:00:01]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_viewer_spaces]
[00:00:01]             │ debg created user ft_ml_viewer_spaces
[00:00:01]             │ debg creating user ft_ml_viewer_space1
[00:00:01]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_viewer_space1]
[00:00:01]             │ debg created user ft_ml_viewer_space1
[00:00:01]             │ debg creating user ft_ml_viewer_all_spaces
[00:00:01]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_viewer_all_spaces]
[00:00:01]             │ debg created user ft_ml_viewer_all_spaces
[00:00:01]             │ debg creating user ft_ml_unauthorized
[00:00:01]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_unauthorized]
[00:00:01]             │ debg created user ft_ml_unauthorized
[00:00:01]             │ debg creating user ft_ml_unauthorized_spaces
[00:00:01]             │ info [o.e.x.s.a.u.TransportPutUserAction] [node-01] added user [ft_ml_unauthorized_spaces]
[00:00:01]             │ debg created user ft_ml_unauthorized_spaces
[00:47:07]           └-: data frame analytics
[00:47:07]             └-> "before all" hook in "data frame analytics"
[00:53:50]             └-: total feature importance panel and decision path popover
[00:53:50]               └-> "before all" hook in "total feature importance panel and decision path popover"
[00:53:50]               └-> "before all" hook in "total feature importance panel and decision path popover"
[00:53:50]                 │ debg applying update to kibana config: {"dateFormat:tz":"UTC"}
[00:53:51]                 │ debg SecurityPage.forceLogout
[00:53:51]                 │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=100
[00:53:51]                 │ debg --- retry.tryForTime error: .login-form is not displayed
[00:53:51]                 │ debg Redirecting to /logout to force the logout
[00:53:51]                 │ debg Waiting on the login form to appear
[00:53:51]                 │ debg Waiting for Login Page to appear.
[00:53:51]                 │ debg Waiting up to 100000ms for login page...
[00:53:51]                 │ debg browser[INFO] http://localhost:6141/logout?_t=1634745858111 281 Refused to execute inline script because it violates the following Content Security Policy directive: "script-src 'unsafe-eval' 'self'". Either the 'unsafe-inline' keyword, a hash ('sha256-P5polb1UreUSOe5V/Pv7tc+yeZuJXiOi/3fqhGsU7BE='), or a nonce ('nonce-...') is required to enable inline execution.
[00:53:51]                 │
[00:53:51]                 │ debg browser[INFO] http://localhost:6141/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:53:51]                 │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=2500
[00:53:54]                 │ warn browser[SEVERE] http://localhost:6141/api/alerts/list_alert_types - Failed to load resource: the server responded with a status of 401 (Unauthorized)
[00:53:54]                 │ debg browser[INFO] http://localhost:6141/47328/bundles/core/core.entry.js 7:106882 "Detected an unhandled Promise rejection.
[00:53:54]                 │      Error: Unauthorized"
[00:53:54]                 │ warn browser[SEVERE] http://localhost:6141/47328/bundles/core/core.entry.js 7:52880 
[00:53:54]                 │ debg browser[INFO] http://localhost:6141/login?msg=LOGGED_OUT 281 Refused to execute inline script because it violates the following Content Security Policy directive: "script-src 'unsafe-eval' 'self'". Either the 'unsafe-inline' keyword, a hash ('sha256-P5polb1UreUSOe5V/Pv7tc+yeZuJXiOi/3fqhGsU7BE='), or a nonce ('nonce-...') is required to enable inline execution.
[00:53:54]                 │
[00:53:54]                 │ debg browser[INFO] http://localhost:6141/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:53:54]                 │ debg --- retry.tryForTime error: .login-form is not displayed
[00:53:54]                 │ warn browser[SEVERE] http://localhost:6141/api/licensing/info - Failed to load resource: the server responded with a status of 401 (Unauthorized)
[00:53:55]                 │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=2500
[00:53:55]                 │ debg TestSubjects.exists(loginForm)
[00:53:55]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="loginForm"]') with timeout=2500
[00:53:55]                 │ debg Waiting for Login Form to appear.
[00:53:55]                 │ debg Waiting up to 100000ms for login form...
[00:53:55]                 │ debg TestSubjects.exists(loginForm)
[00:53:55]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="loginForm"]') with timeout=2500
[00:53:55]                 │ debg TestSubjects.setValue(loginUsername, ft_ml_poweruser)
[00:53:55]                 │ debg TestSubjects.click(loginUsername)
[00:53:55]                 │ debg Find.clickByCssSelector('[data-test-subj="loginUsername"]') with timeout=10000
[00:53:55]                 │ debg Find.findByCssSelector('[data-test-subj="loginUsername"]') with timeout=10000
[00:53:55]                 │ debg TestSubjects.setValue(loginPassword, mlp001)
[00:53:55]                 │ debg TestSubjects.click(loginPassword)
[00:53:55]                 │ debg Find.clickByCssSelector('[data-test-subj="loginPassword"]') with timeout=10000
[00:53:55]                 │ debg Find.findByCssSelector('[data-test-subj="loginPassword"]') with timeout=10000
[00:53:56]                 │ debg TestSubjects.click(loginSubmit)
[00:53:56]                 │ debg Find.clickByCssSelector('[data-test-subj="loginSubmit"]') with timeout=10000
[00:53:56]                 │ debg Find.findByCssSelector('[data-test-subj="loginSubmit"]') with timeout=10000
[00:53:56]                 │ debg Waiting for login result, expected: chrome.
[00:53:56]                 │ debg Find.findByCssSelector('[data-test-subj="userMenuAvatar"]') with timeout=20000
[00:53:56]                 │ proc [kibana] [2021-10-20T16:04:22.490+00:00][INFO ][plugins.security.routes] Logging in with provider "basic" (basic)
[00:53:58]                 │ debg browser[INFO] http://localhost:6141/app/home 281 Refused to execute inline script because it violates the following Content Security Policy directive: "script-src 'unsafe-eval' 'self'". Either the 'unsafe-inline' keyword, a hash ('sha256-P5polb1UreUSOe5V/Pv7tc+yeZuJXiOi/3fqhGsU7BE='), or a nonce ('nonce-...') is required to enable inline execution.
[00:53:58]                 │
[00:53:58]                 │ debg browser[INFO] http://localhost:6141/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:53:58]                 │ debg Finished login process currentUrl = http://localhost:6141/app/home#/
[00:53:58]                 │ debg Waiting up to 20000ms for logout button visible...
[00:53:58]                 │ debg TestSubjects.exists(userMenuButton)
[00:53:58]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenuButton"]') with timeout=2500
[00:53:58]                 │ debg TestSubjects.exists(userMenu)
[00:53:58]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"]') with timeout=2500
[00:54:01]                 │ debg --- retry.tryForTime error: [data-test-subj="userMenu"] is not displayed
[00:54:01]                 │ debg TestSubjects.click(userMenuButton)
[00:54:01]                 │ debg Find.clickByCssSelector('[data-test-subj="userMenuButton"]') with timeout=10000
[00:54:01]                 │ debg Find.findByCssSelector('[data-test-subj="userMenuButton"]') with timeout=10000
[00:54:01]                 │ debg TestSubjects.exists(userMenu)
[00:54:01]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"]') with timeout=120000
[00:54:01]                 │ debg TestSubjects.exists(userMenu > logoutLink)
[00:54:01]                 │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"] [data-test-subj="logoutLink"]') with timeout=2500
[00:54:01]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Loading "mappings.json"
[00:54:01]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Loading "data.json.gz"
[00:54:01]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Skipped restore for existing index "ft_ihp_outlier"
[00:54:01]                 │ debg Searching for 'index-pattern' with title 'ft_ihp_outlier'...
[00:54:01]                 │ debg  > Found '000788c0-31b8-11ec-852e-c977343d8475'
[00:54:01]                 │ debg Index pattern with title 'ft_ihp_outlier' already exists. Nothing to create.
[00:54:01]                 │ debg Creating data frame analytic job with id 'ihp_fi_binary_1634742626014' ...
[00:54:01]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-config] creating index, cause [auto(bulk api)], templates [], shards [1]/[1]
[00:54:01]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-config]
[00:54:01]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-annotations-6] creating index, cause [api], templates [], shards [1]/[1]
[00:54:01]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-annotations-6]
[00:54:01]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-notifications-000002] creating index, cause [auto(bulk api)], templates [.ml-notifications-000002], shards [1]/[1]
[00:54:01]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-notifications-000002]
[00:54:02]                 │ debg Waiting up to 5000ms for 'ihp_fi_binary_1634742626014' to exist...
[00:54:02]                 │ debg Fetching data frame analytics job 'ihp_fi_binary_1634742626014'...
[00:54:02]                 │ debg > DFA job fetched.
[00:54:02]                 │ debg > DFA job created.
[00:54:02]                 │ debg Starting data frame analytics job 'ihp_fi_binary_1634742626014'...
[00:54:02]                 │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [node-01] [ihp_fi_binary_1634742626014] Starting data frame analytics from state [stopped]
[00:54:02]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-inference-000004] creating index, cause [api], templates [], shards [1]/[1]
[00:54:02]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-inference-000004]
[00:54:02]                 │ info [o.e.x.c.m.u.MlIndexAndAlias] [node-01] About to create first concrete index [.ml-state-000001] with alias [.ml-state-write]
[00:54:02]                 │ debg > DFA job started.
[00:54:02]                 │ debg Waiting up to 60000ms for 'ihp_fi_binary_1634742626014' to have training_docs_count > 0...
[00:54:02]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:02]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-state-000001] creating index, cause [api], templates [.ml-state], shards [1]/[1]
[00:54:02]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-state-000001]
[00:54:02]                 │ debg > DFA job stats fetched.
[00:54:02]                 │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'ihp_fi_binary_1634742626014' to have training_docs_count > 0 (got 0)
[00:54:02]                 │ info [o.e.x.c.m.u.MlIndexAndAlias] [node-01] About to create first concrete index [.ml-stats-000001] with alias [.ml-stats-write]
[00:54:02]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [.ml-stats-000001] creating index, cause [api], templates [.ml-stats], shards [1]/[1]
[00:54:02]                 │ info [o.e.c.r.a.AllocationService] [node-01] updating number_of_replicas to [0] for indices [.ml-stats-000001]
[00:54:02]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-state-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:54:02]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-stats-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:54:02]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [ihp_fi_binary_1634742626014] Creating destination index [user-ihp_fi_binary_1634742626014]
[00:54:02]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [user-ihp_fi_binary_1634742626014] creating index, cause [api], templates [], shards [1]/[1]
[00:54:02]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [ihp_fi_binary_1634742626014] Started reindexing
[00:54:02]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-state-000001] from [{"phase":"new","action":"complete","name":"complete"}] to [{"phase":"hot","action":"unfollow","name":"branch-check-unfollow-prerequisites"}] in policy [ml-size-based-ilm-policy]
[00:54:02]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-state-000001] from [{"phase":"hot","action":"unfollow","name":"branch-check-unfollow-prerequisites"}] to [{"phase":"hot","action":"rollover","name":"check-rollover-ready"}] in policy [ml-size-based-ilm-policy]
[00:54:03]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:03]                 │ debg > DFA job stats fetched.
[00:54:03]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:03]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Started loading data
[00:54:03]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Started analyzing
[00:54:03]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Waiting for result processor to complete
[00:54:03]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:03]                 │ debg > DFA job stats fetched.
[00:54:03]                 │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:54:03]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:03]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:03]                 │ debg > DFA job stats fetched.
[00:54:03]                 │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:54:04]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:04]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:04]                 │ debg > DFA job stats fetched.
[00:54:04]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:04]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:04]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:04]                 │ debg > DFA job stats fetched.
[00:54:04]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:04]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [ihp_fi_binary_1634742626014] [data_frame_analyzer/246893] [CBoostedTreeImpl.cc@245] Exiting hyperparameter optimisation loop on round 7 out of 18.
[00:54:05]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:05]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:05]                 │ debg > DFA job stats fetched.
[00:54:05]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:05]                 │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [node-01] [ihp_fi_binary_1634742626014] finished storing trained model with id [ihp_fi_binary_1634742626014-1634745871688]
[00:54:05]                 │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [node-01] [ihp_fi_binary_1634742626014] Started writing results
[00:54:05]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Result processor has completed
[00:54:05]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Closing process
[00:54:05]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [ihp_fi_binary_1634742626014] [data_frame_analyzer/246893] [Main.cc@253] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":10150717}
[00:54:05]                 │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":298480}
[00:54:05]                 │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":1588}
[00:54:05]                 │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":5}
[00:54:05]                 │      ]
[00:54:05]                 │ info [o.e.x.m.p.AbstractNativeProcess] [node-01] [ihp_fi_binary_1634742626014] State output finished
[00:54:05]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_binary_1634742626014] Closed process
[00:54:05]                 │ info [o.e.x.m.d.i.InferenceRunner] [node-01] [ihp_fi_binary_1634742626014] Started inference on test data against model [ihp_fi_binary_1634742626014-1634745871688]
[00:54:05]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:05]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:05]                 │ debg > DFA job stats fetched.
[00:54:05]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:05]                 │ info [o.e.x.m.d.DataFrameAnalyticsManager] [node-01] [ihp_fi_binary_1634742626014] Marking task completed
[00:54:05]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-stats-000001] from [{"phase":"new","action":"complete","name":"complete"}] to [{"phase":"hot","action":"unfollow","name":"branch-check-unfollow-prerequisites"}] in policy [ml-size-based-ilm-policy]
[00:54:05]                 │ info [o.e.x.i.IndexLifecycleTransition] [node-01] moving index [.ml-stats-000001] from [{"phase":"hot","action":"unfollow","name":"branch-check-unfollow-prerequisites"}] to [{"phase":"hot","action":"rollover","name":"check-rollover-ready"}] in policy [ml-size-based-ilm-policy]
[00:54:06]                 │ debg Fetching analytics state for job ihp_fi_binary_1634742626014
[00:54:06]                 │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1634742626014...
[00:54:06]                 │ debg > DFA job stats fetched.
[00:54:06]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Loading "mappings.json"
[00:54:06]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Loading "data.json.gz"
[00:54:06]                 │ info [x-pack/test/functional/es_archives/ml/ihp_outlier] Skipped restore for existing index "ft_ihp_outlier"
[00:54:06]                 │ debg Searching for 'index-pattern' with title 'ft_ihp_outlier'...
[00:54:06]                 │ debg  > Found '000788c0-31b8-11ec-852e-c977343d8475'
[00:54:06]                 │ debg Index pattern with title 'ft_ihp_outlier' already exists. Nothing to create.
[00:54:06]                 │ debg Creating data frame analytic job with id 'ihp_fi_multi_1634742626014' ...
[00:54:07]                 │ debg Waiting up to 5000ms for 'ihp_fi_multi_1634742626014' to exist...
[00:54:07]                 │ debg Fetching data frame analytics job 'ihp_fi_multi_1634742626014'...
[00:54:07]                 │ debg > DFA job fetched.
[00:54:07]                 │ debg > DFA job created.
[00:54:07]                 │ debg Starting data frame analytics job 'ihp_fi_multi_1634742626014'...
[00:54:07]                 │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [node-01] [ihp_fi_multi_1634742626014] Starting data frame analytics from state [stopped]
[00:54:07]                 │ debg > DFA job started.
[00:54:07]                 │ debg Waiting up to 60000ms for 'ihp_fi_multi_1634742626014' to have training_docs_count > 0...
[00:54:07]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:07]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [ihp_fi_multi_1634742626014] Creating destination index [user-ihp_fi_multi_1634742626014]
[00:54:07]                 │ debg > DFA job stats fetched.
[00:54:07]                 │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'ihp_fi_multi_1634742626014' to have training_docs_count > 0 (got 0)
[00:54:07]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [user-ihp_fi_multi_1634742626014] creating index, cause [api], templates [], shards [1]/[1]
[00:54:07]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [ihp_fi_multi_1634742626014] Started reindexing
[00:54:08]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:08]                 │ debg > DFA job stats fetched.
[00:54:08]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:08]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Started loading data
[00:54:08]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Started analyzing
[00:54:08]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Waiting for result processor to complete
[00:54:08]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:08]                 │ debg > DFA job stats fetched.
[00:54:08]                 │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:54:08]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:08]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:08]                 │ debg > DFA job stats fetched.
[00:54:08]                 │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:54:09]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:09]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:09]                 │ debg > DFA job stats fetched.
[00:54:09]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:09]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:09]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:09]                 │ debg > DFA job stats fetched.
[00:54:09]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:10]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:10]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:10]                 │ debg > DFA job stats fetched.
[00:54:10]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:10]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:10]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:10]                 │ debg > DFA job stats fetched.
[00:54:10]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:11]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:11]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:11]                 │ debg > DFA job stats fetched.
[00:54:11]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:11]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:11]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:11]                 │ debg > DFA job stats fetched.
[00:54:11]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:12]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:12]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:12]                 │ debg > DFA job stats fetched.
[00:54:12]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:12]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:12]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:12]                 │ debg > DFA job stats fetched.
[00:54:12]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:13]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [ihp_fi_multi_1634742626014] [data_frame_analyzer/247191] [CBoostedTreeImpl.cc@245] Exiting hyperparameter optimisation loop on round 7 out of 18.
[00:54:13]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:13]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:13]                 │ debg > DFA job stats fetched.
[00:54:13]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:13]                 │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [node-01] [ihp_fi_multi_1634742626014] finished storing trained model with id [ihp_fi_multi_1634742626014-1634745879677]
[00:54:13]                 │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [node-01] [ihp_fi_multi_1634742626014] Started writing results
[00:54:13]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Result processor has completed
[00:54:13]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Closing process
[00:54:13]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [ihp_fi_multi_1634742626014] [data_frame_analyzer/247191] [Main.cc@253] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":22722629}
[00:54:13]                 │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":1485115}
[00:54:13]                 │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":5080}
[00:54:13]                 │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":13}
[00:54:13]                 │      ]
[00:54:13]                 │ info [o.e.x.m.p.AbstractNativeProcess] [node-01] [ihp_fi_multi_1634742626014] State output finished
[00:54:13]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [ihp_fi_multi_1634742626014] Closed process
[00:54:13]                 │ info [o.e.x.m.d.i.InferenceRunner] [node-01] [ihp_fi_multi_1634742626014] Started inference on test data against model [ihp_fi_multi_1634742626014-1634745879677]
[00:54:13]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:13]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:13]                 │ debg > DFA job stats fetched.
[00:54:13]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:13]                 │ info [o.e.x.m.d.DataFrameAnalyticsManager] [node-01] [ihp_fi_multi_1634742626014] Marking task completed
[00:54:14]                 │ debg Fetching analytics state for job ihp_fi_multi_1634742626014
[00:54:14]                 │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1634742626014...
[00:54:14]                 │ debg > DFA job stats fetched.
[00:54:14]                 │ info [x-pack/test/functional/es_archives/ml/egs_regression] Loading "mappings.json"
[00:54:14]                 │ info [x-pack/test/functional/es_archives/ml/egs_regression] Loading "data.json.gz"
[00:54:14]                 │ info [x-pack/test/functional/es_archives/ml/egs_regression] Skipped restore for existing index "ft_egs_regression"
[00:54:14]                 │ debg Searching for 'index-pattern' with title 'ft_egs_regression'...
[00:54:14]                 │ debg  > Found '9d4cdc10-31be-11ec-852e-c977343d8475'
[00:54:14]                 │ debg Index pattern with title 'ft_egs_regression' already exists. Nothing to create.
[00:54:14]                 │ debg Creating data frame analytic job with id 'egs_fi_reg_1634742626014' ...
[00:54:15]                 │ debg Waiting up to 5000ms for 'egs_fi_reg_1634742626014' to exist...
[00:54:15]                 │ debg Fetching data frame analytics job 'egs_fi_reg_1634742626014'...
[00:54:15]                 │ debg > DFA job fetched.
[00:54:15]                 │ debg > DFA job created.
[00:54:15]                 │ debg Starting data frame analytics job 'egs_fi_reg_1634742626014'...
[00:54:15]                 │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [node-01] [egs_fi_reg_1634742626014] Starting data frame analytics from state [stopped]
[00:54:15]                 │ debg > DFA job started.
[00:54:15]                 │ debg Waiting up to 60000ms for 'egs_fi_reg_1634742626014' to have training_docs_count > 0...
[00:54:15]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:15]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [egs_fi_reg_1634742626014] Creating destination index [user-egs_fi_reg_1634742626014]
[00:54:15]                 │ debg > DFA job stats fetched.
[00:54:15]                 │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'egs_fi_reg_1634742626014' to have training_docs_count > 0 (got 0)
[00:54:15]                 │ info [o.e.c.m.MetadataCreateIndexService] [node-01] [user-egs_fi_reg_1634742626014] creating index, cause [api], templates [], shards [1]/[1]
[00:54:15]                 │ info [o.e.x.m.d.s.ReindexingStep] [node-01] [egs_fi_reg_1634742626014] Started reindexing
[00:54:16]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:16]                 │ debg > DFA job stats fetched.
[00:54:16]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:16]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Started loading data
[00:54:16]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Started analyzing
[00:54:16]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Waiting for result processor to complete
[00:54:16]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:16]                 │ debg > DFA job stats fetched.
[00:54:16]                 │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:54:16]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:16]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:16]                 │ debg > DFA job stats fetched.
[00:54:16]                 │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:54:17]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:17]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:17]                 │ debg > DFA job stats fetched.
[00:54:17]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:17]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:17]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:17]                 │ debg > DFA job stats fetched.
[00:54:17]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:18]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:18]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:18]                 │ debg > DFA job stats fetched.
[00:54:18]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:18]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:18]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:18]                 │ debg > DFA job stats fetched.
[00:54:18]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:19]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:19]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:19]                 │ debg > DFA job stats fetched.
[00:54:19]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:19]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:19]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:19]                 │ debg > DFA job stats fetched.
[00:54:19]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:20]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:20]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:20]                 │ debg > DFA job stats fetched.
[00:54:20]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:20]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:20]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:20]                 │ debg > DFA job stats fetched.
[00:54:20]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:21]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:21]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:21]                 │ debg > DFA job stats fetched.
[00:54:21]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:21]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:21]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:21]                 │ debg > DFA job stats fetched.
[00:54:21]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:22]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:22]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:22]                 │ debg > DFA job stats fetched.
[00:54:22]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:22]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:22]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:22]                 │ debg > DFA job stats fetched.
[00:54:22]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:23]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:23]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:23]                 │ debg > DFA job stats fetched.
[00:54:23]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:23]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:23]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:23]                 │ debg > DFA job stats fetched.
[00:54:23]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:24]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:24]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:24]                 │ debg > DFA job stats fetched.
[00:54:24]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:24]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:24]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:24]                 │ debg > DFA job stats fetched.
[00:54:24]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:25]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:25]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:25]                 │ debg > DFA job stats fetched.
[00:54:25]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:25]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:25]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:25]                 │ debg > DFA job stats fetched.
[00:54:25]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:26]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:26]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:26]                 │ debg > DFA job stats fetched.
[00:54:26]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:26]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:26]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:26]                 │ debg > DFA job stats fetched.
[00:54:26]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:27]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:27]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:27]                 │ debg > DFA job stats fetched.
[00:54:27]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:27]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:27]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:27]                 │ debg > DFA job stats fetched.
[00:54:27]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:28]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:28]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:28]                 │ debg > DFA job stats fetched.
[00:54:28]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:28]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:28]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:28]                 │ debg > DFA job stats fetched.
[00:54:28]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:29]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:29]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:29]                 │ debg > DFA job stats fetched.
[00:54:29]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:29]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:29]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:29]                 │ debg > DFA job stats fetched.
[00:54:29]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:30]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:30]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:30]                 │ debg > DFA job stats fetched.
[00:54:30]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:30]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:30]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:30]                 │ debg > DFA job stats fetched.
[00:54:30]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:31]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [egs_fi_reg_1634742626014] [data_frame_analyzer/247503] [CBoostedTreeImpl.cc@245] Exiting hyperparameter optimisation loop on round 6 out of 16.
[00:54:31]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:31]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:31]                 │ debg > DFA job stats fetched.
[00:54:31]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:31]                 │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [node-01] [egs_fi_reg_1634742626014] finished storing trained model with id [egs_fi_reg_1634742626014-1634745897884]
[00:54:31]                 │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [node-01] [egs_fi_reg_1634742626014] Started writing results
[00:54:31]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Result processor has completed
[00:54:31]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Closing process
[00:54:31]                 │ info [o.e.x.m.p.l.CppLogMessageHandler] [node-01] [egs_fi_reg_1634742626014] [data_frame_analyzer/247503] [Main.cc@253] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":14796184}
[00:54:31]                 │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":7627902}
[00:54:31]                 │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":15269}
[00:54:31]                 │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":164}
[00:54:31]                 │      ]
[00:54:31]                 │ info [o.e.x.m.p.AbstractNativeProcess] [node-01] [egs_fi_reg_1634742626014] State output finished
[00:54:31]                 │ info [o.e.x.m.d.p.AnalyticsProcessManager] [node-01] [egs_fi_reg_1634742626014] Closed process
[00:54:31]                 │ info [o.e.x.m.d.i.InferenceRunner] [node-01] [egs_fi_reg_1634742626014] Started inference on test data against model [egs_fi_reg_1634742626014-1634745897884]
[00:54:31]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:31]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:31]                 │ debg > DFA job stats fetched.
[00:54:31]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:32]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:32]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:32]                 │ debg > DFA job stats fetched.
[00:54:32]                 │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:54:32]                 │ info [o.e.x.m.d.DataFrameAnalyticsManager] [node-01] [egs_fi_reg_1634742626014] Marking task completed
[00:54:32]                 │ debg Fetching analytics state for job egs_fi_reg_1634742626014
[00:54:32]                 │ debg Fetching data frame analytics job stats for job egs_fi_reg_1634742626014...
[00:54:32]                 │ debg > DFA job stats fetched.
[00:54:44]               └-: multi class classification job
[00:54:44]                 └-> "before all" hook for "should display the total feature importance in the results view"
[00:54:44]                 └-> "before all" hook for "should display the total feature importance in the results view"
[00:54:44]                   │ debg navigating to ml url: http://localhost:6141/app/ml
[00:54:44]                   │ debg navigate to: http://localhost:6141/app/ml
[00:54:44]                   │ debg browser[INFO] http://localhost:6141/app/ml?_t=1634745910720 281 Refused to execute inline script because it violates the following Content Security Policy directive: "script-src 'unsafe-eval' 'self'". Either the 'unsafe-inline' keyword, a hash ('sha256-P5polb1UreUSOe5V/Pv7tc+yeZuJXiOi/3fqhGsU7BE='), or a nonce ('nonce-...') is required to enable inline execution.
[00:54:44]                   │
[00:54:44]                   │ debg browser[INFO] http://localhost:6141/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:54:44]                   │ debg ... sleep(700) start
[00:54:45]                   │ debg ... sleep(700) end
[00:54:45]                   │ debg returned from get, calling refresh
[00:54:46]                   │ warn browser[SEVERE] http://localhost:6141/47328/bundles/core/core.entry.js 7:106190 TypeError: Failed to fetch
[00:54:46]                   │          at fetch_Fetch.fetchResponse (http://localhost:6141/47328/bundles/core/core.entry.js:8:56515)
[00:54:46]                   │          at async http://localhost:6141/47328/bundles/core/core.entry.js:8:55103
[00:54:46]                   │          at async http://localhost:6141/47328/bundles/core/core.entry.js:8:55060
[00:54:46]                   │ debg browser[INFO] http://localhost:6141/app/ml?_t=1634745910720 281 Refused to execute inline script because it violates the following Content Security Policy directive: "script-src 'unsafe-eval' 'self'". Either the 'unsafe-inline' keyword, a hash ('sha256-P5polb1UreUSOe5V/Pv7tc+yeZuJXiOi/3fqhGsU7BE='), or a nonce ('nonce-...') is required to enable inline execution.
[00:54:46]                   │
[00:54:46]                   │ debg browser[INFO] http://localhost:6141/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:54:46]                   │ debg currentUrl = http://localhost:6141/app/ml
[00:54:46]                   │          appUrl = http://localhost:6141/app/ml
[00:54:46]                   │ debg TestSubjects.find(kibanaChrome)
[00:54:46]                   │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:54:46]                   │ debg ... sleep(501) start
[00:54:47]                   │ debg ... sleep(501) end
[00:54:47]                   │ debg in navigateTo url = http://localhost:6141/app/ml/overview
[00:54:47]                   │ debg TestSubjects.exists(mlApp)
[00:54:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlApp"]') with timeout=2000
[00:54:47]                   │ debg TestSubjects.click(~mlMainTab & ~dataFrameAnalytics)
[00:54:47]                   │ debg Find.clickByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"]') with timeout=10000
[00:54:47]                   │ debg Find.findByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"]') with timeout=10000
[00:54:47]                   │ debg TestSubjects.exists(~mlMainTab & ~dataFrameAnalytics & ~selected)
[00:54:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"][data-test-subj~="selected"]') with timeout=120000
[00:54:47]                   │ debg TestSubjects.exists(mlPageDataFrameAnalytics)
[00:54:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlPageDataFrameAnalytics"]') with timeout=120000
[00:54:47]                   │ debg TestSubjects.exists(~mlAnalyticsTable)
[00:54:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlAnalyticsTable"]') with timeout=60000
[00:54:48]                   │ debg TestSubjects.exists(mlAnalyticsTable loaded)
[00:54:48]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlAnalyticsTable loaded"]') with timeout=30000
[00:54:48]                   │ debg Searching for 'index-pattern' with title 'user-ihp_fi_multi_1634742626014'...
[00:54:48]                   │ debg  > Not found
[00:54:48]                   │ debg Creating index pattern with title 'user-ihp_fi_multi_1634742626014'
[00:54:48]                   │ debg Waiting up to 5000ms for index-pattern with title 'user-ihp_fi_multi_1634742626014' to exist...
[00:54:48]                   │ debg Searching for 'index-pattern' with title 'user-ihp_fi_multi_1634742626014'...
[00:54:48]                   │ debg  > Found '82cefac0-31bf-11ec-852e-c977343d8475'
[00:54:48]                   │ debg  > Created with id '82cefac0-31bf-11ec-852e-c977343d8475'
[00:54:48]                   │ debg TestSubjects.exists(~mlAnalyticsTable > ~row-ihp_fi_multi_1634742626014 > mlAnalyticsJobViewButton)
[00:54:48]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_multi_1634742626014"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=120000
[00:54:48]                   │ debg TestSubjects.click(~mlAnalyticsTable > ~row-ihp_fi_multi_1634742626014 > mlAnalyticsJobViewButton)
[00:54:48]                   │ debg Find.clickByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_multi_1634742626014"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=10000
[00:54:48]                   │ debg Find.findByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_multi_1634742626014"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=10000
[00:54:48]                   │ debg TestSubjects.exists(mlPageDataFrameAnalyticsExploration)
[00:54:48]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlPageDataFrameAnalyticsExploration"]') with timeout=20000
[00:54:48]                 └-> should display the total feature importance in the results view
[00:54:48]                   └-> "before each" hook: global before each for "should display the total feature importance in the results view"
[00:54:48]                   │ debg TestSubjects.exists(mlDFExpandableSection-FeatureImportanceSummary)
[00:54:48]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlDFExpandableSection-FeatureImportanceSummary"]') with timeout=120000
[00:54:49]                   │ debg TestSubjects.exists(mlTotalFeatureImportanceChart)
[00:54:49]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlTotalFeatureImportanceChart"]') with timeout=5000
[00:54:49]                   └- ✓ pass  (496ms)
[00:54:49]                 └-> should display the feature importance decision path in the data grid
[00:54:49]                   └-> "before each" hook: global before each for "should display the feature importance decision path in the data grid"
[00:54:49]                   │ debg TestSubjects.exists(mlExplorationDataGrid loaded)
[00:54:49]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=5000
[00:54:49]                   │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:54:49]                   │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:54:49]                   │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:54:49]                   │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:54:49]                   │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:54:49]                   │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:54:51]                   │ debg --- retry.tryForTime error: Expected data grid cell button to be visible
[00:54:52]                   │ debg TestSubjects.exists(mlDFAFeatureImportancePopover)
[00:54:52]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlDFAFeatureImportancePopover"]') with timeout=120000
[00:54:54]                   │ debg --- retry.tryForTime error: [data-test-subj="mlDFAFeatureImportancePopover"] is not displayed
[00:54:58]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:01]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:04]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:07]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:10]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:13]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:16]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:19]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:22]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:25]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:28]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:31]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:34]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:37]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:40]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:43]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:46]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:49]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:52]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:55]                   │ debg --- retry.tryForTime failed again with the same message...
[00:55:58]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:01]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:05]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:08]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:11]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:14]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:17]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:20]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:23]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:26]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:29]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:32]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:35]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:38]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:41]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:44]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:47]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:50]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:53]                   │ debg --- retry.tryForTime failed again with the same message...
[00:56:54]                   │ info Taking screenshot "/dev/shm/workspace/parallel/4/kibana/x-pack/test/functional/screenshots/failure/machine learning  data frame analytics total feature importance panel and decision path popover multi class classification job should display the feature importance decision path in the data grid.png"
[00:56:54]                   │ info Current URL is: http://localhost:6141/app/ml/data_frame_analytics/exploration?_g=(ml%3A(analysisType%3Aclassification%2CjobId%3Aihp_fi_multi_1634742626014))
[00:56:54]                   │ info Saving page source to: /dev/shm/workspace/parallel/4/kibana/x-pack/test/functional/failure_debug/html/machine learning  data frame analytics total feature importance panel and decision path popover multi class classification job should display the feature importance decision path in the data grid.html
[00:56:54]                   └- ✖ fail: machine learning  data frame analytics total feature importance panel and decision path popover multi class classification job should display the feature importance decision path in the data grid
[00:56:54]                   │      Error: expected testSubject(mlDFAFeatureImportancePopover) to exist
[00:56:54]                   │       at TestSubjects.existOrFail (/dev/shm/workspace/parallel/4/kibana/test/functional/services/common/test_subjects.ts:45:13)
[00:56:54]                   │       at Object.openFeatureImportancePopover (test/functional/services/ml/data_frame_analytics_results.ts:180:7)
[00:56:54]                   │       at Context.<anonymous> (test/functional/apps/ml/data_frame_analytics/feature_importance.ts:207:11)
[00:56:54]                   │       at Object.apply (/dev/shm/workspace/parallel/4/kibana/node_modules/@kbn/test/target_node/functional_test_runner/lib/mocha/wrap_function.js:87:16)
[00:56:54]                   │ 
[00:56:54]                   │ 

Stack Trace

Error: expected testSubject(mlDFAFeatureImportancePopover) to exist
    at TestSubjects.existOrFail (/dev/shm/workspace/parallel/4/kibana/test/functional/services/common/test_subjects.ts:45:13)
    at Object.openFeatureImportancePopover (test/functional/services/ml/data_frame_analytics_results.ts:180:7)
    at Context.<anonymous> (test/functional/apps/ml/data_frame_analytics/feature_importance.ts:207:11)
    at Object.apply (/dev/shm/workspace/parallel/4/kibana/node_modules/@kbn/test/target_node/functional_test_runner/lib/mocha/wrap_function.js:87:16)

---

Metrics [docs]

Async chunks

Total size of all lazy-loaded chunks that will be downloaded as the user navigates the app

id	before	after	diff
discover	332.8KB	332.7KB	-3.0B
lens	1.0MB	1.0MB	-3.0B
visTypeTimeseries	488.4KB	488.4KB	-3.0B
visTypeXy	61.7KB	61.7KB	-3.0B
total			-12.0B

Page load bundle

Size of the bundles that are downloaded on every page load. Target size is below 100kb

id	before	after	diff
kbnUiSharedDeps-npmDll	5.0MB	5.0MB	+4.1KB

History

• 💔 Build #163056 failed 82e1ac6
• 💔 Build #162997 failed 56ded42
• 💔 Build #162888 failed 5be496c

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

[nickofthyme]

@elastic/kibana-data-discovery could you take a look at this please?

[timroes]

Code review only, Data Discovery changes LGTM

[stratoula]

LGTM! We can also close this #111938 (I have already linked this to the issue). I tested it locally and now it scrolls correctly 🎉
I also tested the 'allowBrushingLasthistogrambin' and it works as before.

[nickofthyme]

Ah yes thanks @stratoula I forgot about #111938.