# Node loop crashing

**URL:** <https://discuss.elastic.co/t/node-loop-crashing/232178>\
**Category:** Elasticsearch\
**Created:** [May 12, 2020, 9:35am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178 "2020-05-12T09:35:03Z")\
**Posts on this page:** 20\
**Page:** 1

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 12, 2020, 9:35am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/1 "2020-05-12T09:35:03Z")

</div>

Hey there,

So, I currently have a cluster running for timeseries with security enabled.

It has 5 nodes:

- 1 dedicated master-eligible node, let's call it _node1_
- 2 master-elligible, data and ingest nodes, tagged _hot_, let's call them _node2_ and _node3_
- 2 data and ingest nodes, tagged _cold_, let's call them _node4_ and _node5_

It has around 20 Beats sending data to _node2_ or _node3_, both are always configured. It's a dev environment, so I know that this is bad practice, but the cluster is monitoring itself.

Everything was working fine until recently. Indeed, _node2_ is crashing in a loop continuously (general info: it has around 70 shards on it).

The pattern is the following:

- crash and restart of the node
- cluster looses it. Then cluster finds it again and start reallocating the shards on it.
- when all shards are back all good:
  - crash again.

- etc.

The problem seems to come from a parsing issue:

```auto
Caused by: org.elasticsearch.ElasticsearchParseException: failed to parse date field [2020-05-07T11:36:12.395Z] with format [epoch_millis]: [failed to parse date field [2020-05-07T11:36:12.395Z] with format [epoch_millis]]

```

I only found some occurences of this with other people when using Filebeat in some older versions, but the only FIlebeat which was sending data to this cluster is up-to-date and now turned off (and well, for some reason, it always sent data to a "ghost" _standalone cluster_ instead of this one. So I really don't understand what could be causing this now when everything was working fine before (and I can't point the beginning of this issue to an upgrade or change of config, although it's definitely possible).

Any idea of what could be causing these crashes? I'm running out of ideas...

For information, here are the full logs (parsed by myself) of ES on the problematic node when this happens:

EDIT: Can't write it here directly as it's too long... So still looking for a workaround.

Thanks in advance for your answers!

Cheers,

jsu

---

<div class="post-metadata">

**Author:** ![warkolm](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/warkolm/32/39224_2.png) [@warkolm](https://discuss.elastic.co/u/warkolm)\
**Post date:** [May 12, 2020, 9:41am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/2 "2020-05-12T09:41:14Z")

</div>

This shouldn't be caused by the formatting error.

What do the logs before the "crash" show?

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 12, 2020, 9:44am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/3 "2020-05-12T09:44:46Z")

</div>

Hey @warkolm, thanks for the answer!

Here, I'll try to paste the useful part (as I couldn't paste the whole thing before).

```auto
[2020-05-07T11:38:44,619][DEBUG][o.e.a.s.TransportSearchAction] [node2] [ilm-history-1-000001][0], node[HVFVdzG2QneJ38vvF-Ekhw], [R], s[STARTED], a[id=6JJO3updTyegFh9B3UWxLA]: Failed to execute [SearchRequest{searchType=QUERY_THEN_FETCH, indices=[.apm-agent-configuration, .kibana, .kibana_1, .kibana_2, .kibana_3, .kibana_4, .kibana_task_manager, .kibana_task_manager_1, .kibana_task_manager_2, .kiba na_task_manager_3, .kibana_task_manager_4, .ml-annotations-6, .ml-annotations-read, .ml-annotations-write, .ml-anomalies-.write-asdf, .ml-anomalies-.write-sadf, .ml-anomalies-asdf, .ml-anomalies-sadf, .ml-anomalies-shared, .ml-config, .ml-notifications, .ml-state, .ml-state-write, .monitoring-alerts-7, .monitoring-beats-7-2020.05.01, .monitoring-beats-7-2020.05.02, .monitoring-beats-7-2020.05.03, .mo nitoring-beats-7-2020.05.04, .monitoring-beats-7-2020.05.05, .monitoring-beats-7-2020.05.06, .monitoring-beats-7-2020.05.07, .monitoring-es-7-2020.05.01, .monitoring-es-7-2020.05.02, .monitoring-es-7-2020.05.03, .monitoring-es-7-2020.05.04, .monitoring-es-7-2020.05.05, .monitoring-es-7-2020.05.06, .monitoring-es-7-2020.05.07, .monitoring-kibana-7-2020.05.01, .monitoring-kibana-7-2020.05.02, .monitori ng-kibana-7-2020.05.03, .monitoring-kibana-7-2020.05.04, .monitoring-kibana-7-2020.05.05, .monitoring-kibana-7-2020.05.06, .monitoring-kibana-7-2020.05.07, .reporting-2020.04.26, .reporting-2020.05.03, .siem-signals-default, .siem-signals-default-000001, .siem-signals-default-000002, .siem-signals-default-000003, .slm-history-1, .slm-history-1-000001, .slm-history-1-000002, .slm-history-1-000003, .sl m-history-1-000004, .tasks, .triggered_watches, .watches, auditbeat, auditbeat-000001, auditbeat-000002, auditbeat-000003, auditbeat-000004, auditbeat-000005, auditbeat-000006, auditbeat-000007, auditbeat-000008, indices_e, indices_e-000001, indices_e-000002, indices_e-000003, indices_e-000004, indices_e-000005, indices_e-000006, indices_e-000007, indices_e-000008, indices_f, indices_a-000002, indices_a-000003, indices_a-000004, indices_a-000005, indices_a-000006, indices_a-000007, indices_a-000008, indices_b, indices_b-000001, indices_b-000002, indices_b-000003, indices_b-000004, indices_b-000005, indices_b-000006, indices_b-000007, indices_c, indices_c- 000002, indices_c-000003, indices_c-000004, indices_c-000005, indices_c-000006, indices_c-000007, indices_c-000008, indices_d, indices_d-000002, indices_d-000003, indices_d-000004, indices_d-000005, indices_d-000006, indices_d-000007, indices_d-000008, filebeat, filebeat-000001, filebeat-000002, filebe at-000003, filebeat-000004, filebeat-000005, filebeat-000006, filebeat-000007, filebeat-000008, ilm-history-1, ilm-history-1-000001, ilm-history-1-000002, ilm-history-1-000003, metricbeat, metricbeat-000002, metricbeat-000003, metricbeat-000004, metricbeat-000005, metricbeat-000006, metricbeat-000007, metricbeat-000008, metricbeat-000009, metricbeat-000010, metricbeat-000011, metricbeat-demo, metricb eat-demo-000001, metricbeat-demo-000002, metricbeat-demo-000003, metricbeat-demo-000004, metricbeat-demo-000005, packetbeat, packetbeat-000001, packetbeat-000002, packetbeat-000003, packetbeat-000004, packetbeat-000005, packetbeat-000006, packetbeat-000007, packetbeat-000008, rollover_test_1, rollover_test_1-000001, rollover_test_1-000002, shrink-auditbeat-000001, shrink-auditbeat-000002, shrink-audi tbeat-000003, shrink-auditbeat-000004, shrink-auditbeat-000005, shrink-auditbeat-000006, shrink-auditbeat-000007, shrink-indices_e-000001, shrink-indices_e-000002, shrink-indices_e-000003, shrink-indices_e-000004, shrink-indices_e-000005, shrink-indices_e-000006, shrink-indices_e-000007, shrink-indices_a-000002, shrink-indices_a-000003, shrink-indices_a-000004, shrink-indices_a-000005, shrink-indices_a-000006, shrink-indices_a-000007, shrink-indices_b-000001, shrink-indices_b-000002, shrink-indices_b-000003, shrink-indices_b-000004, shrink-indices_b-000005, shrink-indices_b-000006, shrink-indices_c-000002, shrink-indices_c-000003, shrink-indices_c-000004, shrink-indices_c-00 0005, shrink-indices_c-000006, shrink-indices_c-000007, shrink-indices_d-000001, shrink-indices_d-000002, shrink-indices_d-000003, shrink-indices_d-000004, shrink-indices_d-000005, shrink-indices_d-000006, shrink-indices_d-000007, shrink-filebeat-000001, shrink-filebeat-000002, shrink-filebeat-000003, shrink-filebeat-000004, shrink-f ilebeat-000005, shrink-filebeat-000006, shrink-filebeat-000007, shrink-metricbeat-000001, shrink-metricbeat-000002, shrink-metricbeat-000003, shrink-metricbeat-000004, shrink-metricbeat-000005, shrink-metricbeat-000006, shrink-metricbeat-000007, shrink-metricbeat-000008, shrink-metricbeat-000009, shrink-metricbeat-000010, shrink-metricbeat-demo-000001, shrink-metricbeat-demo-000002, shrink-metricbeat -demo-000003, shrink-metricbeat-demo-000004, shrink-packetbeat-000001, shrink-packetbeat-000002, shrink-packetbeat-000003, shrink-packetbeat-000004, shrink-packetbeat-000005, shrink-packetbeat-000006, shrink-packetbeat-000007, shrink-rollover_test_1-000001, shrink-rollover_test_1-000002, shrink-winlogbeat-000001, shrink-winlogbeat-000002, shrink-winlogbeat-000003, shrink-winlogbeat-000004, shrink-win logbeat-000005, shrink-winlogbeat-000006, shrink-winlogbeat-000007, winlogbeat, winlogbeat-000001, winlogbeat-000002, winlogbeat-000003, winlogbeat-000004, winlogbeat-000005, winlogbeat-000006, winlogbeat-000007, winlogbeat-000008], indicesOptions=IndicesOptions[ignore_unavailable=false, allow_no_indices=true, expand_wildcards_open=true, expand_wildcards_closed=false, allow_aliases_to_multiple_indice s=true, forbid_closed_indices=true, ignore_aliases=false, ignore_throttled=true], types=[], routing='null', preference='null', requestCache=null, scroll=Scroll{keepAlive=1m}, maxConcurrentShardRequests=0, batchedReduceSize=512, preFilterShardSize=128, allowPartialSearchResults=true, localClusterAlias=null, getOrCreateAbsoluteStartMillis=-1, ccsMinimizeRoundtrips=true, source={"size":1000,"query":{"bo ol":{"must":[{"range":{"@timestamp":{"from":"2020-05-07T11:36:12.395Z","to":"2020-05-07T11:38:42.395Z","include_lower":true,"include_upper":true,"boost":1.0}}}],"adjust_pure_negative":true,"boost":1.0}}}}] lastShard [true] org.elasticsearch.transport.RemoteTransportException: [node5][111.22.10.122:9300][indices:data/read/search[phase/query]]

Caused by: org.elasticsearch.ElasticsearchParseException: failed to parse date field [2020-05-07T11:36:12.395Z] with format [epoch_millis]: [failed to parse date field [2020-05-07T11:36:12.395Z] with format [epoch_millis]]

Caused by: java.lang.IllegalArgumentException: failed to parse date field [2020-05-07T11:36:12.395Z] with format [epoch_millis]

Caused by: org.elasticsearch.common.io.stream.NotSerializableExceptionWrapper: date_time_parse_exception: Failed to parse with all enclosed parsers

[2020-05-07T11:38:48,398][WARN][r.suppressed] [node2] path: /_monitoring/bulk, params: {system_id=kibana, system_api_version=6, interval=10000ms}
org.elasticsearch.cluster.block.ClusterBlockException: blocked by: [SERVICE_UNAVAILABLE/2/no master];

```

---

<div class="post-metadata">

**Author:** ![warkolm](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/warkolm/32/39224_2.png) [@warkolm](https://discuss.elastic.co/u/warkolm)\
**Post date:** [May 12, 2020, 9:48am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/4 "2020-05-12T09:48:22Z")

</div>

> [@jsu](#):
>
> SERVICE\_UNAVAILABLE/2/no master

Is there more before this you can share?

You can also use gist/pastebin/etc if there's not enough space here 🙂

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 12, 2020, 11:27am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/5 "2020-05-12T11:27:14Z")

</div>

Ok sure.

As I'm not sure what will be helpful, here is the whole last .log file, without all the stack traces.

> <https://gist.github.com/nedsir/6647dd4c77867c18168f9b4c02371bf3>

---

<div class="post-metadata">

**Author:** ![warkolm](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/warkolm/32/39224_2.png) [@warkolm](https://discuss.elastic.co/u/warkolm)\
**Post date:** [May 12, 2020, 10:10pm UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/6 "2020-05-12T22:10:37Z")

</div>

```auto
[2020-05-12T08:34:20,639][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [36718ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices

```

That seems way more relevant.

What is the output of `_cat/nodes?v` and `_cat/allocation?v`?

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 13, 2020, 7:33am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/7 "2020-05-13T07:33:56Z")

</div>

Well, my understanding so far was that the timeout was already a sign of the node being unavailable.

Looking around, I thought that it was possible that the parsing issue could flood the logs of a node and impact its performance, which could then lead to timeouts/crash.

So, here's the output of `_cat/nodes?v&s=name`:

```auto
ip heap.percent ram.percent cpu load_1m load_5m load_15m node.role master name
111.22.10.100 31 97 8 0.26 0.41 0.44 m * node1
111.22.10.105 37 95 12 3.62 4.26 5.36 dilm - node2
111.22.10.118 42 97 15 1.57 3.09 3.52 dilm - node3
111.22.10.120 69 96 21 0.86 0.76 0.81 di - node4
111.22.10.122 46 93 14 1.27 1.07 0.90 di - node5

```

and here's the `_cat/allocation?v&s=node`:

```auto
shards disk.indices disk.used disk.avail disk.total disk.percent host ip node
    30 UNASSIGNED
    35 19.1gb 164.3gb 179gb 343.3gb 47 111.22.10.105 172.16.10.105 node2
    81 176.1gb 206.3gb 137gb 343.3gb 60 111.22.10.118 172.16.10.118 node3
    83 373.6gb 407.4gb 83.5gb 491gb 82 111.22.10.120 172.16.10.120 node4
    83 351.1gb 384.7gb 106.3gb 491gb 78 111.22.10.122 172.16.10.122 node5

```

node2 crashed not so long ago again and shards are currently being reallocated on it.

Thanks a lot for all the help already !

---

<div class="post-metadata">

**Author:** ![DavidTurner](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/davidturner/32/22453_2.png) [@DavidTurner](https://discuss.elastic.co/u/DavidTurner)\
**Post date:** [May 13, 2020, 8:38am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/8 "2020-05-13T08:38:42Z")

</div>

This node looks overloaded to the point of collapse. An excerpt from the logs:

```auto
[2020-05-12T10:44:00,469][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [33900ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices
[2020-05-12T10:44:08,615][INFO][o.e.i.e.I.EngineMergeScheduler] [node2] [auditbeat-000008][0] now throttling indexing: numMergesInFlight=8, maxNumMerges=7
[2020-05-12T10:45:04,356][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [19344ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices
[2020-05-12T10:46:05,078][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:46:26,963][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:48:20,556][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:48:41,292][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:49:03,119][WARN][o.e.t.TransportService] [node2] Received response for a request that has timed out, sent [14799ms] ago, timed out [2548ms] ago, action [internal:coordination/fault_detection/leader_check], node [{node1}{OSTSZK4sTWS8GNRudXxehQ}{4qkI2Ik5RvKMr-pEG32P-Q}{111.22.10.100}{111.22.10.100:9300}{m}{xpack.installed=true}], id [8231296]
[2020-05-12T10:52:00,572][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:52:10,574][ERROR][o.e.x.m.c.n.NodeStatsCollector] [node2] collector [node_stats] timed out when collecting data
[2020-05-12T10:52:36,823][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [14745ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices
[2020-05-12T10:53:08,099][INFO][o.e.i.e.I.EngineMergeScheduler] [node2] [auditbeat-000008][0] stop throttling indexing: numMergesInFlight=6, maxNumMerges=7
[2020-05-12T10:53:55,369][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [76158ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices
[2020-05-12T10:55:04,263][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [62288ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices
[2020-05-12T10:56:00,339][WARN][o.e.m.j.JvmGcMonitorService] [node2] [gc][656669] overhead, spent [3.4s] collecting in the last [4s]
[2020-05-12T10:56:05,597][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [61418ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [2] indices and skipped [137] unchanged indices
[2020-05-12T10:56:28,616][WARN][o.e.g.PersistedClusterStateService] [node2] writing cluster state took [22924ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [1] indices and skipped [138] unchanged indices

```

This small excerpt contains multiple reports that it took over a minute to write the cluster state to disk (probably only a few MB), a GC pause of over 3 seconds, and some throttling of indexing because merging cannot keep up. Maybe its disk is inadequate or failing, or maybe it's sharing storage with another heavyweight process, or maybe you're just asking too much of it.

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 13, 2020, 9:58am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/9 "2020-05-13T09:58:51Z")

</div>

Hi @DavidTurner , thanks for the answer!

Indeed, it looks like it's collapsing. The thing I don't understand is that the server is only running this and is not used for anything else and the metrics seem to always be within acceptable boundaries.

Here the metrics of the last 4 hours during which 3 crashes occurred:

 ![node2_metrics_last4h](https://us1.discourse-cdn.com/elastic/original/3X/5/f/5f2a3f21be9eefc22c985107b6335fa929dd0e6f.jpeg)

So, would it be correct to assume that the node is crashing due to something elastic related? If so, what could I check to find the root cause?

---

<div class="post-metadata">

**Author:** ![DavidTurner](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/davidturner/32/22453_2.png) [@DavidTurner](https://discuss.elastic.co/u/DavidTurner)\
**Post date:** [May 13, 2020, 10:14am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/10 "2020-05-13T10:14:51Z")

</div>

> [@jsu](#):
>
> would it be correct to assume that the node is crashing due to something elastic related?

To reiterate, it's taking over a minute to write a small number of tiny files to disk. That doesn't sound Elastic-related to me, it sounds like a failing disk.

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 15, 2020, 6:21am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/11 "2020-05-15T06:21:28Z")

</div>

Hi @DavidTurner,

Sorry for the late reply, but following your advice, we completely changed `node2` and moved it somewhere else and I was waiting for everything to settle down before giving any feedback.

Unfortunately, looking back at what's been happening since then, it seems it didn't solve our problem. Indeed, now we have `node2` and `node3` which are both crashing (the elastic nodes, the servers are not crashing at all).

Here are the metrics of the last 12h for `node2`:

 ![node2_metrics_last12h](https://us1.discourse-cdn.com/elastic/original/3X/f/5/f5b66c24e6fb8e738e62538629d12bc47914ae07.jpeg)  
 ![node2_health_last12h](https://us1.discourse-cdn.com/elastic/original/3X/7/7/7700d5b2e33540299dd0f656704340fbefdefee9.jpeg)

and for `node3`:

 ![node3_metrics_last12h](https://us1.discourse-cdn.com/elastic/original/3X/0/4/046441f3e1c2d8d2bca530cd8524c862d52e6d02.jpeg)  
 ![node3_health_last12h](https://us1.discourse-cdn.com/elastic/original/3X/1/0/10fee73c4f115b8daac27fe05e40b348aa5eeed1.jpeg)

Any idea how to continue to investigate what's happening?

Thanks again for all the help!

---

<div class="post-metadata">

**Author:** ![warkolm](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/warkolm/32/39224_2.png) [@warkolm](https://discuss.elastic.co/u/warkolm)\
**Post date:** [May 15, 2020, 6:28am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/12 "2020-05-15T06:28:05Z")

</div>

What sort of hardware does this run on?

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 15, 2020, 9:46am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/13 "2020-05-15T09:46:30Z")

</div>

It's a linux VM on local servers. And none of the other VMs are showing any problem.

Here are logs from `node3` (there are hundreds of lines before and after this part, but they all show the same _failed to execute pipline_ part:

> <https://gist.github.com/nedsir/204785920cdb3875383dd7f16efe6a7b>

and here are the logs from `node2`:

> <https://gist.github.com/nedsir/4fe169b0cc2ef2f05892fec8de630acb>

---

<div class="post-metadata">

**Author:** ![warkolm](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/warkolm/32/39224_2.png) [@warkolm](https://discuss.elastic.co/u/warkolm)\
**Post date:** [May 15, 2020, 9:50am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/14 "2020-05-15T09:50:25Z")

</div>

Your nodes definitely look congested, your threadpools are filling up and rejecting requests. Then you get into really bad GC cycles. Then the cluster state times out and things fall over.

Can you post the output of `_cat/nodes?v` and `_cat/allocation?v`? David might have something else to offer.

---

<div class="post-metadata">

**Author:** ![DavidTurner](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/davidturner/32/22453_2.png) [@DavidTurner](https://discuss.elastic.co/u/DavidTurner)\
**Post date:** [May 15, 2020, 10:18am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/15 "2020-05-15T10:18:51Z")

</div>

These nodes look to have some really serious performance issues:

`[2020-05-15T08:26:08,471][WARN][o.e.g.PersistedClusterStateService] [node3] writing cluster state took [91083ms] which is above the warn threshold of [10s]; wrote global metadata [false] and metadata for [0] indices and skipped [144] unchanged indices`

In this cluster state update nothing changed except the version (and maybe some stuff that doesn't get written out) so it's a very small update, and yet it took over 90 seconds to write it to disk. I think you'll need to deal with your local sysadmin folks to investigate that further, I don't see a way to get Elasticsearch to work acceptably if your disks are this slow.

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 15, 2020, 10:50am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/16 "2020-05-15T10:50:47Z")

</div>

Thanks for the quick answers and all the help anyway already.

So, here's the output of `GET _cat/nodes?v&s=name`:

```auto
ip heap.percent ram.percent cpu load_1m load_5m load_15m node.role master name
111.22.10.100 21 94 12 0.16 0.29 0.23 m * node1
111.22.10.129 60 97 7 1.49 4.29 4.04 dilm - node2
111.22.10.118 42 97 8 14.70 11.43 10.86 dilm - node3
111.22.10.120 40 96 4 0.11 0.08 0.10 di - node4
111.22.10.122 55 96 3 0.27 0.20 0.24 di - node5

```

And the output from `GET _cat/allocation?v&s=node`:

```auto
shards disk.indices disk.used disk.avail disk.total disk.percent host ip node
    67 UNASSIGNED
    43 143.7gb 179.4gb 163.9gb 343.3gb 52 111.22.10.129 111.22.10.129 node2
     4 118gb 175gb 168.3gb 343.3gb 50 111.22.10.118 111.22.10.118 node3
    76 181.8gb 214.5gb 276.4gb 491gb 43 111.22.10.120 111.22.10.120 node4
    86 175.8gb 208.6gb 282.3gb 491gb 42 111.22.10.122 111.22.10.122 node5

```

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 15, 2020, 10:55am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/17 "2020-05-15T10:55:41Z")

</div>

Thanks for your answer!

I am also doing that in parallel but without much success. I'll go back to them then.

But one question I still have here is: would it be possible that the slowness of the the servers could actually be caused by something Elasticsearch-related? Or this is something that you can completely exclude from the logs and other information I sent before?

---

<div class="post-metadata">

**Author:** ![DavidTurner](https://sea2.discourse-cdn.com/elastic/user_avatar/discuss.elastic.co/davidturner/32/22453_2.png) [@DavidTurner](https://discuss.elastic.co/u/DavidTurner)\
**Post date:** [May 15, 2020, 11:17am UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/18 "2020-05-15T11:17:24Z")

</div>

> [@jsu](#):
>
> would it be possible that the slowness of the the servers could actually be caused by something Elasticsearch-related?

I don't want to say it's completely impossible, because computers are hard and bugs do happen, but I can't think of a way that Elasticsearch could be doing this to itself. I've seen other cases that look a lot like this and each one has turned out to be infrastructural in the end.

It's not an easy thing to check for certain, however. My best idea would be to break out `strace` and verify that Elasticsearch is waiting a long time on some IO-related syscalls, and also that it's not making an unreasonable number of such syscalls, but this is pretty low-level stuff and `strace` isn't particularly lightweight so might itself be disruptive to your cluster.

---

<div class="post-metadata">

**Author:** ![jsu](https://avatars.discourse-cdn.com/v4/letter/j/73ab20/32.png) [@jsu](https://discuss.elastic.co/u/jsu)\
**Post date:** [May 15, 2020, 2:51pm UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/19 "2020-05-15T14:51:55Z")

</div>

Well, thanks again for your time and all the help then.

I'll go back to them and try to fix this on the server side and I'll come back here whenever (if) we find a solution.

Cheers!

---

<div class="post-metadata">

**Author:** ![system](https://us1.discourse-cdn.com/elastic/original/3X/1/a/1ac57faf039f6b580b3f104ef42a2a89e41014de.png) [@system](https://discuss.elastic.co/u/system)\
**Post date:** [June 12, 2020, 2:52pm UTC](https://discuss.elastic.co/t/node-loop-crashing/232178/20 "2020-06-12T14:52:01Z")

</div>

This topic was automatically closed 28 days after the last reply. New replies are no longer allowed.
