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

Unrevert "Migrations v2: don't auto-create indices + FTR/esArchiver support (#85778)" #89992

Merged
merged 14 commits into from
Feb 6, 2021

Conversation

rudolf
Copy link
Contributor

@rudolf rudolf commented Feb 2, 2021

This reverts commit f979580 to add back v2 migrations to FTR after #85778 was reverted.

From #85778

Saved objects no longer auto-creates indices

The new migrations aren't compatible with an auto-created saved objects index, so when tests delete .kibana and then use the saved objects client, the next test will fail because migrations fail. We could hack the v2 migrations to still work on the auto-created indices, but this is never the behaviour a user wants. If the saved objects index was deleted while Kibana was running we should "stop the world" and let users investigate. Our current behaviour means users sometimes end up with some changes in a new index and cannot "merge" the two indices and causes all sorts of runtime failures because of incompatible mappings or upgrade failures.

So this PR starts implementing the decision in #81790 to never auto-create system indices. I'm using the require_alias query parameter which means we could theoretically miss a route, but something is better than nothing until we move to a system index.

It reverses the decision in #14141 where we formalized the auto-create index behaviour in 6.1. However, when this decision was made Kibana used an index template so an auto-created index was acceptable since it would always have the correct mappings. With this PR, if the saved objects index and aliases doesn't exist, indexing actions will return a 500. I think we should also return a 500 for read operations when the index doesn't exist since Kibana really is broken, it's not the same as not being able to find a particular saved object, but I felt like this could be postponed into a follow-up PR (created #89642 to track this).

Enables v2 migrations in all tests

Because of removing the auto-create index behaviour I had to adapt tests to always initialize an empty kibana with esArchiver.emptyKibanaIndex() or move some before statements around so that we don't set UiSettings before the index gets initialized.

Closes #85911
Closes #91445

In this PR

I also changed the migrations algorithm slightly. Before, if a clone or create index failed with index_already_exists_exception we would wait until that index's status turns green. This PR changes that to only wait for a yellow status.

Checklist

Delete any items that are not applicable to this PR.

For maintainers

@rudolf rudolf added Team:Core Core services & architecture: plugins, logging, config, saved objects, http, ES client, i18n, etc v8.0.0 release_note:skip Skip the PR/issue when compiling release notes v7.12.0 project:ResilientSavedObjectMigrations Reduce Kibana upgrade failures by making saved object migrations more resilient labels Feb 2, 2021
@rudolf rudolf force-pushed the reenable-v2-migrations-in-ftr branch from d55ae08 to 1a8e158 Compare February 2, 2021 11:07
@rudolf
Copy link
Contributor Author

rudolf commented Feb 2, 2021

@elasticmachine merge upstream

@rudolf
Copy link
Contributor Author

rudolf commented Feb 3, 2021

@elasticmachine retest

@rudolf
Copy link
Contributor Author

rudolf commented Feb 3, 2021

@elasticmachine merge upstream

1 similar comment
@rudolf
Copy link
Contributor Author

rudolf commented Feb 3, 2021

@elasticmachine merge upstream

@spalger
Copy link
Contributor

spalger commented Feb 3, 2021

jenkins test this

@rudolf
Copy link
Contributor Author

rudolf commented Feb 4, 2021

@elasticmachine merge upstream

@kibanamachine
Copy link
Contributor

merge conflict between base and head

@rudolf rudolf force-pushed the reenable-v2-migrations-in-ftr branch from 77eb221 to c647e18 Compare February 4, 2021 10:30
@rudolf
Copy link
Contributor Author

rudolf commented Feb 4, 2021

jenkins test this

@rudolf
Copy link
Contributor Author

rudolf commented Feb 5, 2021

last failure seems like it was jenkins related, no tests failed but there was a java.lang.NullPointerException

@rudolf
Copy link
Contributor Author

rudolf commented Feb 5, 2021

jenkins test this

@rudolf
Copy link
Contributor Author

rudolf commented Feb 5, 2021

Firefox failure seems to be introduced by https://github.com/elastic/kibana/pull/89942/files#r570906828

@@ -66,20 +66,3 @@
}
}
}

{
Copy link
Contributor Author

@rudolf rudolf Feb 5, 2021

Choose a reason for hiding this comment

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

saved objects management sorts by type and the API doesn't allow sorting by two fields. So having a 6 config object and a 8 config object causes unstable tests because of the unstable ordering, so I just deleted this unused object.

Copy link
Contributor

@jportner jportner left a comment

Choose a reason for hiding this comment

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

Security change in test/security_functional/insecure_cluster_warning.ts LGTM

@tylersmalley
Copy link
Contributor

@elasticmachine merge upstream

@rudolf
Copy link
Contributor Author

rudolf commented Feb 6, 2021

@elasticmachine merge upstream

@rudolf rudolf merged commit fd1d965 into elastic:master Feb 6, 2021
@rudolf rudolf deleted the reenable-v2-migrations-in-ftr branch February 6, 2021 17:45
gmmorris added a commit to gmmorris/kibana that referenced this pull request Feb 8, 2021
* master: (55 commits)
  [APM-UI][E2E] use githubNotify step (elastic#90514)
  [APM] Export ProcessorEvent type (elastic#90540)
  [Lens] Retain column config (elastic#90048)
  [Data Table] Add unit tests (elastic#90173)
  Migrate most plugins to synchronous lifecycle (elastic#89562)
  skip flaky suite (elastic#90555)
  skip flaky suite (elastic#64473)
  [actions] improve email action doc (elastic#90020)
  [Fleet] Support Fleet server system indices (elastic#89372)
  skip flaky suite (elastic#90552)
  Bump immer dependencies (elastic#90267)
  Unrevert "Migrations v2: don't auto-create indices + FTR/esArchiver support (elastic#85778)" (elastic#89992)
  [Search Sessions] Use sync config (elastic#90138)
  chore(NA): add safe guard to remove bazelisk from yarn global at bootstrap (elastic#90538)
  [test] Await retry.waitFor (elastic#90456)
  chore(NA): integrate build buddy with our bazel setup and remote cache for ci (elastic#90116)
  Skip failing suite (elastic#90526)
  [Fleet] Fix incorrect conversion of string to numeric values in agent YAML (elastic#90371)
  [Docs] Update reporting troubleshooting for arm rhel/centos (elastic#90385)
  chore(NA): build bazel projects all at once in the distributable build process (elastic#90328)
  ...
@kibanamachine kibanamachine added the backport missing Added to PRs automatically when the are determined to be missing a backport. label Feb 9, 2021
@kibanamachine
Copy link
Contributor

Friendly reminder: Looks like this PR hasn’t been backported yet.
To create backports run node scripts/backport --pr 89992 or prevent reminders by adding the backport:skip label.

rudolf added a commit to rudolf/kibana that referenced this pull request Feb 9, 2021
…upport (elastic#85778)" (elastic#89992)

* Revert "Revert "Migrations v2: don't auto-create indices + FTR/esArchiver support (elastic#85778)""

This reverts commit f979580.

* Fix flaky saved objects management test elastic#89953

* If a clone target exists, wait for yellow, not green, index status

* Fix test after master merge

* Fix types

Co-authored-by: Kibana Machine <42973632+kibanamachine@users.noreply.github.com>
@rudolf rudolf mentioned this pull request Feb 10, 2021
17 tasks
@kibanamachine
Copy link
Contributor

Looks like this PR has a backport PR but it still hasn't been merged. Please merge it ASAP to keep the branches relatively in sync.

2 similar comments
@kibanamachine
Copy link
Contributor

Looks like this PR has a backport PR but it still hasn't been merged. Please merge it ASAP to keep the branches relatively in sync.

@kibanamachine
Copy link
Contributor

Looks like this PR has a backport PR but it still hasn't been merged. Please merge it ASAP to keep the branches relatively in sync.

@kibanamachine
Copy link
Contributor

Looks like this PR has a backport PR but it still hasn't been merged. Please merge it ASAP to keep the branches relatively in sync.

@kibanamachine
Copy link
Contributor

kibanamachine commented Feb 16, 2021

💔 Build Failed

Failed CI Steps


Test Failures

Kibana Pipeline / general / X-Pack API Integration Tests.x-pack/test/api_integration/apis/ml/modules/setup_module·ts.apis Machine Learning modules module setup sets up module data for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true

Link to Jenkins

Standard Out

Failed Tests Reporter:
  - Test has failed 1 times on tracked branches: https://dryrun

[00:00:00]       │
[00:00:00]         └-: apis
[00:00:00]           └-> "before all" hook in "apis"
[00:07:02]           └-: Machine Learning
[00:07:02]             └-> "before all" hook in "Machine Learning"
[00:07:02]             └-> "before all" hook in "Machine Learning"
[00:07:02]               │ debg creating role ft_ml_source
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_source]
[00:07:02]               │ debg creating role ft_ml_source_readonly
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_source_readonly]
[00:07:02]               │ debg creating role ft_ml_dest
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_dest]
[00:07:02]               │ debg creating role ft_ml_dest_readonly
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_dest_readonly]
[00:07:02]               │ debg creating role ft_ml_ui_extras
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_ui_extras]
[00:07:02]               │ debg creating role ft_default_space_ml_all
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_all]
[00:07:02]               │ debg creating role ft_default_space1_ml_all
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space1_ml_all]
[00:07:02]               │ debg creating role ft_all_spaces_ml_all
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_all_spaces_ml_all]
[00:07:02]               │ debg creating role ft_default_space_ml_read
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_read]
[00:07:02]               │ debg creating role ft_default_space1_ml_read
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space1_ml_read]
[00:07:02]               │ debg creating role ft_all_spaces_ml_read
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_all_spaces_ml_read]
[00:07:02]               │ debg creating role ft_default_space_ml_none
[00:07:02]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_none]
[00:07:02]               │ debg creating user ft_ml_poweruser
[00:07:02]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser]
[00:07:02]               │ debg created user ft_ml_poweruser
[00:07:02]               │ debg creating user ft_ml_poweruser_spaces
[00:07:02]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_spaces]
[00:07:02]               │ debg created user ft_ml_poweruser_spaces
[00:07:02]               │ debg creating user ft_ml_poweruser_space1
[00:07:02]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_space1]
[00:07:02]               │ debg created user ft_ml_poweruser_space1
[00:07:02]               │ debg creating user ft_ml_poweruser_all_spaces
[00:07:02]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_all_spaces]
[00:07:02]               │ debg created user ft_ml_poweruser_all_spaces
[00:07:02]               │ debg creating user ft_ml_viewer
[00:07:02]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer]
[00:07:02]               │ debg created user ft_ml_viewer
[00:07:02]               │ debg creating user ft_ml_viewer_spaces
[00:07:03]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_spaces]
[00:07:03]               │ debg created user ft_ml_viewer_spaces
[00:07:03]               │ debg creating user ft_ml_viewer_space1
[00:07:03]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_space1]
[00:07:03]               │ debg created user ft_ml_viewer_space1
[00:07:03]               │ debg creating user ft_ml_viewer_all_spaces
[00:07:03]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_all_spaces]
[00:07:03]               │ debg created user ft_ml_viewer_all_spaces
[00:07:03]               │ debg creating user ft_ml_unauthorized
[00:07:03]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_unauthorized]
[00:07:03]               │ debg created user ft_ml_unauthorized
[00:07:03]               │ debg creating user ft_ml_unauthorized_spaces
[00:07:03]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_unauthorized_spaces]
[00:07:03]               │ debg created user ft_ml_unauthorized_spaces
[00:07:03]             └-: modules
[00:07:03]               └-> "before all" hook in "modules"
[00:07:17]               └-: module setup
[00:07:17]                 └-> "before all" hook in "module setup"
[00:07:17]                 └-> "before all" hook in "module setup"
[00:07:17]                   │ debg applying update to kibana config: {"dateFormat:tz":"UTC"}
[00:08:03]                 └-: sets up module data
[00:08:03]                   └-> "before all" hook for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:03]                   └-> "before all" hook for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:03]                     │ info [ml/module_logs] Loading "mappings.json"
[00:08:03]                     │ info [ml/module_logs] Loading "data.json.gz"
[00:08:03]                     │ info [ml/module_logs] Skipped restore for existing index "ft_module_logs"
[00:08:03]                     │ debg Searching for 'index-pattern' with title 'ft_module_logs'...
[00:08:03]                     │ debg  > Found '7d48e410-7047-11eb-95c4-b75e546da187'
[00:08:03]                     │ debg Index pattern with title 'ft_module_logs' already exists. Nothing to create.
[00:08:03]                   └-> for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true
[00:08:03]                     └-> "before each" hook: global before each for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:03]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared] creating index, cause [api], templates [.ml-anomalies-], shards [1]/[1]
[00:08:03]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-anomalies-shared]
[00:08:03]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-annotations-6] creating index, cause [api], templates [], shards [1]/[1]
[00:08:03]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-annotations-6]
[00:08:03]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/e2yQ-VNKQ4mMKBKy1oshWw] update_mapping [_doc]
[00:08:03]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-config] creating index, cause [auto(bulk api)], templates [], shards [1]/[1]
[00:08:03]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-config]
[00:08:03]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-notifications-000001] creating index, cause [auto(bulk api)], templates [.ml-notifications-000001], shards [1]/[1]
[00:08:03]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-notifications-000001]
[00:08:05]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Opening job [pf7_log-entry-categories-count]
[00:08:05]                     │ info [o.e.x.c.m.u.MlIndexAndAlias] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] About to create first concrete index [.ml-state-000001] with alias [.ml-state-write]
[00:08:05]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-state-000001] creating index, cause [api], templates [.ml-state], shards [1]/[1]
[00:08:05]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-state-000001]
[00:08:05]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] moving index [.ml-state-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:08:05]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] 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:08:05]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Loading model snapshot [N/A], job latest_record_timestamp [N/A]
[00:08:05]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] 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:08:05]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/300013] [CResourceMonitor.cc@77] Setting model memory limit to 41 MB
[00:08:05]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Successfully set job state to [opened] for job [pf7_log-entry-categories-count]
[00:08:05]                     │ info [o.e.x.m.d.DatafeedJob] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Datafeed started (from: 1970-01-01T00:00:00.000Z to: 2021-02-16T11:01:55.664Z) with frequency [450000ms]
[00:08:05]                     │ debg Waiting up to 5000ms for 'pf7_log-entry-categories-count' to exist...
[00:08:05]                     │ debg Waiting up to 5000ms for 'datafeed-pf7_log-entry-categories-count' to exist...
[00:08:05]                     │ debg Waiting up to 10000ms for 'pf7_log-entry-categories-count' to have processed_record_count > 0...
[00:08:05]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:05]                     │ debg > AD job stats fetched.
[00:08:05]                     │ debg --- retry.waitForWithTimeout error: expected anomaly detection job 'pf7_log-entry-categories-count' to have processed_record_count > 0 (got 0)
[00:08:06]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/e2yQ-VNKQ4mMKBKy1oshWw] update_mapping [_doc]
[00:08:06]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:06]                     │ debg > AD job stats fetched.
[00:08:06]                     │ debg Waiting up to 120000ms for job state to be closed...
[00:08:06]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:06]                     │ debg > AD job stats fetched.
[00:08:06]                     │ debg --- retry.waitForWithTimeout error: expected job state to be closed but got opened
[00:08:06]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:06]                     │ debg > AD job stats fetched.
[00:08:06]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:07]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:07]                     │ debg > AD job stats fetched.
[00:08:07]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:07]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:07]                     │ debg > AD job stats fetched.
[00:08:07]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:08]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:08]                     │ debg > AD job stats fetched.
[00:08:08]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:08]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:08]                     │ debg > AD job stats fetched.
[00:08:08]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:09]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:09]                     │ debg > AD job stats fetched.
[00:08:09]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:10]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:10]                     │ debg > AD job stats fetched.
[00:08:10]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:10]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:10]                     │ debg > AD job stats fetched.
[00:08:10]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:11]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:11]                     │ debg > AD job stats fetched.
[00:08:11]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:11]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:11]                     │ debg > AD job stats fetched.
[00:08:11]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:12]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:12]                     │ debg > AD job stats fetched.
[00:08:12]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:12]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:12]                     │ debg > AD job stats fetched.
[00:08:12]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:13]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:13]                     │ debg > AD job stats fetched.
[00:08:13]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:13]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:13]                     │ debg > AD job stats fetched.
[00:08:13]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:14]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:14]                     │ debg > AD job stats fetched.
[00:08:14]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:14]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:14]                     │ debg > AD job stats fetched.
[00:08:14]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:15]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:15]                     │ debg > AD job stats fetched.
[00:08:15]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:15]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:15]                     │ debg > AD job stats fetched.
[00:08:15]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:16]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:16]                     │ debg > AD job stats fetched.
[00:08:16]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:16]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:16]                     │ debg > AD job stats fetched.
[00:08:16]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:17]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:17]                     │ debg > AD job stats fetched.
[00:08:17]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:17]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:17]                     │ debg > AD job stats fetched.
[00:08:17]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:18]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:18]                     │ debg > AD job stats fetched.
[00:08:18]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:18]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:18]                     │ debg > AD job stats fetched.
[00:08:18]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:19]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:19]                     │ debg > AD job stats fetched.
[00:08:19]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:19]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:19]                     │ debg > AD job stats fetched.
[00:08:19]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:20]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:20]                     │ debg > AD job stats fetched.
[00:08:20]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:20]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:20]                     │ debg > AD job stats fetched.
[00:08:20]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:21]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:21]                     │ debg > AD job stats fetched.
[00:08:21]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:21]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:21]                     │ debg > AD job stats fetched.
[00:08:21]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:22]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:22]                     │ debg > AD job stats fetched.
[00:08:22]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:22]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:22]                     │ debg > AD job stats fetched.
[00:08:22]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:23]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:23]                     │ debg > AD job stats fetched.
[00:08:23]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:23]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:23]                     │ debg > AD job stats fetched.
[00:08:23]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:24]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:24]                     │ debg > AD job stats fetched.
[00:08:24]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:24]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:24]                     │ debg > AD job stats fetched.
[00:08:24]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:25]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:25]                     │ debg > AD job stats fetched.
[00:08:25]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:25]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:25]                     │ debg > AD job stats fetched.
[00:08:25]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:25]                     │ info [o.e.x.m.d.DatafeedJob] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Lookback has finished
[00:08:25]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] attempt to stop datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count]
[00:08:25]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] try lock [20s] to stop datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count]...
[00:08:25]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] stopping datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count], acquired [true]...
[00:08:25]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count] has been stopped
[00:08:25]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Closing job [pf7_log-entry-categories-count], because [close job (api)]
[00:08:25]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/300013] [CCmdSkeleton.cc@61] Handled 584 records
[00:08:25]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/300013] [CAnomalyJob.cc@1569] Pruning all models
[00:08:26]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/e2yQ-VNKQ4mMKBKy1oshWw] update_mapping [_doc]
[00:08:26]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:26]                     │ debg > AD job stats fetched.
[00:08:26]                     │ debg --- retry.waitForWithTimeout error: expected job state to be closed but got closing
[00:08:26]                     │ info [o.e.x.m.p.AbstractNativeProcess] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] State output finished
[00:08:26]                     │ info [o.e.x.m.j.p.a.o.AutodetectResultProcessor] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] 2342 buckets parsed from autodetect output
[00:08:26]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:26]                     │ debg > AD job stats fetched.
[00:08:26]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:26]                     │ info [o.e.x.m.j.p.a.AutodetectCommunicator] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] job closed
[00:08:27]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:27]                     │ debg > AD job stats fetched.
[00:08:27]                     │ debg Waiting up to 120000ms for datafeed state to be stopped...
[00:08:27]                     │ debg Fetching datafeed state for datafeed datafeed-pf7_log-entry-categories-count
[00:08:27]                     └- ✖ fail: apis Machine Learning modules module setup sets up module data for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true
[00:08:27]                     │       Error: Expected job model memory limits '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"26mb"}]' (got '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"41mb"}]')
[00:08:27]                     │       + expected - actual
[00:08:27]                     │ 
[00:08:27]                     │        [
[00:08:27]                     │          {
[00:08:27]                     │            "id": "pf7_log-entry-categories-count"
[00:08:27]                     │       -    "modelMemoryLimit": "41mb"
[00:08:27]                     │       +    "modelMemoryLimit": "26mb"
[00:08:27]                     │          }
[00:08:27]                     │        ]
[00:08:27]                     │       
[00:08:27]                     │       at Assertion.assert (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:100:11)
[00:08:27]                     │       at Assertion.eql (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:244:8)
[00:08:27]                     │       at Context.<anonymous> (test/api_integration/apis/ml/modules/setup_module.ts:869:46)
[00:08:27]                     │       at Object.apply (/dev/shm/workspace/parallel/1/kibana/packages/kbn-test/src/functional_test_runner/lib/mocha/wrap_function.js:73:16)
[00:08:27]                     │ 
[00:08:27]                     │ 

Stack Trace

Error: Expected job model memory limits '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"26mb"}]' (got '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"41mb"}]')
    at Assertion.assert (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:100:11)
    at Assertion.eql (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:244:8)
    at Context.<anonymous> (test/api_integration/apis/ml/modules/setup_module.ts:869:46)
    at Object.apply (/dev/shm/workspace/parallel/1/kibana/packages/kbn-test/src/functional_test_runner/lib/mocha/wrap_function.js:73:16) {
  actual: '[\n' +
    '  {\n' +
    '    "id": "pf7_log-entry-categories-count"\n' +
    '    "modelMemoryLimit": "41mb"\n' +
    '  }\n' +
    ']',
  expected: '[\n' +
    '  {\n' +
    '    "id": "pf7_log-entry-categories-count"\n' +
    '    "modelMemoryLimit": "26mb"\n' +
    '  }\n' +
    ']',
  showDiff: true
}

Kibana Pipeline / general / X-Pack API Integration Tests.x-pack/test/api_integration/apis/ml/modules/setup_module·ts.apis Machine Learning modules module setup sets up module data for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true

Link to Jenkins

Standard Out

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

[00:00:00]       │
[00:00:00]         └-: apis
[00:00:00]           └-> "before all" hook in "apis"
[00:07:09]           └-: Machine Learning
[00:07:09]             └-> "before all" hook in "Machine Learning"
[00:07:09]             └-> "before all" hook in "Machine Learning"
[00:07:09]               │ debg creating role ft_ml_source
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_source]
[00:07:09]               │ debg creating role ft_ml_source_readonly
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_source_readonly]
[00:07:09]               │ debg creating role ft_ml_dest
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_dest]
[00:07:09]               │ debg creating role ft_ml_dest_readonly
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_dest_readonly]
[00:07:09]               │ debg creating role ft_ml_ui_extras
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_ml_ui_extras]
[00:07:09]               │ debg creating role ft_default_space_ml_all
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_all]
[00:07:09]               │ debg creating role ft_default_space1_ml_all
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space1_ml_all]
[00:07:09]               │ debg creating role ft_all_spaces_ml_all
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_all_spaces_ml_all]
[00:07:09]               │ debg creating role ft_default_space_ml_read
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_read]
[00:07:09]               │ debg creating role ft_default_space1_ml_read
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space1_ml_read]
[00:07:09]               │ debg creating role ft_all_spaces_ml_read
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_all_spaces_ml_read]
[00:07:09]               │ debg creating role ft_default_space_ml_none
[00:07:09]               │ info [o.e.x.s.a.r.TransportPutRoleAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added role [ft_default_space_ml_none]
[00:07:09]               │ debg creating user ft_ml_poweruser
[00:07:09]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser]
[00:07:09]               │ debg created user ft_ml_poweruser
[00:07:09]               │ debg creating user ft_ml_poweruser_spaces
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_spaces]
[00:07:10]               │ debg created user ft_ml_poweruser_spaces
[00:07:10]               │ debg creating user ft_ml_poweruser_space1
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_space1]
[00:07:10]               │ debg created user ft_ml_poweruser_space1
[00:07:10]               │ debg creating user ft_ml_poweruser_all_spaces
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_poweruser_all_spaces]
[00:07:10]               │ debg created user ft_ml_poweruser_all_spaces
[00:07:10]               │ debg creating user ft_ml_viewer
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer]
[00:07:10]               │ debg created user ft_ml_viewer
[00:07:10]               │ debg creating user ft_ml_viewer_spaces
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_spaces]
[00:07:10]               │ debg created user ft_ml_viewer_spaces
[00:07:10]               │ debg creating user ft_ml_viewer_space1
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_space1]
[00:07:10]               │ debg created user ft_ml_viewer_space1
[00:07:10]               │ debg creating user ft_ml_viewer_all_spaces
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_viewer_all_spaces]
[00:07:10]               │ debg created user ft_ml_viewer_all_spaces
[00:07:10]               │ debg creating user ft_ml_unauthorized
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_unauthorized]
[00:07:10]               │ debg created user ft_ml_unauthorized
[00:07:10]               │ debg creating user ft_ml_unauthorized_spaces
[00:07:10]               │ info [o.e.x.s.a.u.TransportPutUserAction] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] added user [ft_ml_unauthorized_spaces]
[00:07:10]               │ debg created user ft_ml_unauthorized_spaces
[00:07:10]             └-: modules
[00:07:10]               └-> "before all" hook in "modules"
[00:07:24]               └-: module setup
[00:07:24]                 └-> "before all" hook in "module setup"
[00:07:24]                 └-> "before all" hook in "module setup"
[00:07:24]                   │ debg applying update to kibana config: {"dateFormat:tz":"UTC"}
[00:08:11]                 └-: sets up module data
[00:08:11]                   └-> "before all" hook for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:11]                   └-> "before all" hook for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:11]                     │ info [ml/module_logs] Loading "mappings.json"
[00:08:11]                     │ info [ml/module_logs] Loading "data.json.gz"
[00:08:11]                     │ info [ml/module_logs] Skipped restore for existing index "ft_module_logs"
[00:08:11]                     │ debg Searching for 'index-pattern' with title 'ft_module_logs'...
[00:08:11]                     │ debg  > Found '5da3e040-7044-11eb-8e7b-d1664c0656eb'
[00:08:11]                     │ debg Index pattern with title 'ft_module_logs' already exists. Nothing to create.
[00:08:11]                   └-> for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true
[00:08:11]                     └-> "before each" hook: global before each for "for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true"
[00:08:11]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared] creating index, cause [api], templates [.ml-anomalies-], shards [1]/[1]
[00:08:11]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-anomalies-shared]
[00:08:11]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-annotations-6] creating index, cause [api], templates [], shards [1]/[1]
[00:08:11]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-annotations-6]
[00:08:11]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/CHQgS0doTKaWvpDOudtneQ] update_mapping [_doc]
[00:08:11]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-config] creating index, cause [auto(bulk api)], templates [], shards [1]/[1]
[00:08:11]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-config]
[00:08:11]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-notifications-000001] creating index, cause [auto(bulk api)], templates [.ml-notifications-000001], shards [1]/[1]
[00:08:11]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-notifications-000001]
[00:08:13]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Opening job [pf7_log-entry-categories-count]
[00:08:13]                     │ info [o.e.x.c.m.u.MlIndexAndAlias] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] About to create first concrete index [.ml-state-000001] with alias [.ml-state-write]
[00:08:13]                     │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-state-000001] creating index, cause [api], templates [.ml-state], shards [1]/[1]
[00:08:13]                     │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] updating number_of_replicas to [0] for indices [.ml-state-000001]
[00:08:13]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] moving index [.ml-state-000001] from [null] to [{"phase":"new","action":"complete","name":"complete"}] in policy [ml-size-based-ilm-policy]
[00:08:13]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] 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:08:13]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Loading model snapshot [N/A], job latest_record_timestamp [N/A]
[00:08:13]                     │ info [o.e.x.i.IndexLifecycleTransition] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] 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:08:14]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/228947] [CResourceMonitor.cc@77] Setting model memory limit to 41 MB
[00:08:14]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Successfully set job state to [opened] for job [pf7_log-entry-categories-count]
[00:08:14]                     │ info [o.e.x.m.d.DatafeedJob] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Datafeed started (from: 1970-01-01T00:00:00.000Z to: 2021-02-16T10:39:26.478Z) with frequency [450000ms]
[00:08:14]                     │ debg Waiting up to 5000ms for 'pf7_log-entry-categories-count' to exist...
[00:08:14]                     │ debg Waiting up to 5000ms for 'datafeed-pf7_log-entry-categories-count' to exist...
[00:08:14]                     │ debg Waiting up to 10000ms for 'pf7_log-entry-categories-count' to have processed_record_count > 0...
[00:08:14]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:14]                     │ debg > AD job stats fetched.
[00:08:14]                     │ debg --- retry.waitForWithTimeout error: expected anomaly detection job 'pf7_log-entry-categories-count' to have processed_record_count > 0 (got 0)
[00:08:14]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/CHQgS0doTKaWvpDOudtneQ] update_mapping [_doc]
[00:08:14]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:14]                     │ debg > AD job stats fetched.
[00:08:14]                     │ debg Waiting up to 120000ms for job state to be closed...
[00:08:14]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:14]                     │ debg > AD job stats fetched.
[00:08:14]                     │ debg --- retry.waitForWithTimeout error: expected job state to be closed but got opened
[00:08:15]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:15]                     │ debg > AD job stats fetched.
[00:08:15]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:15]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:15]                     │ debg > AD job stats fetched.
[00:08:15]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:16]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:16]                     │ debg > AD job stats fetched.
[00:08:16]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:16]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:16]                     │ debg > AD job stats fetched.
[00:08:16]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:17]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:17]                     │ debg > AD job stats fetched.
[00:08:17]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:17]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:17]                     │ debg > AD job stats fetched.
[00:08:17]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:18]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:18]                     │ debg > AD job stats fetched.
[00:08:18]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:18]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:18]                     │ debg > AD job stats fetched.
[00:08:18]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:19]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:19]                     │ debg > AD job stats fetched.
[00:08:19]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:19]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:20]                     │ debg > AD job stats fetched.
[00:08:20]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:20]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:20]                     │ debg > AD job stats fetched.
[00:08:20]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:21]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:21]                     │ debg > AD job stats fetched.
[00:08:21]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:21]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:21]                     │ debg > AD job stats fetched.
[00:08:21]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:22]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:22]                     │ debg > AD job stats fetched.
[00:08:22]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:22]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:22]                     │ debg > AD job stats fetched.
[00:08:22]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:23]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:23]                     │ debg > AD job stats fetched.
[00:08:23]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:23]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:23]                     │ debg > AD job stats fetched.
[00:08:23]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:24]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:24]                     │ debg > AD job stats fetched.
[00:08:24]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:24]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:24]                     │ debg > AD job stats fetched.
[00:08:24]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:25]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:25]                     │ debg > AD job stats fetched.
[00:08:25]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:25]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:25]                     │ debg > AD job stats fetched.
[00:08:25]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:26]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:26]                     │ debg > AD job stats fetched.
[00:08:26]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:26]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:26]                     │ debg > AD job stats fetched.
[00:08:26]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:27]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:27]                     │ debg > AD job stats fetched.
[00:08:27]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:27]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:27]                     │ debg > AD job stats fetched.
[00:08:27]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:28]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:28]                     │ debg > AD job stats fetched.
[00:08:28]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:28]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:28]                     │ debg > AD job stats fetched.
[00:08:28]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:29]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:29]                     │ debg > AD job stats fetched.
[00:08:29]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:29]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:29]                     │ debg > AD job stats fetched.
[00:08:29]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:30]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:30]                     │ debg > AD job stats fetched.
[00:08:30]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:30]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:30]                     │ debg > AD job stats fetched.
[00:08:30]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:31]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:31]                     │ debg > AD job stats fetched.
[00:08:31]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:31]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:31]                     │ debg > AD job stats fetched.
[00:08:31]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:32]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:32]                     │ debg > AD job stats fetched.
[00:08:32]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:32]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:32]                     │ debg > AD job stats fetched.
[00:08:32]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:33]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:33]                     │ debg > AD job stats fetched.
[00:08:33]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:33]                     │ info [o.e.x.m.d.DatafeedJob] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] Lookback has finished
[00:08:33]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] attempt to stop datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count]
[00:08:33]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] try lock [20s] to stop datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count]...
[00:08:33]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] stopping datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count], acquired [true]...
[00:08:33]                     │ info [o.e.x.m.d.DatafeedManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [no_realtime] datafeed [datafeed-pf7_log-entry-categories-count] for job [pf7_log-entry-categories-count] has been stopped
[00:08:33]                     │ info [o.e.x.m.j.p.a.AutodetectProcessManager] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] Closing job [pf7_log-entry-categories-count], because [close job (api)]
[00:08:33]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/228947] [CCmdSkeleton.cc@61] Handled 584 records
[00:08:33]                     │ info [o.e.x.m.p.l.CppLogMessageHandler] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] [autodetect/228947] [CAnomalyJob.cc@1569] Pruning all models
[00:08:33]                     │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [.ml-anomalies-shared/CHQgS0doTKaWvpDOudtneQ] update_mapping [_doc]
[00:08:33]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:33]                     │ debg > AD job stats fetched.
[00:08:33]                     │ debg --- retry.waitForWithTimeout error: expected job state to be closed but got closing
[00:08:34]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:34]                     │ debg > AD job stats fetched.
[00:08:34]                     │ debg --- retry.waitForWithTimeout failed again with the same message...
[00:08:34]                     │ info [o.e.x.m.p.AbstractNativeProcess] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] State output finished
[00:08:34]                     │ info [o.e.x.m.j.p.a.o.AutodetectResultProcessor] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] 2342 buckets parsed from autodetect output
[00:08:34]                     │ info [o.e.x.m.j.p.a.AutodetectCommunicator] [kibana-ci-immutable-centos-tests-xxl-1613469019579833187] [pf7_log-entry-categories-count] job closed
[00:08:34]                     │ debg Fetching anomaly detection job stats for job pf7_log-entry-categories-count...
[00:08:34]                     │ debg > AD job stats fetched.
[00:08:34]                     │ debg Waiting up to 120000ms for datafeed state to be stopped...
[00:08:34]                     │ debg Fetching datafeed state for datafeed datafeed-pf7_log-entry-categories-count
[00:08:34]                     └- ✖ fail: apis Machine Learning modules module setup sets up module data for logs_ui_categories with prefix, startDatafeed true and estimateModelMemory true
[00:08:34]                     │       Error: Expected job model memory limits '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"26mb"}]' (got '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"41mb"}]')
[00:08:34]                     │       + expected - actual
[00:08:34]                     │ 
[00:08:34]                     │        [
[00:08:34]                     │          {
[00:08:34]                     │            "id": "pf7_log-entry-categories-count"
[00:08:34]                     │       -    "modelMemoryLimit": "41mb"
[00:08:34]                     │       +    "modelMemoryLimit": "26mb"
[00:08:34]                     │          }
[00:08:34]                     │        ]
[00:08:34]                     │       
[00:08:34]                     │       at Assertion.assert (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:100:11)
[00:08:34]                     │       at Assertion.eql (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:244:8)
[00:08:34]                     │       at Context.<anonymous> (test/api_integration/apis/ml/modules/setup_module.ts:869:46)
[00:08:34]                     │       at Object.apply (/dev/shm/workspace/parallel/1/kibana/packages/kbn-test/src/functional_test_runner/lib/mocha/wrap_function.js:73:16)
[00:08:34]                     │ 
[00:08:34]                     │ 

Stack Trace

Error: Expected job model memory limits '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"26mb"}]' (got '[{"id":"pf7_log-entry-categories-count","modelMemoryLimit":"41mb"}]')
    at Assertion.assert (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:100:11)
    at Assertion.eql (/dev/shm/workspace/parallel/1/kibana/packages/kbn-expect/expect.js:244:8)
    at Context.<anonymous> (test/api_integration/apis/ml/modules/setup_module.ts:869:46)
    at Object.apply (/dev/shm/workspace/parallel/1/kibana/packages/kbn-test/src/functional_test_runner/lib/mocha/wrap_function.js:73:16) {
  actual: '[\n' +
    '  {\n' +
    '    "id": "pf7_log-entry-categories-count"\n' +
    '    "modelMemoryLimit": "41mb"\n' +
    '  }\n' +
    ']',
  expected: '[\n' +
    '  {\n' +
    '    "id": "pf7_log-entry-categories-count"\n' +
    '    "modelMemoryLimit": "26mb"\n' +
    '  }\n' +
    ']',
  showDiff: true
}

Metrics [docs]

✅ unchanged

History

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

rudolf added a commit that referenced this pull request Feb 16, 2021
…iver support (#85778)" (#89992) (#90839)

* Unrevert "Migrations v2: don't auto-create indices + FTR/esArchiver support (#85778)" (#89992)

* Revert "Revert "Migrations v2: don't auto-create indices + FTR/esArchiver support (#85778)""

This reverts commit f979580.

* Fix flaky saved objects management test #89953

* If a clone target exists, wait for yellow, not green, index status

* Fix test after master merge

* Fix types

Co-authored-by: Kibana Machine <42973632+kibanamachine@users.noreply.github.com>

* Fix visualize fixture after backport

* Disable monitoring plugin email notifications in functional tests

* Disabling monitoring emails doesnt disable it, configure instead

* Fix monitoring test

* Remove debug logging from FTR config

Co-authored-by: Kibana Machine <42973632+kibanamachine@users.noreply.github.com>
@kibanamachine kibanamachine removed the backport missing Added to PRs automatically when the are determined to be missing a backport. label Feb 16, 2021
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
project:ResilientSavedObjectMigrations Reduce Kibana upgrade failures by making saved object migrations more resilient release_note:skip Skip the PR/issue when compiling release notes Team:Core Core services & architecture: plugins, logging, config, saved objects, http, ES client, i18n, etc v7.12.0 v8.0.0
Projects
None yet
7 participants