{"level":"warn","ts":"2026-05-18T00:40:25.687665Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-18T00:40:25.687912Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-18T00:40:25.688067Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-18T00:40:25.688083Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-18T00:40:25.688118Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-18T00:40:25.688768Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-05-18T00:40:25.68887Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-18T00:40:25.693237Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.09967ms"} {"level":"info","ts":"2026-05-18T00:40:25.69995Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-05-18T00:40:25.700069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-05-18T00:40:25.7001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-05-18T00:40:25.700137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-18T00:40:25.700218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-05-18T00:40:25.700286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-05-18T00:40:25.705889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-18T00:40:25.707177Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-18T00:40:25.708255Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-18T00:40:25.710193Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-18T00:40:25.710288Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-18T00:40:25.710642Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-18T00:40:25.710719Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-18T00:40:25.710727Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-18T00:40:25.711215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-05-18T00:40:25.713691Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-05-18T00:40:25.716563Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-18T00:40:25.716695Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-18T00:40:25.716745Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-05-18T00:40:25.717066Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-18T00:40:25.717121Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-18T00:40:25.900895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-05-18T00:40:25.900987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-18T00:40:25.901008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-05-18T00:40:25.901023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-05-18T00:40:25.901035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-18T00:40:25.901046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-05-18T00:40:25.901065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-05-18T00:40:25.901746Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-05-18T00:40:25.901739Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-18T00:40:25.9019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-18T00:40:25.901937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:40:25.90218Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-18T00:40:25.902314Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-18T00:40:25.902597Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:40:25.902737Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:40:25.902769Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-18T00:40:25.905062Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-18T00:40:25.905064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-05-18T00:40:30.31475Z","caller":"traceutil/trace.go:171","msg":"trace[390656310] linearizableReadLoop","detail":"{readStateIndex:247; appliedIndex:246; }","duration":"268.737916ms","start":"2026-05-18T00:40:30.045985Z","end":"2026-05-18T00:40:30.314723Z","steps":["trace[390656310] 'read index received' (duration: 268.601252ms)","trace[390656310] 'applied index is now lower than readState.Index' (duration: 135.494µs)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:40:30.314877Z","caller":"traceutil/trace.go:171","msg":"trace[1610442716] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"439.225592ms","start":"2026-05-18T00:40:29.875603Z","end":"2026-05-18T00:40:30.314828Z","steps":["trace[1610442716] 'process raft request' (duration: 438.920553ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:30.314981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.962251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-18T00:40:30.315071Z","caller":"traceutil/trace.go:171","msg":"trace[1172843482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:241; }","duration":"269.099805ms","start":"2026-05-18T00:40:30.045957Z","end":"2026-05-18T00:40:30.315057Z","steps":["trace[1172843482] 'agreement among raft nodes before linearized reading' (duration: 268.9071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:30.315451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:40:29.875581Z","time spent":"439.386306ms","remote":"127.0.0.1:55568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:40:30.796326Z","caller":"traceutil/trace.go:171","msg":"trace[1186066416] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"477.107444ms","start":"2026-05-18T00:40:30.319191Z","end":"2026-05-18T00:40:30.796298Z","steps":["trace[1186066416] 'process raft request' (duration: 476.957051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:30.796728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:40:30.319164Z","time spent":"477.234687ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:40:30.830992Z","caller":"traceutil/trace.go:171","msg":"trace[308292069] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"511.304784ms","start":"2026-05-18T00:40:30.319663Z","end":"2026-05-18T00:40:30.830967Z","steps":["trace[308292069] 'process raft request' (duration: 511.16758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:30.831367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:40:30.319641Z","time spent":"511.653563ms","remote":"127.0.0.1:55808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:40:57.179452Z","caller":"traceutil/trace.go:171","msg":"trace[625720694] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"113.38722ms","start":"2026-05-18T00:40:57.066031Z","end":"2026-05-18T00:40:57.179419Z","steps":["trace[625720694] 'process raft request' (duration: 96.708484ms)","trace[625720694] 'compare' (duration: 16.255246ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:40:57.200573Z","caller":"traceutil/trace.go:171","msg":"trace[1599981569] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"120.053253ms","start":"2026-05-18T00:40:57.080478Z","end":"2026-05-18T00:40:57.200531Z","steps":["trace[1599981569] 'process raft request' (duration: 119.896259ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:40:57.201239Z","caller":"traceutil/trace.go:171","msg":"trace[2123768641] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"133.142001ms","start":"2026-05-18T00:40:57.06808Z","end":"2026-05-18T00:40:57.201222Z","steps":["trace[2123768641] 'process raft request' (duration: 129.833101ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:40:57.203489Z","caller":"traceutil/trace.go:171","msg":"trace[567762534] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"123.090277ms","start":"2026-05-18T00:40:57.080374Z","end":"2026-05-18T00:40:57.203464Z","steps":["trace[567762534] 'process raft request' (duration: 117.651495ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:40:57.210203Z","caller":"traceutil/trace.go:171","msg":"trace[1466518756] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"128.541779ms","start":"2026-05-18T00:40:57.080375Z","end":"2026-05-18T00:40:57.208917Z","steps":["trace[1466518756] 'process raft request' (duration: 117.781008ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:40:57.666045Z","caller":"traceutil/trace.go:171","msg":"trace[266892314] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"301.788497ms","start":"2026-05-18T00:40:57.364225Z","end":"2026-05-18T00:40:57.666013Z","steps":["trace[266892314] 'process raft request' (duration: 221.674696ms)","trace[266892314] 'compare' (duration: 79.915196ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:40:57.666215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:40:57.364205Z","time spent":"301.922609ms","remote":"127.0.0.1:55528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:40:57.671802Z","caller":"traceutil/trace.go:171","msg":"trace[1566337944] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"304.332877ms","start":"2026-05-18T00:40:57.367443Z","end":"2026-05-18T00:40:57.671776Z","steps":["trace[1566337944] 'process raft request' (duration: 303.806235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:57.671917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:40:57.367426Z","time spent":"304.428689ms","remote":"127.0.0.1:55528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:40:57.671953Z","caller":"traceutil/trace.go:171","msg":"trace[1797856582] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:574; }","duration":"220.073026ms","start":"2026-05-18T00:40:57.451826Z","end":"2026-05-18T00:40:57.671899Z","steps":["trace[1797856582] 'read index received' (duration: 134.050133ms)","trace[1797856582] 'applied index is now lower than readState.Index' (duration: 86.021413ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:40:57.672007Z","caller":"traceutil/trace.go:171","msg":"trace[867976859] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"250.285814ms","start":"2026-05-18T00:40:57.421707Z","end":"2026-05-18T00:40:57.671993Z","steps":["trace[867976859] 'process raft request' (duration: 249.953005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:57.67234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.513318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:40:57.672383Z","caller":"traceutil/trace.go:171","msg":"trace[301086749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"220.590699ms","start":"2026-05-18T00:40:57.451778Z","end":"2026-05-18T00:40:57.672369Z","steps":["trace[301086749] 'agreement among raft nodes before linearized reading' (duration: 220.286372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:40:57.672498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.889828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-18T00:40:57.672556Z","caller":"traceutil/trace.go:171","msg":"trace[151861770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"181.996291ms","start":"2026-05-18T00:40:57.490538Z","end":"2026-05-18T00:40:57.672534Z","steps":["trace[151861770] 'agreement among raft nodes before linearized reading' (duration: 181.547721ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:41:03.646269Z","caller":"traceutil/trace.go:171","msg":"trace[709911130] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"121.729553ms","start":"2026-05-18T00:41:03.524483Z","end":"2026-05-18T00:41:03.646213Z","steps":["trace[709911130] 'process raft request' (duration: 120.828781ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:41:04.013696Z","caller":"traceutil/trace.go:171","msg":"trace[1878480237] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"316.051904ms","start":"2026-05-18T00:41:03.697616Z","end":"2026-05-18T00:41:04.013668Z","steps":["trace[1878480237] 'read index received' (duration: 315.87302ms)","trace[1878480237] 'applied index is now lower than readState.Index' (duration: 177.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:41:04.01383Z","caller":"traceutil/trace.go:171","msg":"trace[1087284102] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"348.308998ms","start":"2026-05-18T00:41:03.665509Z","end":"2026-05-18T00:41:04.013818Z","steps":["trace[1087284102] 'process raft request' (duration: 347.9736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:41:04.013962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:41:03.665443Z","time spent":"348.415761ms","remote":"127.0.0.1:55656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:41:04.014117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.478944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-18T00:41:04.014206Z","caller":"traceutil/trace.go:171","msg":"trace[2038516166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"316.626757ms","start":"2026-05-18T00:41:03.697558Z","end":"2026-05-18T00:41:04.014185Z","steps":["trace[2038516166] 'agreement among raft nodes before linearized reading' (duration: 316.437303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:41:04.014259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:41:03.697535Z","time spent":"316.71562ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-18T00:41:04.215213Z","caller":"traceutil/trace.go:171","msg":"trace[1442449121] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"201.400373ms","start":"2026-05-18T00:41:04.01378Z","end":"2026-05-18T00:41:04.21518Z","steps":["trace[1442449121] 'read index received' (duration: 192.039295ms)","trace[1442449121] 'applied index is now lower than readState.Index' (duration: 9.359488ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:41:04.215242Z","caller":"traceutil/trace.go:171","msg":"trace[683041082] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"507.571536ms","start":"2026-05-18T00:41:03.707633Z","end":"2026-05-18T00:41:04.215205Z","steps":["trace[683041082] 'process raft request' (duration: 498.223268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:41:04.215516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.502019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-18T00:41:04.215573Z","caller":"traceutil/trace.go:171","msg":"trace[1346417090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"506.610092ms","start":"2026-05-18T00:41:03.708949Z","end":"2026-05-18T00:41:04.21556Z","steps":["trace[1346417090] 'agreement among raft nodes before linearized reading' (duration: 506.371756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:41:04.215609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:41:03.708933Z","time spent":"506.667514ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-18T00:41:04.215616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:41:03.707605Z","time spent":"507.854373ms","remote":"127.0.0.1:55990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:41:04.224684Z","caller":"traceutil/trace.go:171","msg":"trace[1962068009] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"206.015045ms","start":"2026-05-18T00:41:04.01864Z","end":"2026-05-18T00:41:04.224655Z","steps":["trace[1962068009] 'process raft request' (duration: 205.881052ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:41:05.796217Z","caller":"traceutil/trace.go:171","msg":"trace[409033716] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"104.269928ms","start":"2026-05-18T00:41:05.691918Z","end":"2026-05-18T00:41:05.796188Z","steps":["trace[409033716] 'process raft request' (duration: 103.876789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:41:53.129785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.763763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-18T00:41:53.129914Z","caller":"traceutil/trace.go:171","msg":"trace[1953809056] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:998; }","duration":"125.922297ms","start":"2026-05-18T00:41:53.003966Z","end":"2026-05-18T00:41:53.129888Z","steps":["trace[1953809056] 'count revisions from in-memory index tree' (duration: 125.61925ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:42:17.515882Z","caller":"traceutil/trace.go:171","msg":"trace[2000146687] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"135.149994ms","start":"2026-05-18T00:42:17.380709Z","end":"2026-05-18T00:42:17.515859Z","steps":["trace[2000146687] 'process raft request' (duration: 134.928768ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:42:18.79145Z","caller":"traceutil/trace.go:171","msg":"trace[1621877832] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"112.833296ms","start":"2026-05-18T00:42:18.678586Z","end":"2026-05-18T00:42:18.79142Z","steps":["trace[1621877832] 'read index received' (duration: 112.519209ms)","trace[1621877832] 'applied index is now lower than readState.Index' (duration: 312.187µs)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:42:18.791506Z","caller":"traceutil/trace.go:171","msg":"trace[1897650770] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"113.672436ms","start":"2026-05-18T00:42:18.677792Z","end":"2026-05-18T00:42:18.791464Z","steps":["trace[1897650770] 'process raft request' (duration: 113.4301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:42:18.79179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.188694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-18T00:42:18.791868Z","caller":"traceutil/trace.go:171","msg":"trace[828095059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1081; }","duration":"113.338137ms","start":"2026-05-18T00:42:18.678511Z","end":"2026-05-18T00:42:18.791849Z","steps":["trace[828095059] 'agreement among raft nodes before linearized reading' (duration: 113.073861ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:42:19.103821Z","caller":"traceutil/trace.go:171","msg":"trace[2127222686] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"174.287237ms","start":"2026-05-18T00:42:18.929506Z","end":"2026-05-18T00:42:19.103793Z","steps":["trace[2127222686] 'read index received' (duration: 174.093162ms)","trace[2127222686] 'applied index is now lower than readState.Index' (duration: 192.885µs)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:42:19.103936Z","caller":"traceutil/trace.go:171","msg":"trace[1926307752] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"307.560925ms","start":"2026-05-18T00:42:18.796319Z","end":"2026-05-18T00:42:19.10388Z","steps":["trace[1926307752] 'process raft request' (duration: 307.298619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:42:19.104188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:42:18.796302Z","time spent":"307.739039ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:42:19.104744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.654296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-18T00:42:19.104876Z","caller":"traceutil/trace.go:171","msg":"trace[1409845025] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1082; }","duration":"175.399425ms","start":"2026-05-18T00:42:18.929448Z","end":"2026-05-18T00:42:19.104847Z","steps":["trace[1409845025] 'agreement among raft nodes before linearized reading' (duration: 174.447941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:42:50.649113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.386275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-18T00:42:50.649225Z","caller":"traceutil/trace.go:171","msg":"trace[1020164354] linearizableReadLoop","detail":"{readStateIndex:1321; appliedIndex:1320; }","duration":"193.383866ms","start":"2026-05-18T00:42:50.455823Z","end":"2026-05-18T00:42:50.649207Z","steps":["trace[1020164354] 'read index received' (duration: 32.650233ms)","trace[1020164354] 'applied index is now lower than readState.Index' (duration: 160.732263ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:42:50.649347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.52751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:42:50.64938Z","caller":"traceutil/trace.go:171","msg":"trace[1929385888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1271; }","duration":"193.615121ms","start":"2026-05-18T00:42:50.455753Z","end":"2026-05-18T00:42:50.649368Z","steps":["trace[1929385888] 'agreement among raft nodes before linearized reading' (duration: 193.503618ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:42:50.649402Z","caller":"traceutil/trace.go:171","msg":"trace[1159494431] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"240.182938ms","start":"2026-05-18T00:42:50.409157Z","end":"2026-05-18T00:42:50.64934Z","steps":["trace[1159494431] 'process raft request' (duration: 79.336141ms)","trace[1159494431] 'compare' (duration: 160.245702ms)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:02.10754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.254889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-18T00:43:02.107634Z","caller":"traceutil/trace.go:171","msg":"trace[1469354749] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1346; }","duration":"222.362081ms","start":"2026-05-18T00:43:01.885251Z","end":"2026-05-18T00:43:02.107613Z","steps":["trace[1469354749] 'range keys from in-memory index tree' (duration: 222.079294ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:43:28.089117Z","caller":"traceutil/trace.go:171","msg":"trace[1498157868] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"512.546328ms","start":"2026-05-18T00:43:27.576543Z","end":"2026-05-18T00:43:28.08909Z","steps":["trace[1498157868] 'process raft request' (duration: 512.386663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:28.089278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:27.576524Z","time spent":"512.67026ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:28.090185Z","caller":"traceutil/trace.go:171","msg":"trace[1930319397] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1521; }","duration":"153.441323ms","start":"2026-05-18T00:43:27.936706Z","end":"2026-05-18T00:43:28.090147Z","steps":["trace[1930319397] 'read index received' (duration: 152.370346ms)","trace[1930319397] 'applied index is now lower than readState.Index' (duration: 1.069327ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:28.090428Z","caller":"traceutil/trace.go:171","msg":"trace[1867719033] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"512.813464ms","start":"2026-05-18T00:43:27.577421Z","end":"2026-05-18T00:43:28.090235Z","steps":["trace[1867719033] 'process raft request' (duration: 512.515656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:28.090474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.568106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-05-18T00:43:28.090536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.798612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:37631"} {"level":"info","ts":"2026-05-18T00:43:28.090582Z","caller":"traceutil/trace.go:171","msg":"trace[1195855658] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1465; }","duration":"153.930014ms","start":"2026-05-18T00:43:27.936639Z","end":"2026-05-18T00:43:28.090569Z","steps":["trace[1195855658] 'agreement among raft nodes before linearized reading' (duration: 153.677569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:28.090646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:27.577408Z","time spent":"513.145701ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:28.090589Z","caller":"traceutil/trace.go:171","msg":"trace[974891774] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1465; }","duration":"153.76692ms","start":"2026-05-18T00:43:27.936794Z","end":"2026-05-18T00:43:28.090561Z","steps":["trace[974891774] 'agreement among raft nodes before linearized reading' (duration: 153.566486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:28.091263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.88529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-18T00:43:28.091455Z","caller":"traceutil/trace.go:171","msg":"trace[446587624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1465; }","duration":"109.119746ms","start":"2026-05-18T00:43:27.982318Z","end":"2026-05-18T00:43:28.091438Z","steps":["trace[446587624] 'agreement among raft nodes before linearized reading' (duration: 108.293145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:33.860211Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:34.361258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:34.86176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:35.362076Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:35.456378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999989487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-18T00:43:35.456463Z","caller":"traceutil/trace.go:171","msg":"trace[359206778] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00010712s","start":"2026-05-18T00:43:33.456334Z","end":"2026-05-18T00:43:35.456442Z","steps":["trace[359206778] 'agreement among raft nodes before linearized reading' (duration: 2.000007397s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:35.456516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.456324Z","time spent":"2.000177992s","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/18 00:43:35 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-18T00:43:35.863017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:36.363459Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:36.863539Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:37.363769Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:37.430173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000237113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-18T00:43:37.430301Z","caller":"traceutil/trace.go:171","msg":"trace[1140534607] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000405127s","start":"2026-05-18T00:43:35.429868Z","end":"2026-05-18T00:43:37.430273Z","steps":["trace[1140534607] 'agreement among raft nodes before linearized reading' (duration: 2.000259364s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:37.430365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:35.429851Z","time spent":"2.000501509s","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-18T00:43:37.456606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999743021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-18T00:43:37.456654Z","caller":"traceutil/trace.go:171","msg":"trace[1983931487] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999826454s","start":"2026-05-18T00:43:35.456816Z","end":"2026-05-18T00:43:37.456643Z","steps":["trace[1983931487] 'agreement among raft nodes before linearized reading' (duration: 1.999768072s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:37.456683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:35.456797Z","time spent":"1.999880614s","remote":"127.0.0.1:55512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/18 00:43:37 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-18T00:43:37.864142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:38.197303Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.882546034s","expected-duration":"1s"} {"level":"info","ts":"2026-05-18T00:43:38.197742Z","caller":"traceutil/trace.go:171","msg":"trace[1068959548] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"4.883076315s","start":"2026-05-18T00:43:33.314636Z","end":"2026-05-18T00:43:38.197712Z","steps":["trace[1068959548] 'process raft request' (duration: 4.882893711s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:38.197933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.314619Z","time spent":"4.883212749s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:38.203051Z","caller":"traceutil/trace.go:171","msg":"trace[1010143404] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"3.903439657s","start":"2026-05-18T00:43:34.299588Z","end":"2026-05-18T00:43:38.203028Z","steps":["trace[1010143404] 'process raft request' (duration: 3.903250332s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:38.203173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.299558Z","time spent":"3.90357621s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:38.231701Z","caller":"traceutil/trace.go:171","msg":"trace[1376224170] linearizableReadLoop","detail":"{readStateIndex:1552; appliedIndex:1547; }","duration":"4.871500703s","start":"2026-05-18T00:43:33.360143Z","end":"2026-05-18T00:43:38.231644Z","steps":["trace[1376224170] 'read index received' (duration: 4.837392936s)","trace[1376224170] 'applied index is now lower than readState.Index' (duration: 34.106487ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:38.231883Z","caller":"traceutil/trace.go:171","msg":"trace[1619746849] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"1.56246149s","start":"2026-05-18T00:43:36.669399Z","end":"2026-05-18T00:43:38.231861Z","steps":["trace[1619746849] 'process raft request' (duration: 1.56200592s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:38.231993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:36.669371Z","time spent":"1.562568502s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:38.231897Z","caller":"traceutil/trace.go:171","msg":"trace[1259231727] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"772.593463ms","start":"2026-05-18T00:43:37.459286Z","end":"2026-05-18T00:43:38.23188Z","steps":["trace[1259231727] 'process raft request' (duration: 772.290596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:38.232235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:37.45927Z","time spent":"772.842218ms","remote":"127.0.0.1:55548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-18T00:43:40.745983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500554,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:41.246397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500554,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:41.52876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.06410661s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:41.528823Z","caller":"traceutil/trace.go:171","msg":"trace[1977577728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1493; }","duration":"2.064219442s","start":"2026-05-18T00:43:39.464588Z","end":"2026-05-18T00:43:41.528808Z","steps":["trace[1977577728] 'range keys from in-memory index tree' (duration: 2.063950225s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:41.528858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:39.464568Z","time spent":"2.064282373s","remote":"127.0.0.1:55512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-18T00:43:41.529412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326704659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-18T00:43:41.529421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.913938047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-18T00:43:41.529488Z","caller":"traceutil/trace.go:171","msg":"trace[1719336209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1493; }","duration":"1.326832812s","start":"2026-05-18T00:43:40.202633Z","end":"2026-05-18T00:43:41.529466Z","steps":["trace[1719336209] 'range keys from in-memory index tree' (duration: 1.326504914s)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:43:41.529504Z","caller":"traceutil/trace.go:171","msg":"trace[439524078] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:1493; }","duration":"1.9140678s","start":"2026-05-18T00:43:39.615414Z","end":"2026-05-18T00:43:41.529482Z","steps":["trace[439524078] 'range keys from in-memory index tree' (duration: 1.91368529s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:41.529529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:40.2026Z","time spent":"1.326919034s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-18T00:43:41.529558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:39.615387Z","time spent":"1.914148091s","remote":"127.0.0.1:55524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"warn","ts":"2026-05-18T00:43:41.529596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.730980047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-18T00:43:41.529657Z","caller":"traceutil/trace.go:171","msg":"trace[1572519800] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1493; }","duration":"5.731074029s","start":"2026-05-18T00:43:35.798572Z","end":"2026-05-18T00:43:41.529646Z","steps":["trace[1572519800] 'agreement among raft nodes before linearized reading' (duration: 2.433416244s)","trace[1572519800] 'range keys from in-memory index tree' (duration: 3.29751992s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.52969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:35.798552Z","time spent":"5.73113218s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-18T00:43:41.529708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.169513296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-18T00:43:41.529771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.856636588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:41.529795Z","caller":"traceutil/trace.go:171","msg":"trace[1884690461] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1493; }","duration":"5.856695999s","start":"2026-05-18T00:43:35.673092Z","end":"2026-05-18T00:43:41.529788Z","steps":["trace[1884690461] 'agreement among raft nodes before linearized reading' (duration: 2.558903962s)","trace[1884690461] 'count revisions from in-memory index tree' (duration: 3.297760497s)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:41.52978Z","caller":"traceutil/trace.go:171","msg":"trace[1216786163] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1493; }","duration":"8.169563897s","start":"2026-05-18T00:43:33.360182Z","end":"2026-05-18T00:43:41.529746Z","steps":["trace[1216786163] 'agreement among raft nodes before linearized reading' (duration: 4.871757929s)","trace[1216786163] 'count revisions from in-memory index tree' (duration: 3.297743107s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.529817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:35.673074Z","time spent":"5.85673767s","remote":"127.0.0.1:55774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.529841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.360132Z","time spent":"8.16969599s","remote":"127.0.0.1:55776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.529904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.110688893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:41.529949Z","caller":"traceutil/trace.go:171","msg":"trace[1340053702] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1493; }","duration":"8.110787106s","start":"2026-05-18T00:43:33.419146Z","end":"2026-05-18T00:43:41.529933Z","steps":["trace[1340053702] 'agreement among raft nodes before linearized reading' (duration: 4.812876065s)","trace[1340053702] 'count revisions from in-memory index tree' (duration: 3.29785826s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.529977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.40905957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-18T00:43:41.529985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.419128Z","time spent":"8.110848667s","remote":"127.0.0.1:55606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-05-18T00:43:41.529997Z","caller":"traceutil/trace.go:171","msg":"trace[200472404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1493; }","duration":"7.409094171s","start":"2026-05-18T00:43:34.120896Z","end":"2026-05-18T00:43:41.52999Z","steps":["trace[200472404] 'agreement among raft nodes before linearized reading' (duration: 4.111132879s)","trace[200472404] 'range keys from in-memory index tree' (duration: 3.297903531s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.120888Z","time spent":"7.409125402s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-18T00:43:41.52957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.428656673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-18T00:43:41.530109Z","caller":"traceutil/trace.go:171","msg":"trace[1975807143] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1493; }","duration":"5.42930166s","start":"2026-05-18T00:43:36.100799Z","end":"2026-05-18T00:43:41.5301Z","steps":["trace[1975807143] 'agreement among raft nodes before linearized reading' (duration: 2.131183374s)","trace[1975807143] 'count revisions from in-memory index tree' (duration: 3.29750662s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:36.100779Z","time spent":"5.429346231s","remote":"127.0.0.1:55990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.530128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.708405661s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-18T00:43:41.530152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.298676359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-18T00:43:41.530221Z","caller":"traceutil/trace.go:171","msg":"trace[1140392751] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1493; }","duration":"3.298769041s","start":"2026-05-18T00:43:38.231433Z","end":"2026-05-18T00:43:41.530202Z","steps":["trace[1140392751] 'count revisions from in-memory index tree' (duration: 3.298165666s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:41.530237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.101602841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-05-18T00:43:41.530258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:38.231403Z","time spent":"3.298844072s","remote":"127.0.0.1:55936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-18T00:43:41.530294Z","caller":"traceutil/trace.go:171","msg":"trace[11781535] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1493; }","duration":"8.101699293s","start":"2026-05-18T00:43:33.428576Z","end":"2026-05-18T00:43:41.530275Z","steps":["trace[11781535] 'agreement among raft nodes before linearized reading' (duration: 4.803437694s)","trace[11781535] 'range keys from in-memory index tree' (duration: 3.298135866s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.428548Z","time spent":"8.101774674s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-18T00:43:41.530364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.066946237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-18T00:43:41.529917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.221798639s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"rangeKeys: context cancelled: context canceled"} {"level":"info","ts":"2026-05-18T00:43:41.530409Z","caller":"traceutil/trace.go:171","msg":"trace[2143386799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1493; }","duration":"4.067001228s","start":"2026-05-18T00:43:37.463389Z","end":"2026-05-18T00:43:41.53039Z","steps":["trace[2143386799] 'agreement among raft nodes before linearized reading' (duration: 768.583695ms)","trace[2143386799] 'range keys from in-memory index tree' (duration: 3.298370451s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.374646581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-05-18T00:43:41.53045Z","caller":"traceutil/trace.go:171","msg":"trace[1478487174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"7.222346002s","start":"2026-05-18T00:43:34.308089Z","end":"2026-05-18T00:43:41.530435Z","steps":["trace[1478487174] 'agreement among raft nodes before linearized reading' (duration: 3.923931399s)","trace[1478487174] 'range keys from in-memory index tree' (duration: 3.29787884s)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:41.53047Z","caller":"traceutil/trace.go:171","msg":"trace[1540315125] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1493; }","duration":"3.374706573s","start":"2026-05-18T00:43:38.155752Z","end":"2026-05-18T00:43:41.530459Z","steps":["trace[1540315125] 'agreement among raft nodes before linearized reading' (duration: 76.209689ms)","trace[1540315125] 'range keys from in-memory index tree' (duration: 3.298410522s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.53047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:37.463381Z","time spent":"4.06707314s","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-18T00:43:41.530479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.414718798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"rangeKeys: context cancelled: context deadline exceeded"} {"level":"warn","ts":"2026-05-18T00:43:41.530506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:38.155737Z","time spent":"3.374762374s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-18T00:43:41.530506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.308076Z","time spent":"7.222415474s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-18T00:43:41.530517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.170376026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-05-18T00:43:41.530516Z","caller":"traceutil/trace.go:171","msg":"trace[1627660852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"7.41477968s","start":"2026-05-18T00:43:34.115724Z","end":"2026-05-18T00:43:41.530503Z","steps":["trace[1627660852] 'agreement among raft nodes before linearized reading' (duration: 4.116285286s)","trace[1627660852] 'range keys from in-memory index tree' (duration: 3.298453103s)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:41.530543Z","caller":"traceutil/trace.go:171","msg":"trace[752019162] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1493; }","duration":"8.170444708s","start":"2026-05-18T00:43:33.360089Z","end":"2026-05-18T00:43:41.530534Z","steps":["trace[752019162] 'agreement among raft nodes before linearized reading' (duration: 4.871821731s)","trace[752019162] 'range keys from in-memory index tree' (duration: 3.298503165s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.53055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.115704Z","time spent":"7.414839961s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-18T00:43:41.530582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.027264253s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-18T00:43:41.530625Z","caller":"traceutil/trace.go:171","msg":"trace[1591009381] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1493; }","duration":"4.027322406s","start":"2026-05-18T00:43:37.503284Z","end":"2026-05-18T00:43:41.530606Z","steps":["trace[1591009381] 'agreement among raft nodes before linearized reading' (duration: 728.683067ms)","trace[1591009381] 'count revisions from in-memory index tree' (duration: 3.298593047s)"],"step_count":2} 2026/05/18 00:43:41 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-18T00:43:41.530644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.325435985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:41.530162Z","caller":"traceutil/trace.go:171","msg":"trace[1951523698] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1493; }","duration":"6.708468292s","start":"2026-05-18T00:43:34.821679Z","end":"2026-05-18T00:43:41.530148Z","steps":["trace[1951523698] 'agreement among raft nodes before linearized reading' (duration: 3.410320906s)","trace[1951523698] 'count revisions from in-memory index tree' (duration: 3.298111065s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.410201979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-18T00:43:41.530676Z","caller":"traceutil/trace.go:171","msg":"trace[1729080361] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1493; }","duration":"3.325489957s","start":"2026-05-18T00:43:38.205176Z","end":"2026-05-18T00:43:41.530666Z","steps":["trace[1729080361] 'agreement among raft nodes before linearized reading' (duration: 26.779927ms)","trace[1729080361] 'count revisions from in-memory index tree' (duration: 3.298669999s)"],"step_count":2} 2026/05/18 00:43:41 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-18T00:43:41.530692Z","caller":"traceutil/trace.go:171","msg":"trace[834521845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1493; }","duration":"7.41027s","start":"2026-05-18T00:43:34.120412Z","end":"2026-05-18T00:43:41.530682Z","steps":["trace[834521845] 'agreement among raft nodes before linearized reading' (duration: 4.111595531s)","trace[834521845] 'range keys from in-memory index tree' (duration: 3.298591898s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.530692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.821662Z","time spent":"6.709017256s","remote":"127.0.0.1:55706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.530709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:38.205162Z","time spent":"3.325537539s","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.530722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:34.120392Z","time spent":"7.410324292s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-18T00:43:41.53066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:37.503273Z","time spent":"4.027377407s","remote":"127.0.0.1:55910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-05-18T00:43:41.530464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.316379041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"warn","ts":"2026-05-18T00:43:41.530563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:33.360049Z","time spent":"8.170508899s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-18T00:43:41.530828Z","caller":"traceutil/trace.go:171","msg":"trace[694745438] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1493; }","duration":"4.316768852s","start":"2026-05-18T00:43:37.21403Z","end":"2026-05-18T00:43:41.530799Z","steps":["trace[694745438] 'agreement among raft nodes before linearized reading' (duration: 1.017947199s)","trace[694745438] 'range keys from in-memory index tree' (duration: 3.298444763s)"],"step_count":2} {"level":"warn","ts":"2026-05-18T00:43:41.53089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:37.214012Z","time spent":"4.316860644s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-18T00:43:41.746661Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967604656390500554,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-18T00:43:42.030772Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.822938486s","expected-duration":"1s"} {"level":"info","ts":"2026-05-18T00:43:42.031125Z","caller":"traceutil/trace.go:171","msg":"trace[584671117] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"1.823361286s","start":"2026-05-18T00:43:40.207736Z","end":"2026-05-18T00:43:42.031097Z","steps":["trace[584671117] 'process raft request' (duration: 1.823209652s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.031317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:40.207714Z","time spent":"1.823490159s","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:42.066324Z","caller":"traceutil/trace.go:171","msg":"trace[799374525] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"1.23824309s","start":"2026-05-18T00:43:40.828016Z","end":"2026-05-18T00:43:42.066259Z","steps":["trace[799374525] 'process raft request' (duration: 1.237943843s)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.066504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:40.82798Z","time spent":"1.238435694s","remote":"127.0.0.1:55548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-18T00:43:42.066659Z","caller":"traceutil/trace.go:171","msg":"trace[2039038561] linearizableReadLoop","detail":"{readStateIndex:1563; appliedIndex:1552; }","duration":"1.821477s","start":"2026-05-18T00:43:40.245157Z","end":"2026-05-18T00:43:42.066634Z","steps":["trace[2039038561] 'read index received' (duration: 1.785873437s)","trace[2039038561] 'applied index is now lower than readState.Index' (duration: 35.602753ms)"],"step_count":2} {"level":"info","ts":"2026-05-18T00:43:42.066782Z","caller":"traceutil/trace.go:171","msg":"trace[2065876000] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"532.449346ms","start":"2026-05-18T00:43:41.53432Z","end":"2026-05-18T00:43:42.066769Z","steps":["trace[2065876000] 'process raft request' (duration: 531.80955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.066911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.5343Z","time spent":"532.518017ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:42.066945Z","caller":"traceutil/trace.go:171","msg":"trace[1141164471] transaction","detail":"{read_only:false; response_revision:1504; number_of_response:1; }","duration":"268.467793ms","start":"2026-05-18T00:43:41.798466Z","end":"2026-05-18T00:43:42.066934Z","steps":["trace[1141164471] 'process raft request' (duration: 268.075263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.066983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.534479Z","time spent":"532.501857ms","remote":"127.0.0.1:55524","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-18T00:43:42.067086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.821936002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:42.06712Z","caller":"traceutil/trace.go:171","msg":"trace[935102061] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"528.253423ms","start":"2026-05-18T00:43:41.538858Z","end":"2026-05-18T00:43:42.067111Z","steps":["trace[935102061] 'process raft request' (duration: 527.615107ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:43:42.06713Z","caller":"traceutil/trace.go:171","msg":"trace[840926028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1504; }","duration":"1.822012914s","start":"2026-05-18T00:43:40.245105Z","end":"2026-05-18T00:43:42.067118Z","steps":["trace[840926028] 'agreement among raft nodes before linearized reading' (duration: 1.821951102s)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:43:42.067144Z","caller":"traceutil/trace.go:171","msg":"trace[752349006] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"532.177848ms","start":"2026-05-18T00:43:41.534956Z","end":"2026-05-18T00:43:42.067134Z","steps":["trace[752349006] 'process raft request' (duration: 531.387139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.067165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:40.245086Z","time spent":"1.822068316s","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-18T00:43:42.067194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.538853Z","time spent":"528.293093ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:43:42.067204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.534914Z","time spent":"532.26026ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:42.067287Z","caller":"traceutil/trace.go:171","msg":"trace[1307551999] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"531.790909ms","start":"2026-05-18T00:43:41.535486Z","end":"2026-05-18T00:43:42.067277Z","steps":["trace[1307551999] 'process raft request' (duration: 530.900077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.067343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.535472Z","time spent":"531.84455ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-18T00:43:42.067416Z","caller":"traceutil/trace.go:171","msg":"trace[723295117] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"528.639552ms","start":"2026-05-18T00:43:41.538768Z","end":"2026-05-18T00:43:42.067407Z","steps":["trace[723295117] 'process raft request' (duration: 527.649567ms)"],"step_count":1} {"level":"info","ts":"2026-05-18T00:43:42.066922Z","caller":"traceutil/trace.go:171","msg":"trace[1000403624] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"528.087849ms","start":"2026-05-18T00:43:41.538821Z","end":"2026-05-18T00:43:42.066909Z","steps":["trace[1000403624] 'process raft request' (duration: 527.625547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.06747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.538762Z","time spent":"528.679102ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:43:42.067476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.538818Z","time spent":"528.630882ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:43:42.067635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.387645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-18T00:43:42.067674Z","caller":"traceutil/trace.go:171","msg":"trace[325514385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1504; }","duration":"756.467397ms","start":"2026-05-18T00:43:41.311198Z","end":"2026-05-18T00:43:42.067665Z","steps":["trace[325514385] 'agreement among raft nodes before linearized reading' (duration: 756.383355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.067419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.88996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-18T00:43:42.067723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.311168Z","time spent":"756.547069ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-18T00:43:42.067751Z","caller":"traceutil/trace.go:171","msg":"trace[471257370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1504; }","duration":"950.241858ms","start":"2026-05-18T00:43:41.11749Z","end":"2026-05-18T00:43:42.067732Z","steps":["trace[471257370] 'agreement among raft nodes before linearized reading' (duration: 949.818318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.067824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.117473Z","time spent":"950.33338ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-18T00:43:42.066955Z","caller":"traceutil/trace.go:171","msg":"trace[1279251899] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"532.524777ms","start":"2026-05-18T00:43:41.534423Z","end":"2026-05-18T00:43:42.066948Z","steps":["trace[1279251899] 'process raft request' (duration: 531.771188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.067965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.534418Z","time spent":"533.507422ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-18T00:43:42.067562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.2687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-18T00:43:42.068049Z","caller":"traceutil/trace.go:171","msg":"trace[1136720352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1504; }","duration":"594.800585ms","start":"2026-05-18T00:43:41.473238Z","end":"2026-05-18T00:43:42.068038Z","steps":["trace[1136720352] 'agreement among raft nodes before linearized reading' (duration: 594.299652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.068077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.473211Z","time spent":"594.859825ms","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-18T00:43:42.068393Z","caller":"traceutil/trace.go:171","msg":"trace[56797595] transaction","detail":"{read_only:false; response_revision:1503; number_of_response:1; }","duration":"529.136693ms","start":"2026-05-18T00:43:41.539218Z","end":"2026-05-18T00:43:42.068355Z","steps":["trace[56797595] 'process raft request' (duration: 527.288747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-18T00:43:42.069242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-18T00:43:41.53921Z","time spent":"529.698368ms","remote":"127.0.0.1:55752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}