{"level":"warn","ts":"2026-05-27T13:49:22.625927Z","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-27T13:49:22.62602Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-27T13:49:22.626092Z","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-27T13:49:22.626104Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-27T13:49:22.62612Z","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-27T13:49:22.626798Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-05-27T13:49:22.626888Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-27T13:49:22.6357Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.616648ms"} {"level":"info","ts":"2026-05-27T13:49:22.646424Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-05-27T13:49:22.646513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:49:22.646548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-05-27T13:49:22.646566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:49:22.646578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-05-27T13:49:22.64662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-05-27T13:49:22.652247Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:49:22.654122Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:49:22.655695Z","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-27T13:49:22.658347Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:49:22.66201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:49:22.662169Z","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-27T13:49:22.66225Z","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-27T13:49:22.662265Z","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-27T13:49:22.662602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-05-27T13:49:22.663035Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-05-27T13:49:22.664484Z","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-27T13:49:22.664652Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-27T13:49:22.664685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-05-27T13:49:22.665012Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:49:22.665102Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:49:23.247613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:49:23.24771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:49:23.247747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-05-27T13:49:23.247772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:49:23.24779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-27T13:49:23.247814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-05-27T13:49:23.247846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-05-27T13:49:23.249234Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:49:23.250651Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:49:23.250806Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:49:23.250903Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:49:23.251228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:49:23.251247Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:49:23.251352Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:49:23.251588Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:49:23.251639Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:49:23.253454Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-05-27T13:49:23.256761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-27T13:49:46.764434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.978457ms","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-27T13:49:46.764594Z","caller":"traceutil/trace.go:171","msg":"trace[1777138411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"308.198903ms","start":"2026-05-27T13:49:46.456365Z","end":"2026-05-27T13:49:46.764564Z","steps":["trace[1777138411] 'range keys from in-memory index tree' (duration: 307.874305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:46.764676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:46.456345Z","time spent":"308.319496ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:49:46.764665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.058427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-27T13:49:46.764707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.972051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-27T13:49:46.764785Z","caller":"traceutil/trace.go:171","msg":"trace[346521532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"384.116015ms","start":"2026-05-27T13:49:46.38065Z","end":"2026-05-27T13:49:46.764766Z","steps":["trace[346521532] 'range keys from in-memory index tree' (duration: 383.808308ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:46.764788Z","caller":"traceutil/trace.go:171","msg":"trace[194720596] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:428; }","duration":"441.228292ms","start":"2026-05-27T13:49:46.323526Z","end":"2026-05-27T13:49:46.764754Z","steps":["trace[194720596] 'range keys from in-memory index tree' (duration: 440.888243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:46.764827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:46.380624Z","time spent":"384.194967ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:49:46.764844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:49:46.323506Z","time spent":"441.324993ms","remote":"127.0.0.1:54236","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.57\" "} {"level":"info","ts":"2026-05-27T13:50:06.314346Z","caller":"traceutil/trace.go:171","msg":"trace[561465429] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"247.324606ms","start":"2026-05-27T13:50:06.066959Z","end":"2026-05-27T13:50:06.314284Z","steps":["trace[561465429] 'process raft request' (duration: 247.051369ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.323567Z","caller":"traceutil/trace.go:171","msg":"trace[139935680] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"256.108706ms","start":"2026-05-27T13:50:06.067404Z","end":"2026-05-27T13:50:06.323513Z","steps":["trace[139935680] 'process raft request' (duration: 255.208133ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.323696Z","caller":"traceutil/trace.go:171","msg":"trace[206474448] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"238.964147ms","start":"2026-05-27T13:50:06.084724Z","end":"2026-05-27T13:50:06.323688Z","steps":["trace[206474448] 'process raft request' (duration: 238.304809ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.323804Z","caller":"traceutil/trace.go:171","msg":"trace[1785165898] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"238.753861ms","start":"2026-05-27T13:50:06.084558Z","end":"2026-05-27T13:50:06.323312Z","steps":["trace[1785165898] 'process raft request' (duration: 238.388171ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.323615Z","caller":"traceutil/trace.go:171","msg":"trace[1855914602] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"238.735511ms","start":"2026-05-27T13:50:06.084828Z","end":"2026-05-27T13:50:06.323564Z","steps":["trace[1855914602] 'process raft request' (duration: 238.270258ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.32391Z","caller":"traceutil/trace.go:171","msg":"trace[393707613] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"238.461903ms","start":"2026-05-27T13:50:06.085425Z","end":"2026-05-27T13:50:06.323887Z","steps":["trace[393707613] 'process raft request' (duration: 237.744584ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.323929Z","caller":"traceutil/trace.go:171","msg":"trace[670053245] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"256.221928ms","start":"2026-05-27T13:50:06.067697Z","end":"2026-05-27T13:50:06.323919Z","steps":["trace[670053245] 'process raft request' (duration: 255.151371ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.324126Z","caller":"traceutil/trace.go:171","msg":"trace[1414408519] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"236.973596ms","start":"2026-05-27T13:50:06.087138Z","end":"2026-05-27T13:50:06.324111Z","steps":["trace[1414408519] 'process raft request' (duration: 236.134985ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.324382Z","caller":"traceutil/trace.go:171","msg":"trace[61155022] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"234.453393ms","start":"2026-05-27T13:50:06.089851Z","end":"2026-05-27T13:50:06.324304Z","steps":["trace[61155022] 'process raft request' (duration: 234.110594ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.324507Z","caller":"traceutil/trace.go:171","msg":"trace[1507472206] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"228.2932ms","start":"2026-05-27T13:50:06.096197Z","end":"2026-05-27T13:50:06.32449Z","steps":["trace[1507472206] 'process raft request' (duration: 227.992732ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:06.324954Z","caller":"traceutil/trace.go:171","msg":"trace[286059611] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"194.264146ms","start":"2026-05-27T13:50:06.130663Z","end":"2026-05-27T13:50:06.324927Z","steps":["trace[286059611] 'process raft request' (duration: 193.698792ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:12.772438Z","caller":"traceutil/trace.go:171","msg":"trace[280928461] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"172.275057ms","start":"2026-05-27T13:50:12.600134Z","end":"2026-05-27T13:50:12.772409Z","steps":["trace[280928461] 'process raft request' (duration: 171.712132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:13.317797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.356546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-27T13:50:13.317844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.582859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T13:50:13.317905Z","caller":"traceutil/trace.go:171","msg":"trace[1110034457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"261.530941ms","start":"2026-05-27T13:50:13.056355Z","end":"2026-05-27T13:50:13.317886Z","steps":["trace[1110034457] 'range keys from in-memory index tree' (duration: 261.192322ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:13.317923Z","caller":"traceutil/trace.go:171","msg":"trace[1320681762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"294.730523ms","start":"2026-05-27T13:50:13.023172Z","end":"2026-05-27T13:50:13.317902Z","steps":["trace[1320681762] 'range keys from in-memory index tree' (duration: 294.367704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.007301Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322103349541165923,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:50:14.713543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.452114ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:50:14.713678Z","caller":"traceutil/trace.go:171","msg":"trace[2118899146] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:650; }","duration":"331.602667ms","start":"2026-05-27T13:50:14.382055Z","end":"2026-05-27T13:50:14.713658Z","steps":["trace[2118899146] 'range keys from in-memory index tree' (duration: 331.434473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.714499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.886478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:50:14.71473Z","caller":"traceutil/trace.go:171","msg":"trace[302115315] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:673; }","duration":"1.208486332s","start":"2026-05-27T13:50:13.506206Z","end":"2026-05-27T13:50:14.714693Z","steps":["trace[302115315] 'read index received' (duration: 825.695382ms)","trace[302115315] 'applied index is now lower than readState.Index' (duration: 382.78991ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:50:14.714832Z","caller":"traceutil/trace.go:171","msg":"trace[258426455] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"1.256987758s","start":"2026-05-27T13:50:13.457831Z","end":"2026-05-27T13:50:14.714819Z","steps":["trace[258426455] 'process raft request' (duration: 1.256799003s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.714901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:13.457808Z","time spent":"1.257059609s","remote":"127.0.0.1:54444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:50:14.714903Z","caller":"traceutil/trace.go:171","msg":"trace[901074454] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"1.301612996s","start":"2026-05-27T13:50:13.413246Z","end":"2026-05-27T13:50:14.714859Z","steps":["trace[901074454] 'process raft request' (duration: 918.706484ms)","trace[901074454] 'compare' (duration: 381.346243ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:50:14.714959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.13425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:50:14.715018Z","caller":"traceutil/trace.go:171","msg":"trace[148777157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"839.243674ms","start":"2026-05-27T13:50:13.875756Z","end":"2026-05-27T13:50:14.715Z","steps":["trace[148777157] 'agreement among raft nodes before linearized reading' (duration: 839.1067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.715058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:13.875727Z","time spent":"839.320816ms","remote":"127.0.0.1:54194","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-27T13:50:14.715086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:13.413221Z","time spent":"1.301764929s","remote":"127.0.0.1:54384","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-27T13:50:14.715354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.078282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:50:14.715393Z","caller":"traceutil/trace.go:171","msg":"trace[1137615228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:652; }","duration":"297.155104ms","start":"2026-05-27T13:50:14.418225Z","end":"2026-05-27T13:50:14.71538Z","steps":["trace[1137615228] 'agreement among raft nodes before linearized reading' (duration: 297.00898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.716516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210310378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:50:14.716627Z","caller":"traceutil/trace.go:171","msg":"trace[777074113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"1.210488992s","start":"2026-05-27T13:50:13.506123Z","end":"2026-05-27T13:50:14.716612Z","steps":["trace[777074113] 'agreement among raft nodes before linearized reading' (duration: 1.208762309s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:14.716664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:13.506096Z","time spent":"1.210559034s","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:50:30.42357Z","caller":"traceutil/trace.go:171","msg":"trace[405913700] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"244.71912ms","start":"2026-05-27T13:50:30.178817Z","end":"2026-05-27T13:50:30.423536Z","steps":["trace[405913700] 'process raft request' (duration: 244.269019ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:30.541602Z","caller":"traceutil/trace.go:171","msg":"trace[434565047] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"111.189035ms","start":"2026-05-27T13:50:30.430383Z","end":"2026-05-27T13:50:30.541573Z","steps":["trace[434565047] 'process raft request' (duration: 111.020061ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:01.349132Z","caller":"traceutil/trace.go:171","msg":"trace[212225393] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"316.27777ms","start":"2026-05-27T13:51:01.032819Z","end":"2026-05-27T13:51:01.349097Z","steps":["trace[212225393] 'read index received' (duration: 316.031514ms)","trace[212225393] 'applied index is now lower than readState.Index' (duration: 245.066µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:01.349261Z","caller":"traceutil/trace.go:171","msg":"trace[810579372] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"332.496545ms","start":"2026-05-27T13:51:01.016717Z","end":"2026-05-27T13:51:01.349213Z","steps":["trace[810579372] 'process raft request' (duration: 332.157106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.349432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:01.016705Z","time spent":"332.636559ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:51:01.34945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.622379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:51:01.34952Z","caller":"traceutil/trace.go:171","msg":"trace[2065945439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"316.732482ms","start":"2026-05-27T13:51:01.032767Z","end":"2026-05-27T13:51:01.349499Z","steps":["trace[2065945439] 'agreement among raft nodes before linearized reading' (duration: 316.460075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:01.349566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:01.032747Z","time spent":"316.809513ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T13:51:01.483833Z","caller":"traceutil/trace.go:171","msg":"trace[1050125613] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"128.110166ms","start":"2026-05-27T13:51:01.35564Z","end":"2026-05-27T13:51:01.48375Z","steps":["trace[1050125613] 'process raft request' (duration: 126.586387ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:06.894997Z","caller":"traceutil/trace.go:171","msg":"trace[868098289] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"185.98387ms","start":"2026-05-27T13:51:06.70898Z","end":"2026-05-27T13:51:06.894964Z","steps":["trace[868098289] 'process raft request' (duration: 185.783325ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:07.274503Z","caller":"traceutil/trace.go:171","msg":"trace[1171938244] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"139.545581ms","start":"2026-05-27T13:51:07.134905Z","end":"2026-05-27T13:51:07.274451Z","steps":["trace[1171938244] 'process raft request' (duration: 138.376042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:07.644507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.796878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:51:07.644607Z","caller":"traceutil/trace.go:171","msg":"trace[416589848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1036; }","duration":"133.966362ms","start":"2026-05-27T13:51:07.510617Z","end":"2026-05-27T13:51:07.644583Z","steps":["trace[416589848] 'range keys from in-memory index tree' (duration: 133.598123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:07.645434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.38959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:51:07.645492Z","caller":"traceutil/trace.go:171","msg":"trace[1582950392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1036; }","duration":"269.498272ms","start":"2026-05-27T13:51:07.375981Z","end":"2026-05-27T13:51:07.64548Z","steps":["trace[1582950392] 'range keys from in-memory index tree' (duration: 269.230856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.208451Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322103349541166786,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:51:08.492835Z","caller":"traceutil/trace.go:171","msg":"trace[635440800] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"843.340548ms","start":"2026-05-27T13:51:07.649461Z","end":"2026-05-27T13:51:08.492802Z","steps":["trace[635440800] 'process raft request' (duration: 843.140243ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.493025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.649434Z","time spent":"843.491702ms","remote":"127.0.0.1:54472","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-27T13:51:08.551468Z","caller":"traceutil/trace.go:171","msg":"trace[682737740] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"900.665198ms","start":"2026-05-27T13:51:07.65078Z","end":"2026-05-27T13:51:08.551445Z","steps":["trace[682737740] 'process raft request' (duration: 898.138995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.5516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.650757Z","time spent":"900.773411ms","remote":"127.0.0.1:54472","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-27T13:51:08.551677Z","caller":"traceutil/trace.go:171","msg":"trace[383819074] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1074; }","duration":"843.8275ms","start":"2026-05-27T13:51:07.707771Z","end":"2026-05-27T13:51:08.551599Z","steps":["trace[383819074] 'read index received' (duration: 784.863969ms)","trace[383819074] 'applied index is now lower than readState.Index' (duration: 58.962221ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:08.551766Z","caller":"traceutil/trace.go:171","msg":"trace[914598161] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"869.064959ms","start":"2026-05-27T13:51:07.682692Z","end":"2026-05-27T13:51:08.551757Z","steps":["trace[914598161] 'process raft request' (duration: 868.720101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.551831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.682667Z","time spent":"869.12081ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:51:08.551941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.169758ms","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-27T13:51:08.551978Z","caller":"traceutil/trace.go:171","msg":"trace[444763010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1039; }","duration":"844.267711ms","start":"2026-05-27T13:51:07.7077Z","end":"2026-05-27T13:51:08.551968Z","steps":["trace[444763010] 'agreement among raft nodes before linearized reading' (duration: 844.082966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.552015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.707675Z","time spent":"844.328693ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:51:08.55202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.64866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-27T13:51:08.552052Z","caller":"traceutil/trace.go:171","msg":"trace[113410578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1039; }","duration":"838.720592ms","start":"2026-05-27T13:51:07.713324Z","end":"2026-05-27T13:51:08.552044Z","steps":["trace[113410578] 'agreement among raft nodes before linearized reading' (duration: 838.603419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.552076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.71331Z","time spent":"838.762203ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:51:08.552166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.16451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:51:08.552157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.212179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:08.552192Z","caller":"traceutil/trace.go:171","msg":"trace[1656500169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"711.220032ms","start":"2026-05-27T13:51:07.840964Z","end":"2026-05-27T13:51:08.552184Z","steps":["trace[1656500169] 'agreement among raft nodes before linearized reading' (duration: 711.177871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.552216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.840945Z","time spent":"711.265654ms","remote":"127.0.0.1:54194","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-27T13:51:08.552213Z","caller":"traceutil/trace.go:171","msg":"trace[677642962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"674.328552ms","start":"2026-05-27T13:51:07.877869Z","end":"2026-05-27T13:51:08.552197Z","steps":["trace[677642962] 'agreement among raft nodes before linearized reading' (duration: 674.24179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:08.55225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:07.877843Z","time spent":"674.397863ms","remote":"127.0.0.1:54206","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-27T13:51:34.855154Z","caller":"traceutil/trace.go:171","msg":"trace[2118522224] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"108.878456ms","start":"2026-05-27T13:51:34.746246Z","end":"2026-05-27T13:51:34.855124Z","steps":["trace[2118522224] 'process raft request' (duration: 69.952166ms)","trace[2118522224] 'compare' (duration: 38.327745ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:34.855529Z","caller":"traceutil/trace.go:171","msg":"trace[1303876394] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"109.142583ms","start":"2026-05-27T13:51:34.746345Z","end":"2026-05-27T13:51:34.855487Z","steps":["trace[1303876394] 'process raft request' (duration: 108.68574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:37.058164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.082028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:51:37.058299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.672597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:51:37.05836Z","caller":"traceutil/trace.go:171","msg":"trace[435943155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1129; }","duration":"198.764298ms","start":"2026-05-27T13:51:36.859578Z","end":"2026-05-27T13:51:37.058342Z","steps":["trace[435943155] 'range keys from in-memory index tree' (duration: 198.466591ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.058294Z","caller":"traceutil/trace.go:171","msg":"trace[1605479521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1129; }","duration":"179.270872ms","start":"2026-05-27T13:51:36.878994Z","end":"2026-05-27T13:51:37.058265Z","steps":["trace[1605479521] 'range keys from in-memory index tree' (duration: 179.024216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:37.058443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.89987ms","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-27T13:51:37.05853Z","caller":"traceutil/trace.go:171","msg":"trace[511311331] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1129; }","duration":"144.023582ms","start":"2026-05-27T13:51:36.914486Z","end":"2026-05-27T13:51:37.05851Z","steps":["trace[511311331] 'range keys from in-memory index tree' (duration: 143.619963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:37.058798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.613947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-27T13:51:37.059696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.119137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:51:37.059745Z","caller":"traceutil/trace.go:171","msg":"trace[581618995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1129; }","duration":"153.622812ms","start":"2026-05-27T13:51:36.906099Z","end":"2026-05-27T13:51:37.059722Z","steps":["trace[581618995] 'range keys from in-memory index tree' (duration: 152.248528ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.059797Z","caller":"traceutil/trace.go:171","msg":"trace[1058147606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1129; }","duration":"199.25502ms","start":"2026-05-27T13:51:36.860516Z","end":"2026-05-27T13:51:37.059771Z","steps":["trace[1058147606] 'range keys from in-memory index tree' (duration: 198.901082ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.307318Z","caller":"traceutil/trace.go:171","msg":"trace[1001697950] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"243.094234ms","start":"2026-05-27T13:51:37.064188Z","end":"2026-05-27T13:51:37.307282Z","steps":["trace[1001697950] 'process raft request' (duration: 235.245318ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.30759Z","caller":"traceutil/trace.go:171","msg":"trace[927092035] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1173; }","duration":"238.429978ms","start":"2026-05-27T13:51:37.069142Z","end":"2026-05-27T13:51:37.307572Z","steps":["trace[927092035] 'read index received' (duration: 5.430906ms)","trace[927092035] 'applied index is now lower than readState.Index' (duration: 232.998502ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:37.30768Z","caller":"traceutil/trace.go:171","msg":"trace[1209120614] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"242.729905ms","start":"2026-05-27T13:51:37.064925Z","end":"2026-05-27T13:51:37.307655Z","steps":["trace[1209120614] 'process raft request' (duration: 242.305405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:37.307745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.583422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-27T13:51:37.307774Z","caller":"traceutil/trace.go:171","msg":"trace[1572738632] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"238.652233ms","start":"2026-05-27T13:51:37.069115Z","end":"2026-05-27T13:51:37.307767Z","steps":["trace[1572738632] 'agreement among raft nodes before linearized reading' (duration: 238.52821ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.307869Z","caller":"traceutil/trace.go:171","msg":"trace[1200853183] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"241.789821ms","start":"2026-05-27T13:51:37.066072Z","end":"2026-05-27T13:51:37.307862Z","steps":["trace[1200853183] 'process raft request' (duration: 241.427062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.569387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.424827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T13:51:53.569483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.339186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-27T13:51:53.569475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.333377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:51:53.569575Z","caller":"traceutil/trace.go:171","msg":"trace[1645075982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"137.463769ms","start":"2026-05-27T13:51:53.432087Z","end":"2026-05-27T13:51:53.569551Z","steps":["trace[1645075982] 'range keys from in-memory index tree' (duration: 137.182992ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:53.569586Z","caller":"traceutil/trace.go:171","msg":"trace[1495347659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"410.492801ms","start":"2026-05-27T13:51:53.159067Z","end":"2026-05-27T13:51:53.569559Z","steps":["trace[1495347659] 'range keys from in-memory index tree' (duration: 410.156973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.569634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.159047Z","time spent":"410.572822ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:51:53.569613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.270451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T13:51:53.56969Z","caller":"traceutil/trace.go:171","msg":"trace[74859221] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"104.410564ms","start":"2026-05-27T13:51:53.465262Z","end":"2026-05-27T13:51:53.569673Z","steps":["trace[74859221] 'range keys from in-memory index tree' (duration: 104.070896ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:53.56951Z","caller":"traceutil/trace.go:171","msg":"trace[845523240] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"161.584711ms","start":"2026-05-27T13:51:53.407899Z","end":"2026-05-27T13:51:53.569484Z","steps":["trace[845523240] 'range keys from in-memory index tree' (duration: 161.207982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.569826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.27181ms","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-27T13:51:53.569866Z","caller":"traceutil/trace.go:171","msg":"trace[2000152777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1233; }","duration":"126.351012ms","start":"2026-05-27T13:51:53.443502Z","end":"2026-05-27T13:51:53.569853Z","steps":["trace[2000152777] 'range keys from in-memory index tree' (duration: 126.129476ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:53.966784Z","caller":"traceutil/trace.go:171","msg":"trace[699510135] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"392.500241ms","start":"2026-05-27T13:51:53.57426Z","end":"2026-05-27T13:51:53.96676Z","steps":["trace[699510135] 'process raft request' (duration: 392.345088ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.966931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.574241Z","time spent":"392.613474ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:51:53.981252Z","caller":"traceutil/trace.go:171","msg":"trace[2093955732] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"406.737006ms","start":"2026-05-27T13:51:53.57449Z","end":"2026-05-27T13:51:53.981227Z","steps":["trace[2093955732] 'process raft request' (duration: 406.542841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.981416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.574466Z","time spent":"406.859868ms","remote":"127.0.0.1:54472","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-27T13:51:53.981554Z","caller":"traceutil/trace.go:171","msg":"trace[1123626005] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"405.145727ms","start":"2026-05-27T13:51:53.576392Z","end":"2026-05-27T13:51:53.981537Z","steps":["trace[1123626005] 'process raft request' (duration: 404.799318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.981619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.576356Z","time spent":"405.226639ms","remote":"127.0.0.1:54472","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-27T13:51:53.981702Z","caller":"traceutil/trace.go:171","msg":"trace[888125879] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"399.624789ms","start":"2026-05-27T13:51:53.582063Z","end":"2026-05-27T13:51:53.981688Z","steps":["trace[888125879] 'process raft request' (duration: 399.547927ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:53.981688Z","caller":"traceutil/trace.go:171","msg":"trace[774586257] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"399.63966ms","start":"2026-05-27T13:51:53.582014Z","end":"2026-05-27T13:51:53.981654Z","steps":["trace[774586257] 'process raft request' (duration: 399.450025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:53.981843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.582054Z","time spent":"399.709391ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:51:53.981896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:53.582006Z","time spent":"399.841154ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:52:10.380023Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322103349541167433,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:52:10.411806Z","caller":"traceutil/trace.go:171","msg":"trace[915674407] linearizableReadLoop","detail":"{readStateIndex:1355; appliedIndex:1354; }","duration":"532.771462ms","start":"2026-05-27T13:52:09.879005Z","end":"2026-05-27T13:52:10.411776Z","steps":["trace[915674407] 'read index received' (duration: 532.505246ms)","trace[915674407] 'applied index is now lower than readState.Index' (duration: 265.336µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:10.412222Z","caller":"traceutil/trace.go:171","msg":"trace[1757859083] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"592.887777ms","start":"2026-05-27T13:52:09.81932Z","end":"2026-05-27T13:52:10.412208Z","steps":["trace[1757859083] 'process raft request' (duration: 592.275572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.412353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:09.819296Z","time spent":"592.965278ms","remote":"127.0.0.1:54384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11371,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:52:10.412533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.52672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:10.412576Z","caller":"traceutil/trace.go:171","msg":"trace[1099851818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1303; }","duration":"533.605252ms","start":"2026-05-27T13:52:09.878959Z","end":"2026-05-27T13:52:10.412564Z","steps":["trace[1099851818] 'agreement among raft nodes before linearized reading' (duration: 533.543151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.412605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:09.878938Z","time spent":"533.661653ms","remote":"127.0.0.1:54194","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-27T13:52:10.412855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.314914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-27T13:52:10.412891Z","caller":"traceutil/trace.go:171","msg":"trace[1818367230] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1303; }","duration":"367.382656ms","start":"2026-05-27T13:52:10.0455Z","end":"2026-05-27T13:52:10.412882Z","steps":["trace[1818367230] 'agreement among raft nodes before linearized reading' (duration: 367.246503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.412918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:10.045482Z","time spent":"367.430287ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:52:10.413243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.441534ms","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-27T13:52:10.41329Z","caller":"traceutil/trace.go:171","msg":"trace[1631415241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1303; }","duration":"332.524776ms","start":"2026-05-27T13:52:10.080752Z","end":"2026-05-27T13:52:10.413277Z","steps":["trace[1631415241] 'agreement among raft nodes before linearized reading' (duration: 332.371851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.413317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:10.080732Z","time spent":"332.579067ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:52:10.413398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.607148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:52:10.413431Z","caller":"traceutil/trace.go:171","msg":"trace[27514943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1303; }","duration":"332.640338ms","start":"2026-05-27T13:52:10.08078Z","end":"2026-05-27T13:52:10.41342Z","steps":["trace[27514943] 'agreement among raft nodes before linearized reading' (duration: 332.544356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.413449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:10.080703Z","time spent":"332.742671ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:52:10.413504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.815382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T13:52:10.413586Z","caller":"traceutil/trace.go:171","msg":"trace[980549424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1303; }","duration":"349.962606ms","start":"2026-05-27T13:52:10.063602Z","end":"2026-05-27T13:52:10.413565Z","steps":["trace[980549424] 'agreement among raft nodes before linearized reading' (duration: 349.629538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.413626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:10.063578Z","time spent":"350.042158ms","remote":"127.0.0.1:54472","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":"warn","ts":"2026-05-27T13:52:10.413629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.02755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-27T13:52:10.413705Z","caller":"traceutil/trace.go:171","msg":"trace[2082755420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1303; }","duration":"357.175785ms","start":"2026-05-27T13:52:10.056509Z","end":"2026-05-27T13:52:10.413685Z","steps":["trace[2082755420] 'agreement among raft nodes before linearized reading' (duration: 356.912448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:10.413743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:10.056481Z","time spent":"357.255776ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:52:10.656954Z","caller":"traceutil/trace.go:171","msg":"trace[413684481] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"237.894738ms","start":"2026-05-27T13:52:10.419014Z","end":"2026-05-27T13:52:10.656909Z","steps":["trace[413684481] 'process raft request' (duration: 214.260393ms)","trace[413684481] 'compare' (duration: 23.422448ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:10.688783Z","caller":"traceutil/trace.go:171","msg":"trace[494045429] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"268.206707ms","start":"2026-05-27T13:52:10.420532Z","end":"2026-05-27T13:52:10.688739Z","steps":["trace[494045429] 'process raft request' (duration: 267.95309ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.688852Z","caller":"traceutil/trace.go:171","msg":"trace[1063739409] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"268.112295ms","start":"2026-05-27T13:52:10.420706Z","end":"2026-05-27T13:52:10.688818Z","steps":["trace[1063739409] 'process raft request' (duration: 267.92165ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.689565Z","caller":"traceutil/trace.go:171","msg":"trace[2091504436] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"268.850513ms","start":"2026-05-27T13:52:10.420707Z","end":"2026-05-27T13:52:10.689558Z","steps":["trace[2091504436] 'process raft request' (duration: 267.965271ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.690385Z","caller":"traceutil/trace.go:171","msg":"trace[133300467] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"266.472913ms","start":"2026-05-27T13:52:10.423892Z","end":"2026-05-27T13:52:10.690365Z","steps":["trace[133300467] 'process raft request' (duration: 265.589642ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.690882Z","caller":"traceutil/trace.go:171","msg":"trace[1144860399] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"266.777881ms","start":"2026-05-27T13:52:10.424086Z","end":"2026-05-27T13:52:10.690864Z","steps":["trace[1144860399] 'process raft request' (duration: 266.017552ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.692902Z","caller":"traceutil/trace.go:171","msg":"trace[362847813] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"266.247947ms","start":"2026-05-27T13:52:10.42663Z","end":"2026-05-27T13:52:10.692878Z","steps":["trace[362847813] 'process raft request' (duration: 263.991852ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:10.693293Z","caller":"traceutil/trace.go:171","msg":"trace[867474059] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"266.516524ms","start":"2026-05-27T13:52:10.426759Z","end":"2026-05-27T13:52:10.693275Z","steps":["trace[867474059] 'process raft request' (duration: 266.011202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:11.633313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.028176ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-27T13:52:11.8096Z","caller":"traceutil/trace.go:171","msg":"trace[1149087940] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"239.437816ms","start":"2026-05-27T13:52:11.57012Z","end":"2026-05-27T13:52:11.809558Z","steps":["trace[1149087940] 'process raft request' (duration: 239.013925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:12.212483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.886183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:12.213173Z","caller":"traceutil/trace.go:171","msg":"trace[1718055631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"337.61174ms","start":"2026-05-27T13:52:11.875523Z","end":"2026-05-27T13:52:12.213135Z","steps":["trace[1718055631] 'range keys from in-memory index tree' (duration: 336.78305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:12.21335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:11.875506Z","time spent":"337.800845ms","remote":"127.0.0.1:54194","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-27T13:52:12.212484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.605728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:12.213565Z","caller":"traceutil/trace.go:171","msg":"trace[358005470] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1313; }","duration":"248.737126ms","start":"2026-05-27T13:52:11.964798Z","end":"2026-05-27T13:52:12.213535Z","steps":["trace[358005470] 'count revisions from in-memory index tree' (duration: 247.503405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:13.152211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.14951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:52:13.15302Z","caller":"traceutil/trace.go:171","msg":"trace[48083638] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"453.478333ms","start":"2026-05-27T13:52:12.699468Z","end":"2026-05-27T13:52:13.152947Z","steps":["trace[48083638] 'process raft request' (duration: 185.475222ms)","trace[48083638] 'compare' (duration: 267.017796ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:13.153501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:12.69944Z","time spent":"453.934074ms","remote":"127.0.0.1:54472","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-27T13:52:13.349784Z","caller":"traceutil/trace.go:171","msg":"trace[2086318602] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"649.467644ms","start":"2026-05-27T13:52:12.700278Z","end":"2026-05-27T13:52:13.349746Z","steps":["trace[2086318602] 'process raft request' (duration: 562.928496ms)","trace[2086318602] 'compare' (duration: 86.246321ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:13.349893Z","caller":"traceutil/trace.go:171","msg":"trace[1493434180] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"649.141497ms","start":"2026-05-27T13:52:12.700718Z","end":"2026-05-27T13:52:13.349859Z","steps":["trace[1493434180] 'process raft request' (duration: 648.883691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:13.349971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:12.700252Z","time spent":"649.613368ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:52:13.350064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:12.700684Z","time spent":"649.284091ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:52:13.350186Z","caller":"traceutil/trace.go:171","msg":"trace[1033687798] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"323.883462ms","start":"2026-05-27T13:52:13.026279Z","end":"2026-05-27T13:52:13.350162Z","steps":["trace[1033687798] 'process raft request' (duration: 323.83872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:13.350326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:13.026253Z","time spent":"323.995305ms","remote":"127.0.0.1:54472","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-27T13:52:13.350395Z","caller":"traceutil/trace.go:171","msg":"trace[90072257] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1368; }","duration":"473.228411ms","start":"2026-05-27T13:52:12.877152Z","end":"2026-05-27T13:52:13.35038Z","steps":["trace[90072257] 'read index received' (duration: 7.803773ms)","trace[90072257] 'applied index is now lower than readState.Index' (duration: 465.422828ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:13.350211Z","caller":"traceutil/trace.go:171","msg":"trace[1607443370] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"648.119571ms","start":"2026-05-27T13:52:12.70208Z","end":"2026-05-27T13:52:13.3502Z","steps":["trace[1607443370] 'process raft request' (duration: 647.601119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:13.350471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:12.70207Z","time spent":"648.374207ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:52:13.350519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.372424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:13.350552Z","caller":"traceutil/trace.go:171","msg":"trace[790875739] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1320; }","duration":"473.456457ms","start":"2026-05-27T13:52:12.877087Z","end":"2026-05-27T13:52:13.350543Z","steps":["trace[790875739] 'agreement among raft nodes before linearized reading' (duration: 473.388945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:13.350581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:12.877035Z","time spent":"473.539629ms","remote":"127.0.0.1:54194","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-27T13:52:13.350614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.442426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:52:13.350648Z","caller":"traceutil/trace.go:171","msg":"trace[1210623096] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1320; }","duration":"286.509308ms","start":"2026-05-27T13:52:13.064129Z","end":"2026-05-27T13:52:13.350638Z","steps":["trace[1210623096] 'agreement among raft nodes before linearized reading' (duration: 286.452377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.874328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568385546s","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:508"} {"level":"info","ts":"2026-05-27T13:52:26.874416Z","caller":"traceutil/trace.go:171","msg":"trace[503038615] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1402; }","duration":"1.568482488s","start":"2026-05-27T13:52:25.305912Z","end":"2026-05-27T13:52:26.874394Z","steps":["trace[503038615] 'range keys from in-memory index tree' (duration: 1.568199852s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.87446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.305844Z","time spent":"1.568605472s","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-27T13:52:26.87479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304793515s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:52:26.874927Z","caller":"traceutil/trace.go:171","msg":"trace[1467983597] linearizableReadLoop","detail":"{readStateIndex:1458; appliedIndex:1457; }","duration":"1.433884664s","start":"2026-05-27T13:52:25.44102Z","end":"2026-05-27T13:52:26.874905Z","steps":["trace[1467983597] 'read index received' (duration: 128.766481ms)","trace[1467983597] 'applied index is now lower than readState.Index' (duration: 1.305116573s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:26.87547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.675139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:52:26.87551Z","caller":"traceutil/trace.go:171","msg":"trace[1901476606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1403; }","duration":"109.776502ms","start":"2026-05-27T13:52:26.765723Z","end":"2026-05-27T13:52:26.8755Z","steps":["trace[1901476606] 'agreement among raft nodes before linearized reading' (duration: 109.68142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.875544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432673663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:52:26.875584Z","caller":"traceutil/trace.go:171","msg":"trace[949918030] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"1.446435293s","start":"2026-05-27T13:52:25.429138Z","end":"2026-05-27T13:52:26.875574Z","steps":["trace[949918030] 'process raft request' (duration: 140.748117ms)","trace[949918030] 'compare' (duration: 1.304256351s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:26.875641Z","caller":"traceutil/trace.go:171","msg":"trace[1486229349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1403; }","duration":"1.432814687s","start":"2026-05-27T13:52:25.442807Z","end":"2026-05-27T13:52:26.875621Z","steps":["trace[1486229349] 'agreement among raft nodes before linearized reading' (duration: 1.432550991s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.875611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.54323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:52:26.875701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.429094Z","time spent":"1.446537965s","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:52:26.875718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.219805ms","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:530"} {"level":"info","ts":"2026-05-27T13:52:26.875747Z","caller":"traceutil/trace.go:171","msg":"trace[1742672078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1403; }","duration":"996.752526ms","start":"2026-05-27T13:52:25.878968Z","end":"2026-05-27T13:52:26.87572Z","steps":["trace[1742672078] 'agreement among raft nodes before linearized reading' (duration: 996.492879ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:26.875761Z","caller":"traceutil/trace.go:171","msg":"trace[1299417778] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1403; }","duration":"627.301297ms","start":"2026-05-27T13:52:26.248447Z","end":"2026-05-27T13:52:26.875749Z","steps":["trace[1299417778] 'agreement among raft nodes before linearized reading' (duration: 626.983179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.875799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.434782755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-27T13:52:26.875793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428331136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-27T13:52:26.8758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:26.248421Z","time spent":"627.370659ms","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-27T13:52:26.875799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.87894Z","time spent":"996.848627ms","remote":"127.0.0.1:54194","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-27T13:52:26.875832Z","caller":"traceutil/trace.go:171","msg":"trace[253559919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1403; }","duration":"1.428380458s","start":"2026-05-27T13:52:25.447442Z","end":"2026-05-27T13:52:26.875822Z","steps":["trace[253559919] 'agreement among raft nodes before linearized reading' (duration: 1.428275035s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.87587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.447434Z","time spent":"1.428430779s","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:52:26.875693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.442783Z","time spent":"1.432901319s","remote":"127.0.0.1:54472","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-27T13:52:26.875991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.979463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-27T13:52:26.876022Z","caller":"traceutil/trace.go:171","msg":"trace[1967925291] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1403; }","duration":"545.045575ms","start":"2026-05-27T13:52:26.330967Z","end":"2026-05-27T13:52:26.876012Z","steps":["trace[1967925291] 'agreement among raft nodes before linearized reading' (duration: 544.962913ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:26.875822Z","caller":"traceutil/trace.go:171","msg":"trace[1505849127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1403; }","duration":"1.434846627s","start":"2026-05-27T13:52:25.440969Z","end":"2026-05-27T13:52:26.875815Z","steps":["trace[1505849127] 'agreement among raft nodes before linearized reading' (duration: 1.434786525s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:26.876089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:25.440943Z","time spent":"1.435131464s","remote":"127.0.0.1:54472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:52:26.876049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:26.330941Z","time spent":"545.102016ms","remote":"127.0.0.1:54236","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.57\" "} {"level":"info","ts":"2026-05-27T13:52:27.095526Z","caller":"traceutil/trace.go:171","msg":"trace[532039007] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"211.112496ms","start":"2026-05-27T13:52:26.884385Z","end":"2026-05-27T13:52:27.095497Z","steps":["trace[532039007] 'process raft request' (duration: 210.997952ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.095896Z","caller":"traceutil/trace.go:171","msg":"trace[426724757] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"211.464205ms","start":"2026-05-27T13:52:26.884419Z","end":"2026-05-27T13:52:27.095883Z","steps":["trace[426724757] 'process raft request' (duration: 211.030384ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.095573Z","caller":"traceutil/trace.go:171","msg":"trace[14674119] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"213.70779ms","start":"2026-05-27T13:52:26.881823Z","end":"2026-05-27T13:52:27.095531Z","steps":["trace[14674119] 'process raft request' (duration: 213.188706ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.096138Z","caller":"traceutil/trace.go:171","msg":"trace[1946027156] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"211.671599ms","start":"2026-05-27T13:52:26.884446Z","end":"2026-05-27T13:52:27.096118Z","steps":["trace[1946027156] 'process raft request' (duration: 211.29107ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.096401Z","caller":"traceutil/trace.go:171","msg":"trace[1010171323] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"211.498626ms","start":"2026-05-27T13:52:26.884886Z","end":"2026-05-27T13:52:27.096385Z","steps":["trace[1010171323] 'process raft request' (duration: 211.453955ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.096394Z","caller":"traceutil/trace.go:171","msg":"trace[1533526915] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"211.888045ms","start":"2026-05-27T13:52:26.884473Z","end":"2026-05-27T13:52:27.096361Z","steps":["trace[1533526915] 'process raft request' (duration: 211.575948ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.096483Z","caller":"traceutil/trace.go:171","msg":"trace[1181250093] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"211.971837ms","start":"2026-05-27T13:52:26.884492Z","end":"2026-05-27T13:52:27.096464Z","steps":["trace[1181250093] 'process raft request' (duration: 211.772802ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.098268Z","caller":"traceutil/trace.go:171","msg":"trace[1346385392] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1459; }","duration":"185.625286ms","start":"2026-05-27T13:52:26.91263Z","end":"2026-05-27T13:52:27.098255Z","steps":["trace[1346385392] 'read index received' (duration: 182.391066ms)","trace[1346385392] 'applied index is now lower than readState.Index' (duration: 3.23322ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:27.098423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.77738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:27.098463Z","caller":"traceutil/trace.go:171","msg":"trace[907128139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1411; }","duration":"185.862922ms","start":"2026-05-27T13:52:26.912589Z","end":"2026-05-27T13:52:27.098452Z","steps":["trace[907128139] 'agreement among raft nodes before linearized reading' (duration: 185.720569ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:27.098629Z","caller":"traceutil/trace.go:171","msg":"trace[1598919828] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"193.418668ms","start":"2026-05-27T13:52:26.9052Z","end":"2026-05-27T13:52:27.098618Z","steps":["trace[1598919828] 'process raft request' (duration: 192.989217ms)"],"step_count":1}