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

[CI] Add pipeline task queue framework and merge workers into one #64011

Merged
merged 10 commits into from
Jul 7, 2020

Conversation

brianseeders
Copy link
Contributor

@brianseeders brianseeders commented Apr 20, 2020

Adds a "task queue" framework to pipelines. This allows CI to be broken down into lots of small units and run in parallel with a maximum level of concurrency. A "task" is just a closure that executes. So, this is like a more managed version of Jenkins's parallel() block.

This PR also adds a task queue to CI, breaks intake and functional jobs down into small units, and runs everything on the same worker. This means that "Intake" tasks can run while the builds are happening (while normally these extra resources would be wasted).

Each task "process" gets a unique copy of the workspace (with symlinked node_modules) to work out of, so tasks can modify files and such without affecting other tasks.

Some of the intake tasks have hard-coded ports and such for ES/Kibana, so I'm using Docker to run them in isolation and in parallel on the same machine.

As a note, I actually don't really like the idea of creating one huge pipeline that runs on one big machine. It's really difficult to efficiently use resources. This pipeline still has a lot of wasted resources. But, with our constraints (namely, needing to keep Jenkins agent count down to keep Jenkins stable) and the tools currently available to us, I think it will have to do. This at least doesn't lock us into one machine. Multiple task queues can be defined on multiple machines, so tasks can be split up and moved around as needed.

From the code:

/**
  withTaskQueue creates a queue of "tasks" (just plain closures to execute), and executes them with your desired level of concurrency.
  This way, you can define, for example, 40 things that need to execute, then only allow 10 of them to execute at once.

  Each "process" will execute in a separate, unique, empty directory.
  If you want each process to have a bootstrapped kibana repo, check out kibanaPipeline.withCiTaskQueue

  Using the queue currently requires an agent/worker.

  Usage:

  withTaskQueue(parallel: 10) {
    task { print "This is a task" }

    // This is the same as calling task() multiple times
    tasks([ { print "Another task" }, { print "And another task" } ])

    // Tasks can queue up subsequent tasks
    task {
      buildThing()
      task { print "I depend on buildThing()" }
    }
  }

  You can also define a setup task that each process should execute one time before executing tasks:
  withTaskQueue(parallel: 10, setup: { sh "my-setup-scrupt.sh" }) {
    ...
  }

*/

@brianseeders brianseeders added v8.0.0 release_note:skip Skip the PR/issue when compiling release notes labels Apr 20, 2020
@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@elasticmachine
Copy link
Contributor

merge conflict between base and head

@brianseeders
Copy link
Contributor Author

jenkins test this

@botelastic botelastic bot added Feature:Drilldowns Embeddable panel Drilldowns Team:APM All issues that need APM UI Team support labels May 27, 2020
@elasticmachine
Copy link
Contributor

Pinging @elastic/apm-ui (Team:apm)

@brianseeders brianseeders removed Feature:Drilldowns Embeddable panel Drilldowns Team:APM All issues that need APM UI Team support labels May 29, 2020
@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

1 similar comment
@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@brianseeders brianseeders added the Team:Operations Team label for Operations Team label Jun 2, 2020
@brianseeders brianseeders changed the title Pipeline tasks [CI] Add pipeline task queue framework and merge workers into one Jun 8, 2020
@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

2 similar comments
@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@elasticmachine
Copy link
Contributor

merge conflict between base and head

@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@brianseeders brianseeders added the Feature:CI Continuous integration label Jun 25, 2020
@elasticmachine
Copy link
Contributor

merge conflict between base and head

@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@spalger
Copy link
Contributor

spalger commented Jul 3, 2020

Hmm, any idea what this is? rm: cannot remove '/tmp/apt-key-gpghome.s87XffgUmk': Directory not empty Have you seen that happen before? Maybe we should prebuild the majority of that container and push it to dockerhub or a kibana-ci GCR

@brianseeders
Copy link
Contributor Author

@elasticmachine merge upstream

@brianseeders
Copy link
Contributor Author

Hmm, any idea what this is? rm: cannot remove '/tmp/apt-key-gpghome.s87XffgUmk': Directory not empty Have you seen that happen before? Maybe we should prebuild the majority of that container and push it to dockerhub or a kibana-ci GCR

I've seen this before with docker builds and it seems to have a bunch of different causes (such as incompatible versions with old kernel versions). I think a retry will be enough to solve it for now (I checked to make sure it doesn't consistently happen with ubuntu-16), and I'll also work on a daily job to build most of it and push to GCR

@kibanamachine
Copy link
Contributor

💛 Build succeeded, but was flaky


Test Failures

Firefox UI Functional Tests.test/functional/apps/visualize/_tsvb_chart·ts.visualize app visual builder metric should populate fields for basic functions

Link to Jenkins

Standard Out

[00:00:00]       │
[00:11:41]         └-: visualize app
[00:11:41]           └-> "before all" hook
[00:11:41]           └-> "before all" hook
[00:11:41]             │ debg Starting visualize before method
[00:11:41]             │ info [logstash_functional] Loading "mappings.json"
[00:11:41]             │ info [logstash_functional] Loading "data.json.gz"
[00:11:41]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [logstash-2015.09.22] creating index, cause [api], templates [], shards [1]/[0]
[00:11:41]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] current.health="GREEN" message="Cluster health status changed from [YELLOW] to [GREEN] (reason: [shards started [[logstash-2015.09.22][0]]])." previous.health="YELLOW" reason="shards started [[logstash-2015.09.22][0]]"
[00:11:41]             │ info [logstash_functional] Created index "logstash-2015.09.22"
[00:11:41]             │ debg [logstash_functional] "logstash-2015.09.22" settings {"index":{"analysis":{"analyzer":{"url":{"max_token_length":"1000","tokenizer":"uax_url_email","type":"standard"}}},"number_of_replicas":"0","number_of_shards":"1"}}
[00:11:41]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [logstash-2015.09.20] creating index, cause [api], templates [], shards [1]/[0]
[00:11:41]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] current.health="GREEN" message="Cluster health status changed from [YELLOW] to [GREEN] (reason: [shards started [[logstash-2015.09.20][0]]])." previous.health="YELLOW" reason="shards started [[logstash-2015.09.20][0]]"
[00:11:41]             │ info [logstash_functional] Created index "logstash-2015.09.20"
[00:11:41]             │ debg [logstash_functional] "logstash-2015.09.20" settings {"index":{"analysis":{"analyzer":{"url":{"max_token_length":"1000","tokenizer":"uax_url_email","type":"standard"}}},"number_of_replicas":"0","number_of_shards":"1"}}
[00:11:41]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [logstash-2015.09.21] creating index, cause [api], templates [], shards [1]/[0]
[00:11:41]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] current.health="GREEN" message="Cluster health status changed from [YELLOW] to [GREEN] (reason: [shards started [[logstash-2015.09.21][0]]])." previous.health="YELLOW" reason="shards started [[logstash-2015.09.21][0]]"
[00:11:41]             │ info [logstash_functional] Created index "logstash-2015.09.21"
[00:11:41]             │ debg [logstash_functional] "logstash-2015.09.21" settings {"index":{"analysis":{"analyzer":{"url":{"max_token_length":"1000","tokenizer":"uax_url_email","type":"standard"}}},"number_of_replicas":"0","number_of_shards":"1"}}
[00:11:49]             │ info [logstash_functional] Indexed 4633 docs into "logstash-2015.09.22"
[00:11:49]             │ info [logstash_functional] Indexed 4757 docs into "logstash-2015.09.20"
[00:11:49]             │ info [logstash_functional] Indexed 4614 docs into "logstash-2015.09.21"
[00:11:50]             │ info [long_window_logstash] Loading "mappings.json"
[00:11:50]             │ info [long_window_logstash] Loading "data.json.gz"
[00:11:50]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [long-window-logstash-0] creating index, cause [api], templates [], shards [1]/[0]
[00:11:50]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] current.health="GREEN" message="Cluster health status changed from [YELLOW] to [GREEN] (reason: [shards started [[long-window-logstash-0][0]]])." previous.health="YELLOW" reason="shards started [[long-window-logstash-0][0]]"
[00:11:50]             │ info [long_window_logstash] Created index "long-window-logstash-0"
[00:11:50]             │ debg [long_window_logstash] "long-window-logstash-0" settings {"index":{"analysis":{"analyzer":{"makelogs_url":{"max_token_length":"1000","tokenizer":"uax_url_email","type":"standard"}}},"number_of_replicas":"0","number_of_shards":"1"}}
[00:12:00]             │ info [long_window_logstash] Indexed 14005 docs into "long-window-logstash-0"
[00:12:00]             │ info [visualize] Loading "mappings.json"
[00:12:00]             │ info [visualize] Loading "data.json"
[00:12:00]             │ info [o.e.c.m.MetadataDeleteIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_2/Y7t6BJLBQWq6xYMn92zihA] deleting index
[00:12:00]             │ info [o.e.c.m.MetadataDeleteIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_1/OL8eMW5GTH2Y6YPIzIFaXw] deleting index
[00:12:00]             │ info [visualize] Deleted existing index [".kibana_2",".kibana_1"]
[00:12:00]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana] creating index, cause [api], templates [], shards [1]/[1]
[00:12:00]             │ info [visualize] Created index ".kibana"
[00:12:00]             │ debg [visualize] ".kibana" settings {"index":{"number_of_replicas":"1","number_of_shards":"1"}}
[00:12:00]             │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana/peGv-y4bTVuRk7wgKySKXQ] update_mapping [_doc]
[00:12:00]             │ info [visualize] Indexed 12 docs into ".kibana"
[00:12:00]             │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana/peGv-y4bTVuRk7wgKySKXQ] update_mapping [_doc]
[00:12:00]             │ debg Migrating saved objects
[00:12:00]             │ proc [kibana]   log   [16:17:01.991] [info][savedobjects-service] Creating index .kibana_2.
[00:12:00]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_2] creating index, cause [api], templates [], shards [1]/[1]
[00:12:00]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] updating number_of_replicas to [0] for indices [.kibana_2]
[00:12:00]             │ proc [kibana]   log   [16:17:02.043] [info][savedobjects-service] Reindexing .kibana to .kibana_1
[00:12:00]             │ info [o.e.c.m.MetadataCreateIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_1] creating index, cause [api], templates [], shards [1]/[1]
[00:12:00]             │ info [o.e.c.r.a.AllocationService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] updating number_of_replicas to [0] for indices [.kibana_1]
[00:12:00]             │ info [o.e.t.LoggingTaskListener] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] 9007 finished with response BulkByScrollResponse[took=52.2ms,timed_out=false,sliceId=null,updated=0,created=12,deleted=0,batches=1,versionConflicts=0,noops=0,retries=0,throttledUntil=0s,bulk_failures=[],search_failures=[]]
[00:12:01]             │ info [o.e.c.m.MetadataDeleteIndexService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana/peGv-y4bTVuRk7wgKySKXQ] deleting index
[00:12:01]             │ proc [kibana]   log   [16:17:02.380] [info][savedobjects-service] Migrating .kibana_1 saved objects to .kibana_2
[00:12:01]             │ proc [kibana]   log   [16:17:02.387] [error][savedobjects-service] Error: Unable to migrate the corrupt Saved Object document index-pattern:test_index*. To prevent Kibana from performing a migration on every restart, please delete or fix this document by ensuring that the namespace and type in the document's id matches the values in the namespace and type fields.
[00:12:01]             │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_2/fIDmxugQRTSZzffLhzSKqQ] update_mapping [_doc]
[00:12:01]             │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_2/fIDmxugQRTSZzffLhzSKqQ] update_mapping [_doc]
[00:12:01]             │ proc [kibana]   log   [16:17:02.462] [info][savedobjects-service] Pointing alias .kibana to .kibana_2.
[00:12:01]             │ proc [kibana]   log   [16:17:02.505] [info][savedobjects-service] Finished in 515ms.
[00:12:01]             │ debg applying update to kibana config: {"accessibility:disableAnimations":true,"dateFormat:tz":"UTC"}
[00:12:01]             │ info [o.e.c.m.MetadataMappingService] [kibana-ci-immutable-centos-tests-xxl-1594136629916658084] [.kibana_2/fIDmxugQRTSZzffLhzSKqQ] update_mapping [_doc]
[00:12:02]             │ debg replacing kibana config doc: {"defaultIndex":"logstash-*","format:bytes:defaultPattern":"0,0.[000]b"}
[00:12:37]           └-: 
[00:12:37]             └-> "before all" hook
[00:12:37]             └-: visual builder
[00:12:37]               └-> "before all" hook
[00:12:37]               └-: metric
[00:12:37]                 └-> "before all" hook
[00:12:37]                 └-> should not have inspector enabled
[00:12:37]                   └-> "before each" hook: global before each
[00:12:37]                   └-> "before each" hook
[00:12:37]                     │ debg navigating to visualize url: http://localhost:61111/app/visualize#/
[00:12:37]                     │ debg navigate to: http://localhost:61111/app/visualize#/
[00:12:37]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:37]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:37]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:12:37]                     │ debg ... sleep(700) start
[00:12:37]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:12:38]                     │ debg ... sleep(700) end
[00:12:38]                     │ debg returned from get, calling refresh
[00:12:38]                     │ debg browser[info] "INFO: 2020-07-07T16:17:40Z
[00:12:38]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:12:38]                     │
[00:12:38]                     │      "
[00:12:39]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:12:39]                     │ERROR browser[error] (new TypeError("NetworkError when attempting to fetch resource.", ""))
[00:12:39]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:12:39]                     │ debg currentUrl = http://localhost:61111/app/visualize#/
[00:12:39]                     │          appUrl = http://localhost:61111/app/visualize#/
[00:12:39]                     │ debg TestSubjects.find(kibanaChrome)
[00:12:39]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:12:40]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:12:43]                     │ debg browser[info] "INFO: 2020-07-07T16:17:44Z
[00:12:43]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:12:43]                     │
[00:12:43]                     │      "
[00:12:43]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:12:44]                     │ debg browser[debug] "Reporting user-agent."
[00:12:44]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:12:44]                     │ debg ... sleep(501) start
[00:12:44]                     │ debg ... sleep(501) end
[00:12:44]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:12:44]                     │ debg --- retry.try error: URL changed, waiting for it to settle
[00:12:45]                     │ debg ... sleep(501) start
[00:12:45]                     │ debg ... sleep(501) end
[00:12:45]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:12:45]                     │ debg TestSubjects.exists(statusPageContainer)
[00:12:45]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="statusPageContainer"]') with timeout=2500
[00:12:49]                     │ debg --- retry.tryForTime error: [data-test-subj="statusPageContainer"] is not displayed
[00:12:50]                     │ debg TestSubjects.exists(newItemButton)
[00:12:50]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="newItemButton"]') with timeout=2500
[00:12:51]                     │ debg TestSubjects.click(newItemButton)
[00:12:51]                     │ debg Find.clickByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:12:51]                     │ debg Find.findByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:12:51]                     │ debg TestSubjects.find(visNewDialogTypes)
[00:12:51]                     │ debg Find.findByCssSelector('[data-test-subj="visNewDialogTypes"]') with timeout=10000
[00:12:51]                     │ debg TestSubjects.click(visType-metrics)
[00:12:51]                     │ debg Find.clickByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:12:51]                     │ debg Find.findByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:12:51]                     │ debg browser[debug] "click Metric -> (visualize:metrics):"
[00:12:51]                     │ debg browser[debug] ({type:"click", appName:"visualize", eventName:"metrics", count:1})
[00:12:51]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:51]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:51]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:12:51]                     │ debg isGlobalLoadingIndicatorVisible
[00:12:51]                     │ debg TestSubjects.exists(globalLoadingIndicator)
[00:12:51]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:12:52]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:12:53]                     │ debg browser[info] "INFO: 2020-07-07T16:17:54Z
[00:12:53]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:12:53]                     │
[00:12:53]                     │      "
[00:12:53]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:12:54]                     │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:12:54]                     │ debg browser[debug] "Reporting user-agent."
[00:12:54]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:12:54]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:12:54]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:12:54]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:12:54]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:12:55]                   └-> "before each" hook
[00:12:55]                     │ debg navigateToActualUrl http://localhost:61111/app/visualize#create?type=metrics
[00:12:55]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:55]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:12:55]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:12:55]                     │ debg currentUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:12:55]                     │          appUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:12:55]                     │ debg TestSubjects.find(kibanaChrome)
[00:12:55]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:12:55]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:12:58]                     │ debg browser[info] "INFO: 2020-07-07T16:17:59Z
[00:12:58]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:12:58]                     │
[00:12:58]                     │      "
[00:12:58]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:12:58]                     │ debg browser[debug] "Reporting user-agent."
[00:12:59]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:13:00]                     │ debg Wait for initializing TSVB editor
[00:13:00]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:13:00]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:13:03]                     │ debg --- retry.tryForTime error: [data-test-subj="tvbVisEditor"] is not displayed
[00:13:03]                     │ debg Set absolute time range from "Sep 19, 2015 @ 06:31:44.000" to "Sep 22, 2015 @ 18:31:44.000"
[00:13:03]                     │ debg Setting absolute range to Sep 19, 2015 @ 06:31:44.000 to Sep 22, 2015 @ 18:31:44.000
[00:13:03]                     │ debg TestSubjects.exists(superDatePickerToggleQuickMenuButton)
[00:13:03]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerToggleQuickMenuButton"]') with timeout=20000
[00:13:03]                     │ debg TestSubjects.exists(superDatePickerShowDatesButton)
[00:13:03]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=2500
[00:13:03]                     │ debg TestSubjects.click(superDatePickerShowDatesButton)
[00:13:03]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:13:03]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:13:04]                     │ debg TestSubjects.exists(superDatePickerstartDatePopoverButton)
[00:13:04]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=2500
[00:13:04]                     │ debg TestSubjects.click(superDatePickerendDatePopoverButton)
[00:13:04]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:13:04]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:13:04]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:13:04]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:13:04]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:04]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:05]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:13:05]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:05]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:06]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:13:06]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:07]                     │ debg ... sleep(500) start
[00:13:07]                     │ debg ... sleep(500) end
[00:13:07]                     │ debg TestSubjects.click(superDatePickerstartDatePopoverButton)
[00:13:07]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:13:07]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:13:08]                     │ debg Find.waitForElementStale with timeout=10000
[00:13:08]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:13:08]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:13:08]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:08]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:08]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:13:08]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:08]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:08]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:13:08]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:09]                     │ debg TestSubjects.exists(superDatePickerApplyTimeButton)
[00:13:09]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerApplyTimeButton"]') with timeout=2500
[00:13:12]                     │ debg --- retry.tryForTime error: [data-test-subj="superDatePickerApplyTimeButton"] is not displayed
[00:13:12]                     │ debg TestSubjects.click(querySubmitButton)
[00:13:12]                     │ debg Find.clickByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:13:12]                     │ debg Find.findByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:13:15]                     │ debg Find.waitForElementStale with timeout=10000
[00:13:15]                     │ debg Firefox stdout: 1594138696312	Marionette	WARN	TimedPromise timed out after 500 ms: stacktrace:
[00:13:15]                     │      TimedPromise/<@chrome://marionette/content/sync.js:244:13
[00:13:15]                     │      TimedPromise@chrome://marionette/content/sync.js:229:10
[00:13:15]                     │      interaction.flushEventLoop@chrome://marionette/content/interaction.js:416:10
[00:13:15]                     │      webdriverClickElement@chrome://marionette/content/interaction.js:182:31
[00:13:15]                     │
[00:13:15]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:13:15]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:13:15]                     │ debg ... sleep(2000) start
[00:13:17]                     │ debg ... sleep(2000) end
[00:13:17]                     │ debg TestSubjects.find(metricTsvbTypeBtn)
[00:13:17]                     │ debg Find.findByCssSelector('[data-test-subj="metricTsvbTypeBtn"]') with timeout=10000
[00:13:17]                     │ debg TestSubjects.exists(tsvbMetricValue)
[00:13:17]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tsvbMetricValue"]') with timeout=10000
[00:13:17]                   │ debg TestSubjects.getAttribute(openInspectorButton, disabled)
[00:13:17]                   │ debg TestSubjects.find(openInspectorButton)
[00:13:17]                   │ debg Find.findByCssSelector('[data-test-subj="openInspectorButton"]') with timeout=10000
[00:13:17]                   └- ✓ pass  (37ms) "visualize app  visual builder metric should not have inspector enabled"
[00:13:17]                 └-> should show correct data
[00:13:17]                   └-> "before each" hook: global before each
[00:13:17]                   └-> "before each" hook
[00:13:17]                     │ debg navigating to visualize url: http://localhost:61111/app/visualize#/
[00:13:17]                     │ debg navigate to: http://localhost:61111/app/visualize#/
[00:13:18]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:18]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:18]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:18]                     │ debg ... sleep(700) start
[00:13:18]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:19]                     │ debg ... sleep(700) end
[00:13:19]                     │ debg returned from get, calling refresh
[00:13:20]                     │ debg browser[info] "INFO: 2020-07-07T16:18:21Z
[00:13:20]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:20]                     │
[00:13:20]                     │      "
[00:13:20]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:20]                     │ERROR browser[error] (new TypeError("NetworkError when attempting to fetch resource.", ""))
[00:13:20]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:21]                     │ debg currentUrl = http://localhost:61111/app/visualize#/
[00:13:21]                     │          appUrl = http://localhost:61111/app/visualize#/
[00:13:21]                     │ debg TestSubjects.find(kibanaChrome)
[00:13:21]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:13:21]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:23]                     │ debg browser[info] "INFO: 2020-07-07T16:18:24Z
[00:13:23]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:23]                     │
[00:13:23]                     │      "
[00:13:23]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:23]                     │ debg browser[debug] "Reporting user-agent."
[00:13:23]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:13:24]                     │ debg ... sleep(501) start
[00:13:24]                     │ debg ... sleep(501) end
[00:13:24]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:13:24]                     │ debg --- retry.try error: URL changed, waiting for it to settle
[00:13:25]                     │ debg ... sleep(501) start
[00:13:25]                     │ debg ... sleep(501) end
[00:13:25]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:13:25]                     │ debg TestSubjects.exists(statusPageContainer)
[00:13:25]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="statusPageContainer"]') with timeout=2500
[00:13:28]                     │ debg --- retry.tryForTime error: [data-test-subj="statusPageContainer"] is not displayed
[00:13:28]                     │ debg TestSubjects.exists(newItemButton)
[00:13:28]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="newItemButton"]') with timeout=2500
[00:13:28]                     │ debg TestSubjects.click(newItemButton)
[00:13:28]                     │ debg Find.clickByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:13:28]                     │ debg Find.findByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:13:29]                     │ debg TestSubjects.find(visNewDialogTypes)
[00:13:29]                     │ debg Find.findByCssSelector('[data-test-subj="visNewDialogTypes"]') with timeout=10000
[00:13:29]                     │ debg TestSubjects.click(visType-metrics)
[00:13:29]                     │ debg Find.clickByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:13:29]                     │ debg Find.findByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:13:29]                     │ debg browser[debug] "click Metric -> (visualize:metrics):"
[00:13:29]                     │ debg browser[debug] ({type:"click", appName:"visualize", eventName:"metrics", count:1})
[00:13:29]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:29]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:29]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:29]                     │ debg isGlobalLoadingIndicatorVisible
[00:13:29]                     │ debg TestSubjects.exists(globalLoadingIndicator)
[00:13:29]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:13:30]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:31]                     │ debg browser[info] "INFO: 2020-07-07T16:18:32Z
[00:13:31]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:31]                     │
[00:13:31]                     │      "
[00:13:31]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:32]                     │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:13:32]                     │ debg browser[debug] "Reporting user-agent."
[00:13:32]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:13:32]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:13:32]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:13:32]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:13:32]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:13:33]                   └-> "before each" hook
[00:13:33]                     │ debg navigateToActualUrl http://localhost:61111/app/visualize#create?type=metrics
[00:13:33]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:33]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:33]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:33]                     │ debg currentUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:13:33]                     │          appUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:13:33]                     │ debg TestSubjects.find(kibanaChrome)
[00:13:33]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:13:34]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:35]                     │ debg browser[info] "INFO: 2020-07-07T16:18:37Z
[00:13:35]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:35]                     │
[00:13:35]                     │      "
[00:13:36]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:36]                     │ debg browser[debug] "Reporting user-agent."
[00:13:36]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:13:36]                     │ debg Wait for initializing TSVB editor
[00:13:36]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:13:36]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:13:37]                     │ debg Set absolute time range from "Sep 19, 2015 @ 06:31:44.000" to "Sep 22, 2015 @ 18:31:44.000"
[00:13:37]                     │ debg Setting absolute range to Sep 19, 2015 @ 06:31:44.000 to Sep 22, 2015 @ 18:31:44.000
[00:13:37]                     │ debg TestSubjects.exists(superDatePickerToggleQuickMenuButton)
[00:13:37]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerToggleQuickMenuButton"]') with timeout=20000
[00:13:37]                     │ debg TestSubjects.exists(superDatePickerShowDatesButton)
[00:13:37]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=2500
[00:13:37]                     │ debg TestSubjects.click(superDatePickerShowDatesButton)
[00:13:37]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:13:37]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:13:38]                     │ debg TestSubjects.exists(superDatePickerstartDatePopoverButton)
[00:13:38]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=2500
[00:13:38]                     │ debg TestSubjects.click(superDatePickerendDatePopoverButton)
[00:13:38]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:13:38]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:13:38]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:13:38]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:13:38]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:38]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:39]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:13:39]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:39]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:39]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:13:39]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:40]                     │ debg ... sleep(500) start
[00:13:40]                     │ debg ... sleep(500) end
[00:13:40]                     │ debg TestSubjects.click(superDatePickerstartDatePopoverButton)
[00:13:40]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:13:40]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:13:41]                     │ debg Find.waitForElementStale with timeout=10000
[00:13:41]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:13:41]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:13:41]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:41]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:13:41]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:13:41]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:41]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:42]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:13:42]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:13:42]                     │ debg TestSubjects.exists(superDatePickerApplyTimeButton)
[00:13:42]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerApplyTimeButton"]') with timeout=2500
[00:13:45]                     │ debg --- retry.tryForTime error: [data-test-subj="superDatePickerApplyTimeButton"] is not displayed
[00:13:45]                     │ debg TestSubjects.click(querySubmitButton)
[00:13:45]                     │ debg Find.clickByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:13:45]                     │ debg Find.findByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:13:46]                     │ debg Find.waitForElementStale with timeout=10000
[00:13:46]                     │ debg Firefox stdout: 1594138727632	Marionette	WARN	TimedPromise timed out after 500 ms: stacktrace:
[00:13:46]                     │      TimedPromise/<@chrome://marionette/content/sync.js:244:13
[00:13:46]                     │      TimedPromise@chrome://marionette/content/sync.js:229:10
[00:13:46]                     │      interaction.flushEventLoop@chrome://marionette/content/interaction.js:416:10
[00:13:46]                     │      webdriverClickElement@chrome://marionette/content/interaction.js:182:31
[00:13:46]                     │
[00:13:46]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:13:46]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:13:46]                     │ debg ... sleep(2000) start
[00:13:48]                     │ debg ... sleep(2000) end
[00:13:48]                     │ debg TestSubjects.find(metricTsvbTypeBtn)
[00:13:48]                     │ debg Find.findByCssSelector('[data-test-subj="metricTsvbTypeBtn"]') with timeout=10000
[00:13:48]                     │ debg TestSubjects.exists(tsvbMetricValue)
[00:13:48]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tsvbMetricValue"]') with timeout=10000
[00:13:49]                   │ debg Waiting up to 20000ms for rendering count to stabilize...
[00:13:49]                   │ debg TestSubjects.find(visualizationLoader)
[00:13:49]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:13:49]                   │ debg -- firstCount=3
[00:13:49]                   │ debg ... sleep(1000) start
[00:13:50]                   │ debg ... sleep(1000) end
[00:13:50]                   │ debg TestSubjects.find(visualizationLoader)
[00:13:50]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:13:50]                   │ debg -- secondCount=3
[00:13:50]                   │ debg Find.findByCssSelector('.tvbVisMetric__value--primary') with timeout=10000
[00:13:50]                   └- ✓ pass  (1.1s) "visualize app  visual builder metric should show correct data"
[00:13:50]                 └-> should show correct data with Math Aggregation
[00:13:50]                   └-> "before each" hook: global before each
[00:13:50]                   └-> "before each" hook
[00:13:50]                     │ debg navigating to visualize url: http://localhost:61111/app/visualize#/
[00:13:50]                     │ debg navigate to: http://localhost:61111/app/visualize#/
[00:13:50]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:50]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:13:50]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:50]                     │ debg ... sleep(700) start
[00:13:51]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:51]                     │ debg ... sleep(700) end
[00:13:51]                     │ debg returned from get, calling refresh
[00:13:52]                     │ debg browser[info] "INFO: 2020-07-07T16:18:53Z
[00:13:52]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:52]                     │
[00:13:52]                     │      "
[00:13:52]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:53]                     │ERROR browser[error] (new TypeError("NetworkError when attempting to fetch resource.", ""))
[00:13:53]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:13:53]                     │ debg currentUrl = http://localhost:61111/app/visualize#/
[00:13:53]                     │          appUrl = http://localhost:61111/app/visualize#/
[00:13:53]                     │ debg TestSubjects.find(kibanaChrome)
[00:13:53]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:13:54]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:13:55]                     │ debg browser[info] "INFO: 2020-07-07T16:18:56Z
[00:13:55]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:13:55]                     │
[00:13:55]                     │      "
[00:13:55]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:13:55]                     │ debg browser[debug] "Reporting user-agent."
[00:13:55]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:13:56]                     │ debg ... sleep(501) start
[00:13:56]                     │ debg ... sleep(501) end
[00:13:56]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:13:56]                     │ debg --- retry.try error: URL changed, waiting for it to settle
[00:13:57]                     │ debg ... sleep(501) start
[00:13:57]                     │ debg ... sleep(501) end
[00:13:57]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:13:57]                     │ debg TestSubjects.exists(statusPageContainer)
[00:13:57]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="statusPageContainer"]') with timeout=2500
[00:14:00]                     │ debg --- retry.tryForTime error: [data-test-subj="statusPageContainer"] is not displayed
[00:14:00]                     │ debg TestSubjects.exists(newItemButton)
[00:14:00]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="newItemButton"]') with timeout=2500
[00:14:00]                     │ debg TestSubjects.click(newItemButton)
[00:14:00]                     │ debg Find.clickByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:14:00]                     │ debg Find.findByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:14:01]                     │ debg TestSubjects.find(visNewDialogTypes)
[00:14:01]                     │ debg Find.findByCssSelector('[data-test-subj="visNewDialogTypes"]') with timeout=10000
[00:14:01]                     │ debg TestSubjects.click(visType-metrics)
[00:14:01]                     │ debg Find.clickByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:14:01]                     │ debg Find.findByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:14:01]                     │ debg browser[debug] "click Metric -> (visualize:metrics):"
[00:14:01]                     │ debg browser[debug] ({type:"click", appName:"visualize", eventName:"metrics", count:1})
[00:14:01]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:01]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:01]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:14:01]                     │ debg isGlobalLoadingIndicatorVisible
[00:14:01]                     │ debg TestSubjects.exists(globalLoadingIndicator)
[00:14:01]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:14:02]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:14:03]                     │ debg browser[info] "INFO: 2020-07-07T16:19:05Z
[00:14:03]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:14:03]                     │
[00:14:03]                     │      "
[00:14:04]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:14:04]                     │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:14:04]                     │ debg browser[debug] "Reporting user-agent."
[00:14:04]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:14:04]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:14:04]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:14:05]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:14:05]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:14:05]                   └-> "before each" hook
[00:14:05]                     │ debg navigateToActualUrl http://localhost:61111/app/visualize#create?type=metrics
[00:14:05]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:05]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:05]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:14:06]                     │ debg currentUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:14:06]                     │          appUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:14:06]                     │ debg TestSubjects.find(kibanaChrome)
[00:14:06]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:14:06]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:14:08]                     │ debg browser[info] "INFO: 2020-07-07T16:19:09Z
[00:14:08]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:14:08]                     │
[00:14:08]                     │      "
[00:14:08]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:14:09]                     │ debg browser[debug] "Reporting user-agent."
[00:14:09]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:14:09]                     │ debg Wait for initializing TSVB editor
[00:14:09]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:14:09]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:14:10]                     │ debg Set absolute time range from "Sep 19, 2015 @ 06:31:44.000" to "Sep 22, 2015 @ 18:31:44.000"
[00:14:10]                     │ debg Setting absolute range to Sep 19, 2015 @ 06:31:44.000 to Sep 22, 2015 @ 18:31:44.000
[00:14:10]                     │ debg TestSubjects.exists(superDatePickerToggleQuickMenuButton)
[00:14:10]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerToggleQuickMenuButton"]') with timeout=20000
[00:14:10]                     │ debg TestSubjects.exists(superDatePickerShowDatesButton)
[00:14:10]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=2500
[00:14:10]                     │ debg TestSubjects.click(superDatePickerShowDatesButton)
[00:14:10]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:14:10]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:14:11]                     │ debg TestSubjects.exists(superDatePickerstartDatePopoverButton)
[00:14:11]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=2500
[00:14:11]                     │ debg TestSubjects.click(superDatePickerendDatePopoverButton)
[00:14:11]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:14:11]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:14:11]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:14:11]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:14:11]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:14:11]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:14:12]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:14:12]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:12]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:12]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:14:12]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:13]                     │ debg ... sleep(500) start
[00:14:14]                     │ debg ... sleep(500) end
[00:14:14]                     │ debg TestSubjects.click(superDatePickerstartDatePopoverButton)
[00:14:14]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:14:14]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:14:14]                     │ debg Find.waitForElementStale with timeout=10000
[00:14:14]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:14:14]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:14:14]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:14:14]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:14:15]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:14:15]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:15]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:15]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:14:15]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:14:16]                     │ debg TestSubjects.exists(superDatePickerApplyTimeButton)
[00:14:16]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerApplyTimeButton"]') with timeout=2500
[00:14:19]                     │ debg --- retry.tryForTime error: [data-test-subj="superDatePickerApplyTimeButton"] is not displayed
[00:14:19]                     │ debg TestSubjects.click(querySubmitButton)
[00:14:19]                     │ debg Find.clickByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:14:19]                     │ debg Find.findByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:14:21]                     │ debg Find.waitForElementStale with timeout=10000
[00:14:21]                     │ debg Firefox stdout: 1594138762632	Marionette	WARN	TimedPromise timed out after 500 ms: stacktrace:
[00:14:21]                     │      TimedPromise/<@chrome://marionette/content/sync.js:244:13
[00:14:21]                     │      TimedPromise@chrome://marionette/content/sync.js:229:10
[00:14:21]                     │      interaction.flushEventLoop@chrome://marionette/content/interaction.js:416:10
[00:14:21]                     │      webdriverClickElement@chrome://marionette/content/interaction.js:182:31
[00:14:21]                     │
[00:14:21]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:14:21]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:14:21]                     │ debg ... sleep(2000) start
[00:14:23]                     │ debg ... sleep(2000) end
[00:14:23]                     │ debg TestSubjects.find(metricTsvbTypeBtn)
[00:14:23]                     │ debg Find.findByCssSelector('[data-test-subj="metricTsvbTypeBtn"]') with timeout=10000
[00:14:24]                     │ debg TestSubjects.exists(tsvbMetricValue)
[00:14:24]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tsvbMetricValue"]') with timeout=10000
[00:14:24]                   │ debg TestSubjects.findAll(aggSelector)
[00:14:24]                   │ debg Find.allByCssSelector('[data-test-subj="aggSelector"]') with timeout=10000
[00:14:24]                   │ debg TestSubjects.findAll(addMetricAddBtn)
[00:14:24]                   │ debg Find.allByCssSelector('[data-test-subj="addMetricAddBtn"]') with timeout=10000
[00:14:24]                   │ debg Waiting up to 20000ms for rendering count to stabilize...
[00:14:24]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:24]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:25]                   │ debg -- firstCount=3
[00:14:25]                   │ debg ... sleep(1000) start
[00:14:26]                   │ debg ... sleep(1000) end
[00:14:26]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:26]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:26]                   │ debg -- secondCount=4
[00:14:26]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:26]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:26]                   │ debg -- firstCount=4
[00:14:26]                   │ debg ... sleep(1000) start
[00:14:27]                   │ debg ... sleep(1000) end
[00:14:27]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:27]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:27]                   │ debg -- secondCount=4
[00:14:27]                   │ debg Waiting up to 20000ms for new agg is added...
[00:14:27]                   │ debg TestSubjects.findAll(aggSelector)
[00:14:27]                   │ debg Find.allByCssSelector('[data-test-subj="aggSelector"]') with timeout=10000
[00:14:27]                   │ debg TestSubjects.findAll(aggSelector)
[00:14:27]                   │ debg Find.allByCssSelector('[data-test-subj="aggSelector"]') with timeout=10000
[00:14:27]                   │ debg comboBox.setElement, value: math
[00:14:27]                   │ debg comboBox.isOptionSelected, value: math
[00:14:30]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:14:30]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:14:30]                   │ debg Find.allByCssSelector('.euiFilterSelectItem[title^="math"]') with timeout=2500
[00:14:32]                   │ debg Find.findByCssSelector('.euiFilterSelectItem') with timeout=10000
[00:14:33]                   │ERROR browser[error] "Warning: Can't perform a React state update on an unmounted component. This is a no-op, but it indicates a memory leak in your application. To fix, cancel all subscriptions and asynchronous tasks in %s.%s" "the componentWillUnmount method" "
[00:14:33]                   │          in EuiComboBox (created by AggSelect)
[00:14:33]                   │          in div (created by AggSelect)
[00:14:33]                   │          in AggSelect (created by StandardAgg)
[00:14:33]                   │          in div (created by EuiFlexItem)
[00:14:33]                   │          in EuiFlexItem (created by StandardAgg)
[00:14:33]                   │          in div (created by EuiFlexGroup)
[00:14:33]                   │          in EuiFlexGroup (created by StandardAgg)
[00:14:33]                   │          in div (created by EuiFlexItem)
[00:14:33]                   │          in EuiFlexItem (created by AggRow)
[00:14:33]                   │          in div (created by EuiFlexGroup)
[00:14:33]                   │          in EuiFlexGroup (created by AggRow)
[00:14:33]                   │          in div (created by AggRow)
[00:14:33]                   │          in AggRow (created by StandardAgg)
[00:14:33]                   │          in StandardAgg (created by Agg)"
[00:14:33]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:14:33]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:14:35]                   │ debg --- retry.tryForTime error: [data-test-subj~="comboBoxOptionsList"] is not displayed
[00:14:36]                   │ debg isGlobalLoadingIndicatorVisible
[00:14:36]                   │ debg TestSubjects.exists(globalLoadingIndicator)
[00:14:36]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:14:37]                   │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:14:38]                   │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:14:38]                   │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:14:38]                   │ debg TestSubjects.findAll(varRow)
[00:14:38]                   │ debg Find.allByCssSelector('[data-test-subj="varRow"]') with timeout=10000
[00:14:38]                   │ debg comboBox.setElement, value: Count
[00:14:38]                   │ debg comboBox.isOptionSelected, value: Count
[00:14:41]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:14:41]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:14:41]                   │ debg Find.allByCssSelector('.euiFilterSelectItem[title^="Count"]') with timeout=2500
[00:14:41]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:14:41]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:14:44]                   │ debg --- retry.tryForTime error: [data-test-subj~="comboBoxOptionsList"] is not displayed
[00:14:44]                   │ debg isGlobalLoadingIndicatorVisible
[00:14:44]                   │ debg TestSubjects.exists(globalLoadingIndicator)
[00:14:44]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:14:46]                   │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:14:46]                   │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:14:46]                   │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:14:46]                   │ debg TestSubjects.findAll(mathExpression)
[00:14:46]                   │ debg Find.allByCssSelector('[data-test-subj="mathExpression"]') with timeout=10000
[00:14:47]                   │ debg isGlobalLoadingIndicatorVisible
[00:14:47]                   │ debg TestSubjects.exists(globalLoadingIndicator)
[00:14:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:14:47]                   │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:14:47]                   │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:14:48]                   │ debg Waiting up to 20000ms for rendering count to stabilize...
[00:14:48]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:48]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:48]                   │ debg -- firstCount=7
[00:14:48]                   │ debg ... sleep(1000) start
[00:14:49]                   │ debg ... sleep(1000) end
[00:14:49]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:49]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:49]                   │ debg -- secondCount=8
[00:14:49]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:49]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:49]                   │ debg -- firstCount=8
[00:14:49]                   │ debg ... sleep(1000) start
[00:14:50]                   │ debg ... sleep(1000) end
[00:14:50]                   │ debg TestSubjects.find(visualizationLoader)
[00:14:50]                   │ debg Find.findByCssSelector('[data-test-subj="visualizationLoader"]') with timeout=10000
[00:14:50]                   │ debg -- secondCount=8
[00:14:50]                   │ debg Find.findByCssSelector('.tvbVisMetric__value--primary') with timeout=10000
[00:14:50]                   └- ✓ pass  (26.1s) "visualize app  visual builder metric should show correct data with Math Aggregation"
[00:14:50]                 └-> should populate fields for basic functions
[00:14:50]                   └-> "before each" hook: global before each
[00:14:50]                   └-> "before each" hook
[00:14:50]                     │ debg navigating to visualize url: http://localhost:61111/app/visualize#/
[00:14:50]                     │ debg navigate to: http://localhost:61111/app/visualize#/
[00:14:50]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:50]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:14:50]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:14:50]                     │ debg ... sleep(700) start
[00:14:51]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:14:51]                     │ debg ... sleep(700) end
[00:14:51]                     │ debg returned from get, calling refresh
[00:14:52]                     │ debg browser[info] "INFO: 2020-07-07T16:19:53Z
[00:14:52]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:14:52]                     │
[00:14:52]                     │      "
[00:14:52]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:14:53]                     │ERROR browser[error] (new TypeError("NetworkError when attempting to fetch resource.", ""))
[00:14:53]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:14:53]                     │ debg currentUrl = http://localhost:61111/app/visualize#/
[00:14:53]                     │          appUrl = http://localhost:61111/app/visualize#/
[00:14:53]                     │ debg TestSubjects.find(kibanaChrome)
[00:14:53]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:14:53]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:14:55]                     │ debg browser[info] "INFO: 2020-07-07T16:19:56Z
[00:14:55]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:14:55]                     │
[00:14:55]                     │      "
[00:14:55]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:14:55]                     │ debg browser[debug] "Reporting user-agent."
[00:14:55]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:14:55]                     │ debg ... sleep(501) start
[00:14:56]                     │ debg ... sleep(501) end
[00:14:56]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:14:56]                     │ debg --- retry.try error: URL changed, waiting for it to settle
[00:14:56]                     │ debg ... sleep(501) start
[00:14:57]                     │ debg ... sleep(501) end
[00:14:57]                     │ debg in navigateTo url = http://localhost:61111/app/visualize#/?_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:now-15m,to:now))
[00:14:57]                     │ debg TestSubjects.exists(statusPageContainer)
[00:14:57]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="statusPageContainer"]') with timeout=2500
[00:14:59]                     │ debg --- retry.tryForTime error: [data-test-subj="statusPageContainer"] is not displayed
[00:15:00]                     │ debg TestSubjects.exists(newItemButton)
[00:15:00]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="newItemButton"]') with timeout=2500
[00:15:00]                     │ debg TestSubjects.click(newItemButton)
[00:15:00]                     │ debg Find.clickByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:15:00]                     │ debg Find.findByCssSelector('[data-test-subj="newItemButton"]') with timeout=10000
[00:15:00]                     │ debg TestSubjects.find(visNewDialogTypes)
[00:15:00]                     │ debg Find.findByCssSelector('[data-test-subj="visNewDialogTypes"]') with timeout=10000
[00:15:00]                     │ debg TestSubjects.click(visType-metrics)
[00:15:00]                     │ debg Find.clickByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:15:00]                     │ debg Find.findByCssSelector('[data-test-subj="visType-metrics"]') with timeout=10000
[00:15:00]                     │ debg browser[debug] "click Metric -> (visualize:metrics):"
[00:15:00]                     │ debg browser[debug] ({type:"click", appName:"visualize", eventName:"metrics", count:1})
[00:15:00]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:15:00]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:15:00]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:15:01]                     │ debg isGlobalLoadingIndicatorVisible
[00:15:01]                     │ debg TestSubjects.exists(globalLoadingIndicator)
[00:15:01]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:15:01]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:15:02]                     │ debg browser[info] "INFO: 2020-07-07T16:20:04Z
[00:15:02]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:15:02]                     │
[00:15:02]                     │      "
[00:15:03]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:15:03]                     │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:15:03]                     │ debg browser[debug] "Reporting user-agent."
[00:15:03]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:15:03]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:15:03]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:15:04]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:15:04]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:15:06]                     │ debg --- retry.tryForTime error: [data-test-subj="tvbVisEditor"] is not displayed
[00:15:07]                   └-> "before each" hook
[00:15:07]                     │ debg navigateToActualUrl http://localhost:61111/app/visualize#create?type=metrics
[00:15:07]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:15:07]                     │ debg browser[debug] "Reporting application changed to undefined"
[00:15:07]                     │ debg browser[log] "^ A single error about an inline script not firing due to content security policy is expected!"
[00:15:08]                     │ debg currentUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:15:08]                     │          appUrl = http://localhost:61111/app/visualize#create?type=metrics
[00:15:08]                     │ debg TestSubjects.find(kibanaChrome)
[00:15:08]                     │ debg Find.findByCssSelector('[data-test-subj="kibanaChrome"]') with timeout=60000
[00:15:08]                     │ debg browser[info] "%cDownload the React DevTools for a better development experience: https://fb.me/react-devtools" "font-weight:bold"
[00:15:11]                     │ debg browser[info] "INFO: 2020-07-07T16:20:12Z
[00:15:11]                     │        Adding connection to http://localhost:61111/elasticsearch
[00:15:11]                     │
[00:15:11]                     │      "
[00:15:11]                     │ debg browser[warn] "App [management] is using deprecated mount context. Use core.getStartServices() instead."
[00:15:11]                     │ debg browser[debug] "Reporting user-agent."
[00:15:11]                     │ debg browser[debug] "Reporting application changed to visualize"
[00:15:12]                     │ debg Wait for initializing TSVB editor
[00:15:12]                     │ debg TestSubjects.exists(tvbVisEditor)
[00:15:12]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tvbVisEditor"]') with timeout=10000
[00:15:15]                     │ debg --- retry.tryForTime error: [data-test-subj="tvbVisEditor"] is not displayed
[00:15:22]                     │ debg Set absolute time range from "Sep 19, 2015 @ 06:31:44.000" to "Sep 22, 2015 @ 18:31:44.000"
[00:15:22]                     │ debg Setting absolute range to Sep 19, 2015 @ 06:31:44.000 to Sep 22, 2015 @ 18:31:44.000
[00:15:22]                     │ debg TestSubjects.exists(superDatePickerToggleQuickMenuButton)
[00:15:22]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerToggleQuickMenuButton"]') with timeout=20000
[00:15:22]                     │ debg TestSubjects.exists(superDatePickerShowDatesButton)
[00:15:22]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=2500
[00:15:22]                     │ debg TestSubjects.click(superDatePickerShowDatesButton)
[00:15:22]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:15:22]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerShowDatesButton"]') with timeout=10000
[00:15:22]                     │ debg TestSubjects.exists(superDatePickerstartDatePopoverButton)
[00:15:22]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=2500
[00:15:22]                     │ debg TestSubjects.click(superDatePickerendDatePopoverButton)
[00:15:22]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:15:22]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerendDatePopoverButton"]') with timeout=10000
[00:15:23]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:15:23]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:15:23]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:15:23]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:15:24]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:15:24]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:24]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:24]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:15:24]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:26]                     │ debg ... sleep(500) start
[00:15:26]                     │ debg ... sleep(500) end
[00:15:26]                     │ debg TestSubjects.click(superDatePickerstartDatePopoverButton)
[00:15:26]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:15:26]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerstartDatePopoverButton"]') with timeout=10000
[00:15:27]                     │ debg Find.waitForElementStale with timeout=10000
[00:15:27]                     │ debg Find.findByCssSelector('div.euiPopover__panel-isOpen') with timeout=10000
[00:15:27]                     │ debg TestSubjects.click(superDatePickerAbsoluteTab)
[00:15:27]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:15:27]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteTab"]') with timeout=10000
[00:15:28]                     │ debg TestSubjects.click(superDatePickerAbsoluteDateInput)
[00:15:28]                     │ debg Find.clickByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:28]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:28]                     │ debg TestSubjects.find(superDatePickerAbsoluteDateInput)
[00:15:28]                     │ debg Find.findByCssSelector('[data-test-subj="superDatePickerAbsoluteDateInput"]') with timeout=10000
[00:15:29]                     │ debg TestSubjects.exists(superDatePickerApplyTimeButton)
[00:15:29]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="superDatePickerApplyTimeButton"]') with timeout=2500
[00:15:32]                     │ debg --- retry.tryForTime error: [data-test-subj="superDatePickerApplyTimeButton"] is not displayed
[00:15:32]                     │ debg TestSubjects.click(querySubmitButton)
[00:15:32]                     │ debg Find.clickByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:15:32]                     │ debg Find.findByCssSelector('[data-test-subj="querySubmitButton"]') with timeout=10000
[00:15:33]                     │ debg Find.waitForElementStale with timeout=10000
[00:15:33]                     │ debg Firefox stdout: 1594138834935	Marionette	WARN	TimedPromise timed out after 500 ms: stacktrace:
[00:15:33]                     │      TimedPromise/<@chrome://marionette/content/sync.js:244:13
[00:15:33]                     │      TimedPromise@chrome://marionette/content/sync.js:229:10
[00:15:33]                     │      interaction.flushEventLoop@chrome://marionette/content/interaction.js:416:10
[00:15:33]                     │      webdriverClickElement@chrome://marionette/content/interaction.js:182:31
[00:15:33]                     │
[00:15:33]                     │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:15:33]                     │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:15:33]                     │ debg ... sleep(2000) start
[00:15:35]                     │ debg ... sleep(2000) end
[00:15:35]                     │ debg TestSubjects.find(metricTsvbTypeBtn)
[00:15:35]                     │ debg Find.findByCssSelector('[data-test-subj="metricTsvbTypeBtn"]') with timeout=10000
[00:15:36]                     │ debg TestSubjects.exists(tsvbMetricValue)
[00:15:36]                     │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="tsvbMetricValue"]') with timeout=10000
[00:15:36]                   │ debg TestSubjects.findAll(aggSelector)
[00:15:36]                   │ debg Find.allByCssSelector('[data-test-subj="aggSelector"]') with timeout=10000
[00:15:36]                   │ debg comboBox.setElement, value: Average
[00:15:36]                   │ debg comboBox.isOptionSelected, value: Average
[00:15:39]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:15:39]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:15:39]                   │ debg Find.allByCssSelector('.euiFilterSelectItem[title^="Average"]') with timeout=2500
[00:15:39]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:15:39]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:15:42]                   │ debg --- retry.tryForTime error: [data-test-subj~="comboBoxOptionsList"] is not displayed
[00:15:42]                   │ debg isGlobalLoadingIndicatorVisible
[00:15:42]                   │ debg TestSubjects.exists(globalLoadingIndicator)
[00:15:42]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj="globalLoadingIndicator"]') with timeout=1500
[00:15:44]                   │ debg --- retry.tryForTime error: [data-test-subj="globalLoadingIndicator"] is not displayed
[00:15:44]                   │ debg TestSubjects.exists(globalLoadingIndicator-hidden)
[00:15:44]                   │ debg Find.existsByCssSelector('[data-test-subj="globalLoadingIndicator-hidden"]') with timeout=100000
[00:15:44]                   │ debg TestSubjects.findAll(aggRow)
[00:15:44]                   │ debg Find.allByCssSelector('[data-test-subj="aggRow"]') with timeout=10000
[00:15:44]                   │ debg comboBox.setElement, value: machine.ram
[00:15:44]                   │ debg comboBox.isOptionSelected, value: machine.ram
[00:15:47]                   │ debg TestSubjects.exists(~comboBoxOptionsList)
[00:15:47]                   │ debg Find.existsByDisplayedByCssSelector('[data-test-subj~="comboBoxOptionsList"]') with timeout=2500
[00:15:50]                   │ debg --- retry.tryForTime error: [data-test-subj~="comboBoxOptionsList"] is not displayed
[00:16:00]                   │ info Taking screenshot "/dev/shm/workspace/parallel/11/kibana/test/functional/screenshots/failure/visualize app  visual builder metric should populate fields for basic functions.png"
[00:16:00]                   │ info Current URL is: http://localhost:61111/app/visualize#/create?type=metrics&_g=(filters:!(),refreshInterval:(pause:!t,value:0),time:(from:%272015-09-19T06:31:44.000Z%27,to:%272015-09-22T18:31:44.000Z%27))&_a=(filters:!(),linked:!f,query:(language:kuery,query:%27%27),uiState:(),vis:(aggs:!(),params:(axis_formatter:number,axis_position:left,axis_scale:normal,background_color_rules:!((id:caa01b00-c06d-11ea-8f6c-21d03fcdb9b3)),default_index_pattern:%27logstash-*%27,default_timefield:%27@timestamp%27,id:%2761ca57f0-469d-11e7-af02-69e470af7417%27,index_pattern:%27%27,interval:%27%27,isModelInvalid:!f,series:!((axis_position:right,chart_type:line,color:%2368BC00,fill:0.5,formatter:number,id:%2761ca57f1-469d-11e7-af02-69e470af7417%27,label:%27%27,line_width:1,metrics:!((id:%2761ca57f2-469d-11e7-af02-69e470af7417%27,type:avg)),point_size:1,separate_axis:0,split_color_mode:kibana,split_mode:everything,stacked:none)),show_grid:1,show_legend:1,time_field:%27%27,tooltip_mode:show_all,type:metric),title:%27%27,type:metrics))
[00:16:00]                   │ info Saving page source to: /dev/shm/workspace/parallel/11/kibana/test/functional/failure_debug/html/visualize app  visual builder metric should populate fields for basic functions.html
[00:16:00]                   └- ✖ fail: "visualize app  visual builder metric should populate fields for basic functions"
[00:16:00]                   │

Stack Trace

{ NoSuchElementError: Unable to locate element: [data-test-subj="comboBoxToggleListButton"]
    at Object.throwDecodedError (/dev/shm/workspace/kibana/node_modules/selenium-webdriver/lib/error.js:550:15)
    at parseHttpResponse (/dev/shm/workspace/kibana/node_modules/selenium-webdriver/lib/http.js:565:13)
    at Executor.execute (/dev/shm/workspace/kibana/node_modules/selenium-webdriver/lib/http.js:491:26)
    at process._tickCallback (internal/process/next_tick.js:68:7)
  name: 'NoSuchElementError',
  remoteStacktrace:
   'WebDriverError@chrome://marionette/content/error.js:175:5\nNoSuchElementError@chrome://marionette/content/error.js:387:5\nelement.find/</<@chrome://marionette/content/element.js:331:16\n' }

Build metrics

✅ unchanged

History

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

@brianseeders brianseeders merged commit 465ed21 into elastic:master Jul 7, 2020
brianseeders added a commit to brianseeders/kibana that referenced this pull request Jul 8, 2020
…astic#64011)

# Conflicts:
#	src/dev/notice/generate_notice_from_source.ts
#	test/scripts/jenkins_build_kibana.sh
#	test/scripts/jenkins_ci_group.sh
#	test/scripts/jenkins_xpack_build_kibana.sh
brianseeders added a commit to brianseeders/kibana that referenced this pull request Jul 8, 2020
…astic#64011)

# Conflicts:
#	Jenkinsfile
#	src/dev/notice/generate_notice_from_source.ts
#	test/scripts/jenkins_build_kibana.sh
#	test/scripts/jenkins_ci_group.sh
#	test/scripts/jenkins_security_solution_cypress.sh
#	test/scripts/jenkins_xpack_build_kibana.sh
#	vars/kibanaPipeline.groovy
gmmorris added a commit to gmmorris/kibana that referenced this pull request Jul 8, 2020
* master: (36 commits)
  fixed api url in example plugin (elastic#70934)
  [data.search.aggs]: Remove remaining client dependencies (elastic#70251)
  [Security Solution][Endpoint] Fix base64 download bug and adopt new user artifact/manifest format (elastic#70998)
  [Security Solution][Exceptions] - Exception Modal Part I (elastic#70639)
  [SIEM][Detection Engine][Lists] Adds additional data types to value based lists
  [SIEM][Detection Engine][Lists] Removes feature flag for lists
  [APM] Show license callout in ML settings (elastic#70959)
  Migrate service settings test to jest (elastic#70992)
  [APM] Add cloud attributes to data telemetry (elastic#71008)
  Fix breadcrumb on panels for visibility / round corners (elastic#71010)
  Improve search typescript (elastic#69333)
  [savedObjects field count] run in baseline job (elastic#70999)
  [Security Solution] [Timeline] Timeline manager tweaks (elastic#69988)
  [Endpoint] Support redirect from Policy Details to Ingest when user initiates Edit Policy from Datasource Edit page (elastic#70874)
  [APM] Add API tests (elastic#70740)
  [Security Solution][Exceptions] - Tie server and client code together (elastic#70918)
  [Audit Logging] Add AuditTrail service (elastic#69278)
  [Usage Collection] Ensure no type duplicates (elastic#70946)
  [Security Solution] [Timeline] Bugfix for timeline row actions disappear sometimes (elastic#70958)
  [CI] Add pipeline task queue framework and merge workers into one (elastic#64011)
  ...
spalger added a commit to spalger/kibana that referenced this pull request Jul 8, 2020
spalger added a commit that referenced this pull request Jul 8, 2020
* Revert "temporarily disable firefox functional tests in PRs (#71116)"

This reverts commit 54bd07f.

* Revert "[savedObjects field count] run in baseline job (#70999)"

This reverts commit 53ee7a7.

* Revert "[CI] Add pipeline task queue framework and merge workers into one (#64011)"

This reverts commit 465ed21.

* Revert revert of change to jenkins_xpack_visual_regression.sh

Co-authored-by: spalger <[email protected]>
brianseeders added a commit to brianseeders/kibana that referenced this pull request Jul 9, 2020
@brianseeders brianseeders self-assigned this Jul 17, 2020
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Feature:CI Continuous integration release_note:skip Skip the PR/issue when compiling release notes reverted Team:Operations Team label for Operations Team v7.8.1 v7.9.0 v8.0.0
Projects
None yet
Development

Successfully merging this pull request may close these issues.

4 participants