Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Improve security plugin return types #101492

Conversation

stacey-gammon
Copy link
Contributor

@stacey-gammon stacey-gammon commented Jun 7, 2021

Plugin API Changes

__legacy and sessionTimeout were removed from the security plugin's setup contract.

Details

  1. Use explicit interfaces instead of ReturnType<X> as recommended in the Developer Guide. (Improves the API docs and supports comments)
  2. Removed __legacy return item from Setup function because it was unused.
  3. Removed sessionTimeout return from the Setup function because it also seems unused.
  4. Added some comments.

Before:
Screen Shot 2021-06-08 at 9 50 30 AM

After:
Screen Shot 2021-06-08 at 9 48 33 AM

@stacey-gammon stacey-gammon force-pushed the 2021-06-07-fix-security-return-types branch 2 times, most recently from 582c495 to 2ce7f03 Compare June 7, 2021 17:52
@stacey-gammon stacey-gammon marked this pull request as ready for review June 7, 2021 20:40
@stacey-gammon stacey-gammon requested a review from a team as a code owner June 7, 2021 20:40
@stacey-gammon stacey-gammon added auto-backport Deprecated: Automatically backport this PR after it's merged release_note:skip Skip the PR/issue when compiling release notes v7.14.0 v8.0.0 labels Jun 7, 2021
@stacey-gammon stacey-gammon force-pushed the 2021-06-07-fix-security-return-types branch from 4e78403 to fc89a0e Compare June 8, 2021 13:49
@stacey-gammon stacey-gammon force-pushed the 2021-06-07-fix-security-return-types branch from fc89a0e to 6cfaf0a Compare June 8, 2021 13:49
Copy link
Member

@legrego legrego left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Thanks for putting this together, Stacey!

x-pack/plugins/security/public/plugin.tsx Outdated Show resolved Hide resolved
x-pack/plugins/security/public/plugin.tsx Outdated Show resolved Hide resolved
stacey-gammon and others added 8 commits June 8, 2021 11:10
….tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
….tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
…cey-gammon/kibana into 2021-06-07-fix-security-return-types
@stacey-gammon stacey-gammon enabled auto-merge (squash) June 8, 2021 17:09
@stacey-gammon stacey-gammon merged commit 8aa370b into elastic:master Jun 8, 2021
@kibanamachine
Copy link
Contributor

💔 Backport failed

Status Branch Result
7.x Commit could not be cherrypicked due to conflicts

To backport manually run:
node scripts/backport --pr 101492

@stacey-gammon stacey-gammon added the release_note:plugin_api_changes Contains a Plugin API changes section for the breaking plugin API changes section. label Jun 8, 2021
stacey-gammon added a commit to stacey-gammon/kibana that referenced this pull request Jun 8, 2021
* Add explicit security types

* Remove sessionTimeout, seems unused

* add comments

* Add comments and fix test since removing the unused APIs

* remove unused import

* wording cleanup

* Export some types that are part of the public API but not exported

* more improvements for api docs

* update security docs

* Update x-pack/plugins/security/public/nav_control/nav_control_service.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/nav_control/nav_control_service.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/plugin.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/plugin.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* remove unneccessary readonly prefix

* Update all api docs

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
# Conflicts:
#	api_docs/data.json
#	api_docs/data_index_patterns.json
#	api_docs/data_search.json
#	api_docs/deprecations.mdx
#	api_docs/licensing.json
#	api_docs/lists.json
#	api_docs/triggers_actions_ui.json
#	api_docs/usage_collection.json
stacey-gammon added a commit that referenced this pull request Jun 8, 2021
* Add explicit security types

* Remove sessionTimeout, seems unused

* add comments

* Add comments and fix test since removing the unused APIs

* remove unused import

* wording cleanup

* Export some types that are part of the public API but not exported

* more improvements for api docs

* update security docs

* Update x-pack/plugins/security/public/nav_control/nav_control_service.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/nav_control/nav_control_service.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/plugin.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* Update x-pack/plugins/security/public/plugin.tsx

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>

* remove unneccessary readonly prefix

* Update all api docs

Co-authored-by: Larry Gregory <lgregorydev@gmail.com>
# Conflicts:
#	api_docs/data.json
#	api_docs/data_index_patterns.json
#	api_docs/data_search.json
#	api_docs/deprecations.mdx
#	api_docs/licensing.json
#	api_docs/lists.json
#	api_docs/triggers_actions_ui.json
#	api_docs/usage_collection.json
@kibanamachine
Copy link
Contributor

💛 Build succeeded, but was flaky


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 binary classification job should display the feature importance decision path in the data grid

Link to Jenkins

Standard Out

Failed Tests Reporter:
  - Test has failed 2 times on tracked branches: https://github.com/elastic/kibana/issues/93188

[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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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:01]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] added user [ft_ml_poweruser_all_spaces]
[00:00:01]               │ debg created user ft_ml_poweruser_all_spaces
[00:00:01]               │ debg creating user ft_ml_viewer
[00:00:01]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] added user [ft_ml_viewer]
[00:00:01]               │ debg created user ft_ml_viewer
[00:00:01]               │ debg creating user ft_ml_viewer_spaces
[00:00:01]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] added user [ft_ml_unauthorized_spaces]
[00:00:01]               │ debg created user ft_ml_unauthorized_spaces
[00:45:45]             └-: data frame analytics
[00:45:45]               └-> "before all" hook in "data frame analytics"
[00:51:21]               └-: total feature importance panel and decision path popover
[00:51:21]                 └-> "before all" hook in "total feature importance panel and decision path popover"
[00:51:21]                 └-> "before all" hook in "total feature importance panel and decision path popover"
[00:51:21]                   │ debg applying update to kibana config: {"dateFormat:tz":"UTC"}
[00:51:22]                   │ debg SecurityPage.forceLogout
[00:51:22]                   │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=100
[00:51:22]                   │ debg --- retry.tryForTime error: .login-form is not displayed
[00:51:22]                   │ debg Redirecting to /logout to force the logout
[00:51:23]                   │ debg Waiting on the login form to appear
[00:51:23]                   │ debg Waiting for Login Page to appear.
[00:51:23]                   │ debg Waiting up to 100000ms for login page...
[00:51:23]                   │ debg browser[INFO] http://localhost:6191/logout?_t=1623180480399 340 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:51:23]                   │
[00:51:23]                   │ debg browser[INFO] http://localhost:6191/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:51:23]                   │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=2500
[00:51:25]                   │ERROR browser[SEVERE] http://localhost:6191/api/alerts/list_alert_types - Failed to load resource: the server responded with a status of 401 (Unauthorized)
[00:51:25]                   │ debg browser[INFO] http://localhost:6191/43338/bundles/core/core.entry.js 12:153802 "Detected an unhandled Promise rejection.
[00:51:25]                   │      Error: Unauthorized"
[00:51:25]                   │ERROR browser[SEVERE] http://localhost:6191/43338/bundles/core/core.entry.js 5:2514 
[00:51:25]                   │ debg browser[INFO] http://localhost:6191/login?msg=LOGGED_OUT 340 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:51:25]                   │
[00:51:25]                   │ debg browser[INFO] http://localhost:6191/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:51:25]                   │ debg --- retry.tryForTime error: .login-form is not displayed
[00:51:25]                   │ERROR browser[SEVERE] http://localhost:6191/api/licensing/info - Failed to load resource: the server responded with a status of 401 (Unauthorized)
[00:51:26]                   │ debg Find.existsByDisplayedByCssSelector('.login-form') with timeout=2500
[00:51:26]                   │ debg TestSubjects.exists(loginForm)
[00:51:26]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="loginForm"]') with timeout=2500
[00:51:26]                   │ debg Waiting for Login Form to appear.
[00:51:26]                   │ debg Waiting up to 100000ms for login form...
[00:51:26]                   │ debg TestSubjects.exists(loginForm)
[00:51:26]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="loginForm"]') with timeout=2500
[00:51:26]                   │ debg TestSubjects.setValue(loginUsername, ft_ml_poweruser)
[00:51:26]                   │ debg TestSubjects.click(loginUsername)
[00:51:26]                   │ debg Find.clickByCssSelector('[data-test-subj="loginUsername"]') with timeout=10000
[00:51:26]                   │ debg Find.findByCssSelector('[data-test-subj="loginUsername"]') with timeout=10000
[00:51:26]                   │ debg TestSubjects.setValue(loginPassword, mlp001)
[00:51:26]                   │ debg TestSubjects.click(loginPassword)
[00:51:26]                   │ debg Find.clickByCssSelector('[data-test-subj="loginPassword"]') with timeout=10000
[00:51:26]                   │ debg Find.findByCssSelector('[data-test-subj="loginPassword"]') with timeout=10000
[00:51:27]                   │ debg TestSubjects.click(loginSubmit)
[00:51:27]                   │ debg Find.clickByCssSelector('[data-test-subj="loginSubmit"]') with timeout=10000
[00:51:27]                   │ debg Find.findByCssSelector('[data-test-subj="loginSubmit"]') with timeout=10000
[00:51:27]                   │ debg Waiting for login result, expected: chrome.
[00:51:27]                   │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"] .kbnAppWrapper:not(.kbnAppWrapper--hiddenChrome)') with timeout=20000
[00:51:27]                   │ proc [kibana]   log   [19:28:04.596] [info][plugins][routes][security] Logging in with provider "basic" (basic)
[00:51:29]                   │ debg browser[INFO] http://localhost:6191/app/home 340 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:51:29]                   │
[00:51:29]                   │ debg browser[INFO] http://localhost:6191/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:51:29]                   │ debg Finished login process currentUrl = http://localhost:6191/app/home#/
[00:51:29]                   │ debg Waiting up to 20000ms for logout button visible...
[00:51:29]                   │ debg TestSubjects.exists(userMenuButton)
[00:51:29]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenuButton"]') with timeout=2500
[00:51:29]                   │ debg TestSubjects.exists(userMenu)
[00:51:29]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"]') with timeout=2500
[00:51:29]                   │ERROR browser[SEVERE] http://localhost:6191/api/fleet/epm/packages?experimental=true - Failed to load resource: the server responded with a status of 403 (Forbidden)
[00:51:32]                   │ debg --- retry.tryForTime error: [data-test-subj="userMenu"] is not displayed
[00:51:32]                   │ debg TestSubjects.click(userMenuButton)
[00:51:32]                   │ debg Find.clickByCssSelector('[data-test-subj="userMenuButton"]') with timeout=10000
[00:51:32]                   │ debg Find.findByCssSelector('[data-test-subj="userMenuButton"]') with timeout=10000
[00:51:32]                   │ debg TestSubjects.exists(userMenu)
[00:51:32]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"]') with timeout=120000
[00:51:32]                   │ debg TestSubjects.exists(userMenu > logoutLink)
[00:51:32]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="userMenu"] [data-test-subj="logoutLink"]') with timeout=2500
[00:51:32]                   │ info [ml/ihp_outlier] Loading "mappings.json"
[00:51:32]                   │ info [ml/ihp_outlier] Loading "data.json.gz"
[00:51:32]                   │ info [ml/ihp_outlier] Skipped restore for existing index "ft_ihp_outlier"
[00:51:33]                   │ debg Searching for 'index-pattern' with title 'ft_ihp_outlier'...
[00:51:33]                   │ debg  > Found 'a05b2f50-c888-11eb-aa4e-c728742f7f9c'
[00:51:33]                   │ debg Index pattern with title 'ft_ihp_outlier' already exists. Nothing to create.
[00:51:33]                   │ debg Creating data frame analytic job with id 'ihp_fi_binary_1623177396834' ...
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-config] creating index, cause [auto(bulk api)], templates [], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-config]
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-annotations-6] creating index, cause [api], templates [], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-annotations-6]
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-notifications-000001] creating index, cause [auto(bulk api)], templates [.ml-notifications-000001], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-notifications-000001]
[00:51:33]                   │ debg Waiting up to 5000ms for 'ihp_fi_binary_1623177396834' to exist...
[00:51:33]                   │ debg Fetching data frame analytics job 'ihp_fi_binary_1623177396834'...
[00:51:33]                   │ debg > DFA job fetched.
[00:51:33]                   │ debg > DFA job created.
[00:51:33]                   │ debg Starting data frame analytics job 'ihp_fi_binary_1623177396834'...
[00:51:33]                   │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Starting data frame analytics from state [stopped]
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-inference-000004] creating index, cause [api], templates [], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-inference-000004]
[00:51:33]                   │ info [o.e.x.c.m.u.MlIndexAndAlias] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] About to create first concrete index [.ml-state-000001] with alias [.ml-state-write]
[00:51:33]                   │ debg > DFA job started.
[00:51:33]                   │ debg Waiting up to 60000ms for 'ihp_fi_binary_1623177396834' to have training_docs_count > 0...
[00:51:33]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-state-000001] creating index, cause [api], templates [.ml-state], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-state-000001]
[00:51:33]                   │ debg > DFA job stats fetched.
[00:51:33]                   │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'ihp_fi_binary_1623177396834' to have training_docs_count > 0 (got 0)
[00:51:33]                   │ info [o.e.x.c.m.u.MlIndexAndAlias] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] About to create first concrete index [.ml-stats-000001] with alias [.ml-stats-write]
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [.ml-stats-000001] creating index, cause [api], templates [.ml-stats], shards [1]/[1]
[00:51:33]                   │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] updating number_of_replicas to [0] for indices [.ml-stats-000001]
[00:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] moving index [.ml-state-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:51:33]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Creating destination index [user-ihp_fi_binary_1623177396834]
[00:51:33]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [user-ihp_fi_binary_1623177396834] creating index, cause [api], templates [], shards [1]/[1]
[00:51:33]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Started reindexing
[00:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] moving index [.ml-stats-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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:51:33]                   │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] 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:51:34]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:34]                   │ debg > DFA job stats fetched.
[00:51:34]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:34]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Started loading data
[00:51:34]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Started analyzing
[00:51:34]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Waiting for result processor to complete
[00:51:34]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:34]                   │ debg > DFA job stats fetched.
[00:51:34]                   │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:51:34]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:34]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:34]                   │ debg > DFA job stats fetched.
[00:51:34]                   │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:51:35]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:35]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:35]                   │ debg > DFA job stats fetched.
[00:51:35]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:35]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:35]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:35]                   │ debg > DFA job stats fetched.
[00:51:35]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:36]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] [data_frame_analyzer/224422] [CBoostedTreeImpl.cc@236] Exiting hyperparameter optimisation loop early
[00:51:36]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:36]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:36]                   │ debg > DFA job stats fetched.
[00:51:36]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:36]                   │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] finished storing trained model with id [ihp_fi_binary_1623177396834-1623180493958]
[00:51:36]                   │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Started writing results
[00:51:36]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Result processor has completed
[00:51:36]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Closing process
[00:51:36]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] [data_frame_analyzer/224422] [Main.cc@241] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":6040668}
[00:51:36]                   │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":321930}
[00:51:36]                   │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":1684}
[00:51:36]                   │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":4}
[00:51:36]                   │      ]
[00:51:36]                   │ info [o.e.x.m.p.AbstractNativeProcess] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] State output finished
[00:51:36]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Closed process
[00:51:36]                   │ info [o.e.x.m.d.i.InferenceRunner] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Started inference on test data against model [ihp_fi_binary_1623177396834-1623180493958]
[00:51:36]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:36]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:36]                   │ debg > DFA job stats fetched.
[00:51:36]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:37]                   │ info [o.e.x.m.d.DataFrameAnalyticsManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_binary_1623177396834] Marking task completed
[00:51:37]                   │ debg Fetching analytics state for job ihp_fi_binary_1623177396834
[00:51:37]                   │ debg Fetching data frame analytics job stats for job ihp_fi_binary_1623177396834...
[00:51:37]                   │ debg > DFA job stats fetched.
[00:51:37]                   │ info [ml/ihp_outlier] Loading "mappings.json"
[00:51:37]                   │ info [ml/ihp_outlier] Loading "data.json.gz"
[00:51:37]                   │ info [ml/ihp_outlier] Skipped restore for existing index "ft_ihp_outlier"
[00:51:37]                   │ debg Searching for 'index-pattern' with title 'ft_ihp_outlier'...
[00:51:37]                   │ debg  > Found 'a05b2f50-c888-11eb-aa4e-c728742f7f9c'
[00:51:37]                   │ debg Index pattern with title 'ft_ihp_outlier' already exists. Nothing to create.
[00:51:37]                   │ debg Creating data frame analytic job with id 'ihp_fi_multi_1623177396834' ...
[00:51:38]                   │ debg Waiting up to 5000ms for 'ihp_fi_multi_1623177396834' to exist...
[00:51:38]                   │ debg Fetching data frame analytics job 'ihp_fi_multi_1623177396834'...
[00:51:38]                   │ debg > DFA job fetched.
[00:51:38]                   │ debg > DFA job created.
[00:51:38]                   │ debg Starting data frame analytics job 'ihp_fi_multi_1623177396834'...
[00:51:38]                   │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Starting data frame analytics from state [stopped]
[00:51:38]                   │ debg > DFA job started.
[00:51:38]                   │ debg Waiting up to 60000ms for 'ihp_fi_multi_1623177396834' to have training_docs_count > 0...
[00:51:38]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:38]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Creating destination index [user-ihp_fi_multi_1623177396834]
[00:51:38]                   │ debg > DFA job stats fetched.
[00:51:38]                   │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'ihp_fi_multi_1623177396834' to have training_docs_count > 0 (got 0)
[00:51:38]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [user-ihp_fi_multi_1623177396834] creating index, cause [api], templates [], shards [1]/[1]
[00:51:38]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Started reindexing
[00:51:39]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Started loading data
[00:51:39]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Started analyzing
[00:51:39]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:39]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Waiting for result processor to complete
[00:51:39]                   │ debg > DFA job stats fetched.
[00:51:39]                   │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:51:39]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:39]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:39]                   │ debg > DFA job stats fetched.
[00:51:39]                   │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:51:39]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:39]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:39]                   │ debg > DFA job stats fetched.
[00:51:39]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:40]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:40]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:40]                   │ debg > DFA job stats fetched.
[00:51:40]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:40]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:40]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:40]                   │ debg > DFA job stats fetched.
[00:51:40]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:41]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:41]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:41]                   │ debg > DFA job stats fetched.
[00:51:41]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:41]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:41]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:41]                   │ debg > DFA job stats fetched.
[00:51:41]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:42]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:42]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:42]                   │ debg > DFA job stats fetched.
[00:51:42]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:42]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:42]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:42]                   │ debg > DFA job stats fetched.
[00:51:42]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:43]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:43]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:43]                   │ debg > DFA job stats fetched.
[00:51:43]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:43]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:43]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:43]                   │ debg > DFA job stats fetched.
[00:51:43]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:44]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:44]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:44]                   │ debg > DFA job stats fetched.
[00:51:44]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:44]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:44]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:44]                   │ debg > DFA job stats fetched.
[00:51:44]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:45]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:45]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:45]                   │ debg > DFA job stats fetched.
[00:51:45]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:45]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:45]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:45]                   │ debg > DFA job stats fetched.
[00:51:45]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:46]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:46]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:46]                   │ debg > DFA job stats fetched.
[00:51:46]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:46]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:46]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:46]                   │ debg > DFA job stats fetched.
[00:51:46]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:47]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:47]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:47]                   │ debg > DFA job stats fetched.
[00:51:47]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:47]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:47]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:47]                   │ debg > DFA job stats fetched.
[00:51:47]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:48]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:48]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:48]                   │ debg > DFA job stats fetched.
[00:51:48]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:48]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:48]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:48]                   │ debg > DFA job stats fetched.
[00:51:48]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:49]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:49]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:49]                   │ debg > DFA job stats fetched.
[00:51:49]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:49]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:49]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:49]                   │ debg > DFA job stats fetched.
[00:51:49]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:50]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:50]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:50]                   │ debg > DFA job stats fetched.
[00:51:50]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:50]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:50]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:50]                   │ debg > DFA job stats fetched.
[00:51:50]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:51]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:51]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:51]                   │ debg > DFA job stats fetched.
[00:51:51]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:51]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:51]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:51]                   │ debg > DFA job stats fetched.
[00:51:51]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:52]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:52]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:52]                   │ debg > DFA job stats fetched.
[00:51:52]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:52]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:52]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:52]                   │ debg > DFA job stats fetched.
[00:51:52]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:53]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] [data_frame_analyzer/224613] [CBoostedTreeImpl.cc@236] Exiting hyperparameter optimisation loop early
[00:51:53]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:53]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:53]                   │ debg > DFA job stats fetched.
[00:51:53]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:53]                   │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] finished storing trained model with id [ihp_fi_multi_1623177396834-1623180511001]
[00:51:53]                   │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Started writing results
[00:51:53]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Result processor has completed
[00:51:53]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Closing process
[00:51:53]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] [data_frame_analyzer/224613] [Main.cc@241] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":9613532}
[00:51:53]                   │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":1490468}
[00:51:53]                   │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":14157}
[00:51:53]                   │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":65}
[00:51:53]                   │      ]
[00:51:53]                   │ info [o.e.x.m.p.AbstractNativeProcess] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] State output finished
[00:51:53]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Closed process
[00:51:53]                   │ info [o.e.x.m.d.i.InferenceRunner] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Started inference on test data against model [ihp_fi_multi_1623177396834-1623180511001]
[00:51:53]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:53]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:53]                   │ debg > DFA job stats fetched.
[00:51:53]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:54]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:54]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:54]                   │ debg > DFA job stats fetched.
[00:51:54]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:54]                   │ info [o.e.x.m.d.DataFrameAnalyticsManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [ihp_fi_multi_1623177396834] Marking task completed
[00:51:54]                   │ debg Fetching analytics state for job ihp_fi_multi_1623177396834
[00:51:54]                   │ debg Fetching data frame analytics job stats for job ihp_fi_multi_1623177396834...
[00:51:55]                   │ debg > DFA job stats fetched.
[00:51:55]                   │ info [ml/egs_regression] Loading "mappings.json"
[00:51:55]                   │ info [ml/egs_regression] Loading "data.json.gz"
[00:51:55]                   │ info [ml/egs_regression] Skipped restore for existing index "ft_egs_regression"
[00:51:55]                   │ debg Searching for 'index-pattern' with title 'ft_egs_regression'...
[00:51:55]                   │ debg  > Found '03643730-c88f-11eb-aa4e-c728742f7f9c'
[00:51:55]                   │ debg Index pattern with title 'ft_egs_regression' already exists. Nothing to create.
[00:51:55]                   │ debg Creating data frame analytic job with id 'egs_fi_reg_1623177396834' ...
[00:51:55]                   │ debg Waiting up to 5000ms for 'egs_fi_reg_1623177396834' to exist...
[00:51:55]                   │ debg Fetching data frame analytics job 'egs_fi_reg_1623177396834'...
[00:51:55]                   │ debg > DFA job fetched.
[00:51:55]                   │ debg > DFA job created.
[00:51:55]                   │ debg Starting data frame analytics job 'egs_fi_reg_1623177396834'...
[00:51:55]                   │ info [o.e.x.m.a.TransportStartDataFrameAnalyticsAction] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Starting data frame analytics from state [stopped]
[00:51:55]                   │ debg > DFA job started.
[00:51:55]                   │ debg Waiting up to 60000ms for 'egs_fi_reg_1623177396834' to have training_docs_count > 0...
[00:51:55]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:55]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Creating destination index [user-egs_fi_reg_1623177396834]
[00:51:55]                   │ debg > DFA job stats fetched.
[00:51:55]                   │ debg --- retry.waitForWithTimeout error: expected data frame analytics job 'egs_fi_reg_1623177396834' to have training_docs_count > 0 (got 0)
[00:51:55]                   │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [user-egs_fi_reg_1623177396834] creating index, cause [api], templates [], shards [1]/[1]
[00:51:55]                   │ info [o.e.x.m.d.s.ReindexingStep] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Started reindexing
[00:51:56]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:56]                   │ debg > DFA job stats fetched.
[00:51:56]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:56]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Started loading data
[00:51:56]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Started analyzing
[00:51:56]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Waiting for result processor to complete
[00:51:56]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:56]                   │ debg > DFA job stats fetched.
[00:51:56]                   │ debg Waiting up to 120000ms for analytics state to be stopped...
[00:51:56]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:56]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:56]                   │ debg > DFA job stats fetched.
[00:51:56]                   │ debg --- retry.waitForWithTimeout error: expected analytics state to be stopped but got started
[00:51:57]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:57]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:57]                   │ debg > DFA job stats fetched.
[00:51:57]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:57]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:57]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:57]                   │ debg > DFA job stats fetched.
[00:51:57]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:58]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:58]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:58]                   │ debg > DFA job stats fetched.
[00:51:58]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:58]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:58]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:58]                   │ debg > DFA job stats fetched.
[00:51:58]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:59]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:59]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:59]                   │ debg > DFA job stats fetched.
[00:51:59]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:51:59]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:51:59]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:51:59]                   │ debg > DFA job stats fetched.
[00:51:59]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:00]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:00]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:00]                   │ debg > DFA job stats fetched.
[00:52:00]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:00]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:00]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:00]                   │ debg > DFA job stats fetched.
[00:52:00]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:01]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:01]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:01]                   │ debg > DFA job stats fetched.
[00:52:01]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:01]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:01]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:01]                   │ debg > DFA job stats fetched.
[00:52:01]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:02]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:02]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:02]                   │ debg > DFA job stats fetched.
[00:52:02]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:02]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:02]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:02]                   │ debg > DFA job stats fetched.
[00:52:02]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:03]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:03]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:03]                   │ debg > DFA job stats fetched.
[00:52:03]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:03]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:03]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:03]                   │ debg > DFA job stats fetched.
[00:52:03]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:04]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:04]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:04]                   │ debg > DFA job stats fetched.
[00:52:04]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:04]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:04]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:04]                   │ debg > DFA job stats fetched.
[00:52:04]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:05]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:05]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:05]                   │ debg > DFA job stats fetched.
[00:52:05]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:05]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:05]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:05]                   │ debg > DFA job stats fetched.
[00:52:05]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:06]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:06]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:06]                   │ debg > DFA job stats fetched.
[00:52:06]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:06]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:06]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:06]                   │ debg > DFA job stats fetched.
[00:52:06]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:07]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:07]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:07]                   │ debg > DFA job stats fetched.
[00:52:07]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:07]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:07]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:07]                   │ debg > DFA job stats fetched.
[00:52:07]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:08]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:08]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:08]                   │ debg > DFA job stats fetched.
[00:52:08]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:08]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:08]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:08]                   │ debg > DFA job stats fetched.
[00:52:08]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:09]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:09]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:09]                   │ debg > DFA job stats fetched.
[00:52:09]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:09]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:09]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:09]                   │ debg > DFA job stats fetched.
[00:52:09]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:10]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:10]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:10]                   │ debg > DFA job stats fetched.
[00:52:10]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:10]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:10]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:11]                   │ debg > DFA job stats fetched.
[00:52:11]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:11]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:11]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:11]                   │ debg > DFA job stats fetched.
[00:52:11]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:12]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:12]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:12]                   │ debg > DFA job stats fetched.
[00:52:12]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:12]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:12]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:12]                   │ debg > DFA job stats fetched.
[00:52:12]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:13]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:13]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:13]                   │ debg > DFA job stats fetched.
[00:52:13]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:13]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:13]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:13]                   │ debg > DFA job stats fetched.
[00:52:13]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:14]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:14]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:14]                   │ debg > DFA job stats fetched.
[00:52:14]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:14]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:14]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:14]                   │ debg > DFA job stats fetched.
[00:52:14]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:15]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:15]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:15]                   │ debg > DFA job stats fetched.
[00:52:15]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:15]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:15]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:15]                   │ debg > DFA job stats fetched.
[00:52:15]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:16]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:16]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:16]                   │ debg > DFA job stats fetched.
[00:52:16]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:16]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:16]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:16]                   │ debg > DFA job stats fetched.
[00:52:16]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:17]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:17]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:17]                   │ debg > DFA job stats fetched.
[00:52:17]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:17]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:17]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:17]                   │ debg > DFA job stats fetched.
[00:52:17]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:18]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:18]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:18]                   │ debg > DFA job stats fetched.
[00:52:18]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:18]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:18]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:18]                   │ debg > DFA job stats fetched.
[00:52:18]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:18]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] [data_frame_analyzer/225388] [CBoostedTreeImpl.cc@236] Exiting hyperparameter optimisation loop early
[00:52:19]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:19]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:19]                   │ debg > DFA job stats fetched.
[00:52:19]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:19]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:19]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:19]                   │ debg > DFA job stats fetched.
[00:52:19]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:19]                   │ info [o.e.x.m.d.p.ChunkedTrainedModelPersister] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] finished storing trained model with id [egs_fi_reg_1623177396834-1623180537370]
[00:52:19]                   │ info [o.e.x.m.d.p.AnalyticsResultProcessor] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Started writing results
[00:52:20]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:20]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:20]                   │ debg > DFA job stats fetched.
[00:52:20]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:20]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Result processor has completed
[00:52:20]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Closing process
[00:52:20]                   │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] [data_frame_analyzer/225388] [Main.cc@241] [{"name":"E_DFTPMEstimatedPeakMemoryUsage","description":"The upfront estimate of the peak memory training the predictive model would use","value":7582576}
[00:52:20]                   │      ,{"name":"E_DFTPMPeakMemoryUsage","description":"The peak memory training the predictive model used","value":6607693}
[00:52:20]                   │      ,{"name":"E_DFTPMTimeToTrain","description":"The time it took to train the predictive model","value":22834}
[00:52:20]                   │      ,{"name":"E_DFTPMTrainedForestNumberTrees","description":"The total number of trees in the trained forest","value":337}
[00:52:20]                   │      ]
[00:52:20]                   │ info [o.e.x.m.p.AbstractNativeProcess] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] State output finished
[00:52:20]                   │ info [o.e.x.m.d.p.AnalyticsProcessManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Closed process
[00:52:20]                   │ info [o.e.x.m.d.i.InferenceRunner] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Started inference on test data against model [egs_fi_reg_1623177396834-1623180537370]
[00:52:20]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:20]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:20]                   │ debg > DFA job stats fetched.
[00:52:20]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:21]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:21]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:21]                   │ debg > DFA job stats fetched.
[00:52:21]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:21]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:21]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:21]                   │ debg > DFA job stats fetched.
[00:52:21]                   │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:52:21]                   │ info [o.e.x.m.d.DataFrameAnalyticsManager] [kibana-ci-immutable-ubuntu-18-tests-xxl-1623175892915287101] [egs_fi_reg_1623177396834] Marking task completed
[00:52:22]                   │ debg Fetching analytics state for job egs_fi_reg_1623177396834
[00:52:22]                   │ debg Fetching data frame analytics job stats for job egs_fi_reg_1623177396834...
[00:52:22]                   │ debg > DFA job stats fetched.
[00:52:22]                 └-: binary classification job
[00:52:22]                   └-> "before all" hook for "should display the total feature importance in the results view"
[00:52:22]                   └-> "before all" hook for "should display the total feature importance in the results view"
[00:52:22]                     │ debg navigating to ml url: http://localhost:6191/app/ml
[00:52:22]                     │ debg navigate to: http://localhost:6191/app/ml
[00:52:22]                     │ debg browser[INFO] http://localhost:6191/app/ml?_t=1623180539651 340 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:52:22]                     │
[00:52:22]                     │ debg browser[INFO] http://localhost:6191/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:52:22]                     │ debg ... sleep(700) start
[00:52:23]                     │ debg ... sleep(700) end
[00:52:23]                     │ debg returned from get, calling refresh
[00:52:23]                     │ debg browser[INFO] http://localhost:6191/app/ml?_t=1623180539651 340 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:52:23]                     │
[00:52:23]                     │ debg browser[INFO] http://localhost:6191/bootstrap.js 41:19 "^ A single error about an inline script not firing due to content security policy is expected!"
[00:52:24]                     │ debg currentUrl = http://localhost:6191/app/ml
[00:52:24]                     │          appUrl = http://localhost:6191/app/ml
[00:52:24]                     │ debg TestSubjects.find(kibanaChrome)
[00:52:24]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:52:24]                     │ debg ... sleep(501) start
[00:52:24]                     │ERROR browser[SEVERE] http://localhost:6191/api/fleet/epm/packages?experimental=true - Failed to load resource: the server responded with a status of 403 (Forbidden)
[00:52:24]                     │ debg ... sleep(501) end
[00:52:24]                     │ debg in navigateTo url = http://localhost:6191/app/ml/overview
[00:52:24]                     │ debg --- retry.tryForTime error: URL changed, waiting for it to settle
[00:52:25]                     │ debg ... sleep(501) start
[00:52:25]                     │ debg ... sleep(501) end
[00:52:25]                     │ debg in navigateTo url = http://localhost:6191/app/ml/overview
[00:52:25]                     │ debg TestSubjects.exists(mlApp)
[00:52:25]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlApp"]') with timeout=2000
[00:52:25]                     │ debg TestSubjects.click(~mlMainTab & ~dataFrameAnalytics)
[00:52:25]                     │ debg Find.clickByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"]') with timeout=10000
[00:52:25]                     │ debg Find.findByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"]') with timeout=10000
[00:52:26]                     │ debg TestSubjects.exists(~mlMainTab & ~dataFrameAnalytics & ~selected)
[00:52:26]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlMainTab"][data-test-subj~="dataFrameAnalytics"][data-test-subj~="selected"]') with timeout=120000
[00:52:26]                     │ debg TestSubjects.exists(mlPageDataFrameAnalytics)
[00:52:26]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlPageDataFrameAnalytics"]') with timeout=120000
[00:52:26]                     │ debg TestSubjects.exists(~mlAnalyticsTable)
[00:52:26]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlAnalyticsTable"]') with timeout=60000
[00:52:26]                     │ debg TestSubjects.exists(mlAnalyticsTable loaded)
[00:52:26]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlAnalyticsTable loaded"]') with timeout=30000
[00:52:26]                     │ debg Searching for 'index-pattern' with title 'user-ihp_fi_binary_1623177396834'...
[00:52:26]                     │ debg  > Not found
[00:52:26]                     │ debg Creating index pattern with title 'user-ihp_fi_binary_1623177396834'
[00:52:27]                     │ debg Waiting up to 5000ms for index-pattern with title 'user-ihp_fi_binary_1623177396834' to exist...
[00:52:27]                     │ debg Searching for 'index-pattern' with title 'user-ihp_fi_binary_1623177396834'...
[00:52:27]                     │ debg  > Found 'c8cdef70-c88f-11eb-aa4e-c728742f7f9c'
[00:52:27]                     │ debg  > Created with id 'c8cdef70-c88f-11eb-aa4e-c728742f7f9c'
[00:52:27]                     │ debg TestSubjects.exists(~mlAnalyticsTable > ~row-ihp_fi_binary_1623177396834 > mlAnalyticsJobViewButton)
[00:52:27]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_binary_1623177396834"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=120000
[00:52:27]                     │ debg TestSubjects.click(~mlAnalyticsTable > ~row-ihp_fi_binary_1623177396834 > mlAnalyticsJobViewButton)
[00:52:27]                     │ debg Find.clickByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_binary_1623177396834"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=10000
[00:52:27]                     │ debg Find.findByCssSelector('[data-test-subj~="mlAnalyticsTable"] [data-test-subj~="row-ihp_fi_binary_1623177396834"] [data-test-subj="mlAnalyticsJobViewButton"]') with timeout=10000
[00:52:27]                     │ debg TestSubjects.exists(mlPageDataFrameAnalyticsExploration)
[00:52:27]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlPageDataFrameAnalyticsExploration"]') with timeout=20000
[00:52:27]                   └-> should display the total feature importance in the results view
[00:52:27]                     └-> "before each" hook: global before each for "should display the total feature importance in the results view"
[00:52:27]                     │ debg TestSubjects.exists(mlDFExpandableSection-FeatureImportanceSummary)
[00:52:27]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlDFExpandableSection-FeatureImportanceSummary"]') with timeout=120000
[00:52:28]                     │ debg TestSubjects.exists(mlTotalFeatureImportanceChart)
[00:52:28]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlTotalFeatureImportanceChart"]') with timeout=5000
[00:52:30]                     └- ✓ pass  (2.7s) "machine learning  data frame analytics total feature importance panel and decision path popover binary classification job should display the total feature importance in the results view"
[00:52:30]                   └-> should display the feature importance decision path in the data grid
[00:52:30]                     └-> "before each" hook: global before each for "should display the feature importance decision path in the data grid"
[00:52:30]                     │ debg TestSubjects.exists(mlExplorationDataGrid loaded)
[00:52:30]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=5000
[00:52:30]                     │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:52:30]                     │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:52:30]                     │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:52:30]                     │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:52:30]                     │ debg TestSubjects.find(mlExplorationDataGrid loaded)
[00:52:30]                     │ debg Find.findByCssSelector('[data-test-subj="mlExplorationDataGrid loaded"]') with timeout=10000
[00:52:30]                     │ debg --- retry.tryForTime error: Expected data grid cell button to be visible
[00:52:31]                     │ debg TestSubjects.exists(mlDFADecisionPathPopover)
[00:52:31]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="mlDFADecisionPathPopover"]') with timeout=120000
[00:52:34]                     │ debg --- retry.tryForTime error: [data-test-subj="mlDFADecisionPathPopover"] is not displayed
[00:52:37]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:40]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:43]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:46]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:49]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:52]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:55]                     │ debg --- retry.tryForTime failed again with the same message...
[00:52:58]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:01]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:04]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:07]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:10]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:13]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:16]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:19]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:22]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:25]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:28]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:31]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:34]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:37]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:40]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:43]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:46]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:49]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:52]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:55]                     │ debg --- retry.tryForTime failed again with the same message...
[00:53:58]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:01]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:04]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:07]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:10]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:13]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:16]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:19]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:22]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:25]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:29]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:32]                     │ debg --- retry.tryForTime failed again with the same message...
[00:54:32]                     │ info Taking screenshot "/dev/shm/workspace/parallel/9/kibana/x-pack/test/functional/screenshots/failure/machine learning  data frame analytics total feature importance panel and decision path popover binary classification job should display the feature importance decision path in the data grid.png"
[00:54:32]                     │ info Current URL is: http://localhost:6191/app/ml/data_frame_analytics/exploration?_g=(ml%3A(analysisType%3Aclassification%2CjobId%3Aihp_fi_binary_1623177396834))
[00:54:32]                     │ info Saving page source to: /dev/shm/workspace/parallel/9/kibana/x-pack/test/functional/failure_debug/html/machine learning  data frame analytics total feature importance panel and decision path popover binary classification job should display the feature importance decision path in the data grid.html
[00:54:32]                     └- ✖ fail: machine learning  data frame analytics total feature importance panel and decision path popover binary classification job should display the feature importance decision path in the data grid
[00:54:32]                     │      Error: expected testSubject(mlDFADecisionPathPopover) to exist
[00:54:32]                     │       at TestSubjects.existOrFail (/dev/shm/workspace/parallel/9/kibana/test/functional/services/common/test_subjects.ts:45:13)
[00:54:32]                     │       at Object.openFeatureImportanceDecisionPathPopover (test/functional/services/ml/data_frame_analytics_results.ts:163:7)
[00:54:32]                     │       at Context.<anonymous> (test/functional/apps/ml/data_frame_analytics/feature_importance.ts:207:11)
[00:54:32]                     │       at Object.apply (/dev/shm/workspace/parallel/9/kibana/node_modules/@kbn/test/src/functional_test_runner/lib/mocha/wrap_function.js:73:16)
[00:54:32]                     │ 
[00:54:32]                     │ 

Stack Trace

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

Metrics [docs]

Public APIs missing comments

Total count of every public API that lacks a comment. Target amount is 0. Run node scripts/build_api_docs --plugin [yourplugin] --stats comments for more detailed information.

id before after diff
security 36 45 +9

Public APIs missing exports

Total count of every type that is part of your API that should be exported but is not. This will cause broken links in the API documentation system. Target amount is 0. Run node scripts/build_api_docs --plugin [yourplugin] --stats exports for more detailed information.

id before after diff
security 15 11 -4

Page load bundle

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

id before after diff
security 82.3KB 82.5KB +179.0B
Unknown metric groups

API count

id before after diff
security 77 95 +18

History

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

gmmorris added a commit to gmmorris/kibana that referenced this pull request Jun 9, 2021
* master: (54 commits)
  Implement "select all" rules feature (elastic#100554)
  [ML] Remove script fields from the Anomaly detection alerting rule executor  (elastic#101607)
  [Security solutions][Endpoint] Update event filtering texts (elastic#101563)
  [Enterprise Search] Mocks/tests tech debt - avoid hungry mocking (elastic#101107)
  [FTR] Updates esArchive paths
  [FTR] Updates esArchive paths
  [Security Solution][Detection Engine] Adds runtime field tests (elastic#101664)
  Added APM PHP agent to the list of agent names (elastic#101062)
  [CI] Restore old version_info behavior when .git directory is present (elastic#101642)
  [Fleet] Add fleet server telemetry (elastic#101400)
  [APM] Syncs agent config settings to APM Fleet policies (elastic#100744)
  [esArchiver] drop support for --dir, use repo-relative paths instead (elastic#101345)
  Revert "[xpack/test] restore incremental: false in ts project"
  [Security Solution] Remove Host Isolation feature flag (elastic#101655)
  [xpack/test] restore incremental: false in ts project
  [DOCS] Adds link to video landing page (elastic#101413)
  [ML] Move Index Data Visualizer into separate plugin (Part 1) (elastic#100922)
  Improve security plugin return types (elastic#101492)
  [ts] migrate `x-pack/test` to composite ts project (elastic#101441)
  [App Search] Updated Search UI to new URL (elastic#101320)
  ...
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
auto-backport Deprecated: Automatically backport this PR after it's merged release_note:plugin_api_changes Contains a Plugin API changes section for the breaking plugin API changes section. release_note:skip Skip the PR/issue when compiling release notes v7.14.0 v8.0.0
Projects
None yet
Development

Successfully merging this pull request may close these issues.

None yet

3 participants