{"level":"warn","ts":"2026-05-27T13:46:23.351542Z","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:46:23.35169Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.139: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.19.213.139:2380","--initial-cluster=instance=https://199.19.213.139:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.139:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.139: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:46:23.35181Z","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:46:23.351834Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.139:2380"]} {"level":"info","ts":"2026-05-27T13:46:23.351866Z","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:46:23.353135Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"]} {"level":"info","ts":"2026-05-27T13:46:23.353304Z","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.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.139: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:46:23.358324Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.603197ms"} {"level":"info","ts":"2026-05-27T13:46:23.366677Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb257ce137899862","cluster-id":"9913588efaa998c1"} {"level":"info","ts":"2026-05-27T13:46:23.366974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:46:23.367013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 0"} {"level":"info","ts":"2026-05-27T13:46:23.367038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb257ce137899862 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:46:23.367061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 1"} {"level":"info","ts":"2026-05-27T13:46:23.367119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"} {"level":"warn","ts":"2026-05-27T13:46:23.378397Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:46:23.379781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:46:23.381341Z","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:46:23.383712Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb257ce137899862","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:46:23.383902Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb257ce137899862","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:46:23.384026Z","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:46:23.384157Z","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:46:23.384173Z","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:46:23.391705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"} {"level":"info","ts":"2026-05-27T13:46:23.391917Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","added-peer-id":"cb257ce137899862","added-peer-peer-urls":["https://199.19.213.139:2380"]} {"level":"info","ts":"2026-05-27T13:46:23.394483Z","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:46:23.394758Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb257ce137899862","initial-advertise-peer-urls":["https://199.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:46:23.394795Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:46:23.394936Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.139:2380"} {"level":"info","ts":"2026-05-27T13:46:23.394954Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.139:2380"} {"level":"info","ts":"2026-05-27T13:46:23.768924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:46:23.769308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:46:23.769489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgPreVoteResp from cb257ce137899862 at term 1"} {"level":"info","ts":"2026-05-27T13:46:23.769658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:46:23.769729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgVoteResp from cb257ce137899862 at term 2"} {"level":"info","ts":"2026-05-27T13:46:23.769902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became leader at term 2"} {"level":"info","ts":"2026-05-27T13:46:23.76996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb257ce137899862 elected leader cb257ce137899862 at term 2"} {"level":"info","ts":"2026-05-27T13:46:23.771323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:46:23.771372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:46:23.771374Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:23.772661Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:23.772942Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:23.773118Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:23.773262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.139:2379"} {"level":"info","ts":"2026-05-27T13:46:23.773487Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:46:23.773515Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:46:23.774709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:46:23.771292Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb257ce137899862","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.139:2379]}","request-path":"/0/members/cb257ce137899862/attributes","cluster-id":"9913588efaa998c1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:46:25.39275Z","caller":"traceutil/trace.go:171","msg":"trace[253410112] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"196.678559ms","start":"2026-05-27T13:46:25.196036Z","end":"2026-05-27T13:46:25.392714Z","steps":["trace[253410112] 'process raft request' (duration: 196.531422ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:25.392816Z","caller":"traceutil/trace.go:171","msg":"trace[610635994] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"196.120883ms","start":"2026-05-27T13:46:25.196645Z","end":"2026-05-27T13:46:25.392766Z","steps":["trace[610635994] 'process raft request' (duration: 195.961235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.393147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.099839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:25.393241Z","caller":"traceutil/trace.go:171","msg":"trace[1508357689] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"192.261997ms","start":"2026-05-27T13:46:25.200964Z","end":"2026-05-27T13:46:25.393226Z","steps":["trace[1508357689] 'agreement among raft nodes before linearized reading' (duration: 191.959182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:25.393411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.964832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:25.39342Z","caller":"traceutil/trace.go:171","msg":"trace[545454851] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:11; }","duration":"186.147843ms","start":"2026-05-27T13:46:25.20651Z","end":"2026-05-27T13:46:25.392657Z","steps":["trace[545454851] 'read index received' (duration: 137.675121ms)","trace[545454851] 'applied index is now lower than readState.Index' (duration: 48.471631ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:25.393469Z","caller":"traceutil/trace.go:171","msg":"trace[350133926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"198.085967ms","start":"2026-05-27T13:46:25.19537Z","end":"2026-05-27T13:46:25.393456Z","steps":["trace[350133926] 'agreement among raft nodes before linearized reading' (duration: 197.682068ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:25.392702Z","caller":"traceutil/trace.go:171","msg":"trace[1079035215] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"199.205021ms","start":"2026-05-27T13:46:25.193436Z","end":"2026-05-27T13:46:25.392641Z","steps":["trace[1079035215] 'process raft request' (duration: 150.654906ms)","trace[1079035215] 'compare' (duration: 48.268761ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:25.894017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239321999,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:27.579274Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.419280408s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T13:46:28.023061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.958591664s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-27T13:46:28.023289Z","caller":"traceutil/trace.go:171","msg":"trace[1771872358] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"2.814349343s","start":"2026-05-27T13:46:25.208908Z","end":"2026-05-27T13:46:28.023258Z","steps":["trace[1771872358] 'process raft request' (duration: 855.180592ms)","trace[1771872358] 'compare' (duration: 1.958414946s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:28.023438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.20889Z","time spent":"2.814487369s","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.023564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.777081669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-27T13:46:28.023597Z","caller":"traceutil/trace.go:171","msg":"trace[937939186] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"2.777125951s","start":"2026-05-27T13:46:25.246465Z","end":"2026-05-27T13:46:28.023591Z","steps":["trace[937939186] 'agreement among raft nodes before linearized reading' (duration: 2.777034187s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:28.023478Z","caller":"traceutil/trace.go:171","msg":"trace[296121481] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:14; }","duration":"2.630002946s","start":"2026-05-27T13:46:25.393462Z","end":"2026-05-27T13:46:28.023465Z","steps":["trace[296121481] 'read index received' (duration: 670.601925ms)","trace[296121481] 'applied index is now lower than readState.Index' (duration: 1.959400191s)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:28.023625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.246437Z","time spent":"2.777182475s","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-27T13:46:28.023725Z","caller":"traceutil/trace.go:171","msg":"trace[1277908192] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"2.813017618s","start":"2026-05-27T13:46:25.210697Z","end":"2026-05-27T13:46:28.023714Z","steps":["trace[1277908192] 'process raft request' (duration: 2.812603389s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.023773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.210687Z","time spent":"2.81306078s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.023816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.626819613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-27T13:46:28.02369Z","caller":"traceutil/trace.go:171","msg":"trace[1987725735] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"2.813371995s","start":"2026-05-27T13:46:25.210062Z","end":"2026-05-27T13:46:28.023434Z","steps":["trace[1987725735] 'process raft request' (duration: 2.813222138s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.02401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.528403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:28.024044Z","caller":"traceutil/trace.go:171","msg":"trace[1050480836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"541.603786ms","start":"2026-05-27T13:46:27.482433Z","end":"2026-05-27T13:46:28.024037Z","steps":["trace[1050480836] 'agreement among raft nodes before linearized reading' (duration: 541.555724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:27.482402Z","time spent":"541.660999ms","remote":"127.0.0.1:47176","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:46:28.024135Z","caller":"traceutil/trace.go:171","msg":"trace[1548707523] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"2.626490856s","start":"2026-05-27T13:46:25.397638Z","end":"2026-05-27T13:46:28.024128Z","steps":["trace[1548707523] 'process raft request' (duration: 2.625732131s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.397611Z","time spent":"2.626551639s","remote":"127.0.0.1:47624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.024192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.827128246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:28.024223Z","caller":"traceutil/trace.go:171","msg":"trace[86919759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"1.827189078s","start":"2026-05-27T13:46:26.197026Z","end":"2026-05-27T13:46:28.024216Z","steps":["trace[86919759] 'agreement among raft nodes before linearized reading' (duration: 1.827145486s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:26.197001Z","time spent":"1.827236792s","remote":"127.0.0.1:47176","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:46:28.024274Z","caller":"traceutil/trace.go:171","msg":"trace[46941441] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"2.626264845s","start":"2026-05-27T13:46:25.398003Z","end":"2026-05-27T13:46:28.024268Z","steps":["trace[46941441] 'process raft request' (duration: 2.625399795s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.02431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.397982Z","time spent":"2.626314207s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.02435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.93481102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:28.024377Z","caller":"traceutil/trace.go:171","msg":"trace[1131593179] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20; }","duration":"1.934884884s","start":"2026-05-27T13:46:26.089481Z","end":"2026-05-27T13:46:28.024366Z","steps":["trace[1131593179] 'agreement among raft nodes before linearized reading' (duration: 1.934848483s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:28.024398Z","caller":"traceutil/trace.go:171","msg":"trace[772662136] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"2.626246805s","start":"2026-05-27T13:46:25.398145Z","end":"2026-05-27T13:46:28.024392Z","steps":["trace[772662136] 'process raft request' (duration: 2.62529381s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:26.089444Z","time spent":"1.934955388s","remote":"127.0.0.1:47516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-05-27T13:46:28.024434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.398127Z","time spent":"2.626288756s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.024525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.640883288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:28.02454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935048122s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:28.024563Z","caller":"traceutil/trace.go:171","msg":"trace[1979705531] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:20; }","duration":"1.935106984s","start":"2026-05-27T13:46:26.089447Z","end":"2026-05-27T13:46:28.024554Z","steps":["trace[1979705531] 'agreement among raft nodes before linearized reading' (duration: 1.935073163s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:28.024602Z","caller":"traceutil/trace.go:171","msg":"trace[1947778098] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"2.640938581s","start":"2026-05-27T13:46:25.383604Z","end":"2026-05-27T13:46:28.024543Z","steps":["trace[1947778098] 'agreement among raft nodes before linearized reading' (duration: 2.640903629s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:26.089412Z","time spent":"1.935185888s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-05-27T13:46:28.024624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.383583Z","time spent":"2.641035675s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-05-27T13:46:28.024729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.767714187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:28.023854Z","caller":"traceutil/trace.go:171","msg":"trace[911122614] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"2.626905276s","start":"2026-05-27T13:46:25.396939Z","end":"2026-05-27T13:46:28.023844Z","steps":["trace[911122614] 'agreement among raft nodes before linearized reading' (duration: 2.626801831s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:28.024756Z","caller":"traceutil/trace.go:171","msg":"trace[289537570] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:20; }","duration":"2.76777489s","start":"2026-05-27T13:46:25.256976Z","end":"2026-05-27T13:46:28.024751Z","steps":["trace[289537570] 'agreement among raft nodes before linearized reading' (duration: 2.767737689s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.024775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.25696Z","time spent":"2.767811412s","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-27T13:46:28.024606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.210047Z","time spent":"2.813881219s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:28.025236Z","caller":"traceutil/trace.go:171","msg":"trace[483110978] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"2.816253352s","start":"2026-05-27T13:46:25.208975Z","end":"2026-05-27T13:46:28.025229Z","steps":["trace[483110978] 'process raft request' (duration: 2.814236468s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.025275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.208948Z","time spent":"2.816311204s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:28.025362Z","caller":"traceutil/trace.go:171","msg":"trace[1105481741] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12; }","duration":"2.816449531s","start":"2026-05-27T13:46:25.208908Z","end":"2026-05-27T13:46:28.025358Z","steps":["trace[1105481741] 'process raft request' (duration: 2.814273859s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.025388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.20889Z","time spent":"2.816486653s","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:28.02551Z","caller":"traceutil/trace.go:171","msg":"trace[259397025] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"2.815727925s","start":"2026-05-27T13:46:25.209772Z","end":"2026-05-27T13:46:28.0255Z","steps":["trace[259397025] 'process raft request' (duration: 2.813492001s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.025561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.209758Z","time spent":"2.815774928s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:28.02402Z","caller":"traceutil/trace.go:171","msg":"trace[1301635401] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"2.805429483s","start":"2026-05-27T13:46:25.218583Z","end":"2026-05-27T13:46:28.024012Z","steps":["trace[1301635401] 'process raft request' (duration: 2.804735121s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:28.02598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.218573Z","time spent":"2.807376533s","remote":"127.0.0.1:47416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:28.027333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:25.3969Z","time spent":"2.627867131s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-27T13:46:28.533811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239322006,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:29.035032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239322006,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:29.535697Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239322006,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:46:29.607647Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.574952712s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:46:29.703653Z","caller":"traceutil/trace.go:171","msg":"trace[2060867662] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"1.671193052s","start":"2026-05-27T13:46:28.032407Z","end":"2026-05-27T13:46:29.7036Z","steps":["trace[2060867662] 'process raft request' (duration: 1.575471556s)","trace[2060867662] 'compare' (duration: 94.933089ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:29.703876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.032386Z","time spent":"1.67138056s","remote":"127.0.0.1:47258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:29.703911Z","caller":"traceutil/trace.go:171","msg":"trace[278450836] linearizableReadLoop","detail":"{readStateIndex:35; appliedIndex:24; }","duration":"1.671142709s","start":"2026-05-27T13:46:28.032741Z","end":"2026-05-27T13:46:29.703883Z","steps":["trace[278450836] 'read index received' (duration: 1.575260856s)","trace[278450836] 'applied index is now lower than readState.Index' (duration: 95.880953ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:46:29.703956Z","caller":"traceutil/trace.go:171","msg":"trace[414690190] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"1.667873767s","start":"2026-05-27T13:46:28.03603Z","end":"2026-05-27T13:46:29.703904Z","steps":["trace[414690190] 'process raft request' (duration: 1.667701119s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704063Z","caller":"traceutil/trace.go:171","msg":"trace[1094824439] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"1.667993842s","start":"2026-05-27T13:46:28.036054Z","end":"2026-05-27T13:46:29.704048Z","steps":["trace[1094824439] 'process raft request' (duration: 1.667709349s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704185Z","caller":"traceutil/trace.go:171","msg":"trace[1533705548] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"1.669576576s","start":"2026-05-27T13:46:28.034468Z","end":"2026-05-27T13:46:29.704044Z","steps":["trace[1533705548] 'process raft request' (duration: 1.669100084s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704258Z","caller":"traceutil/trace.go:171","msg":"trace[2102489116] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"1.671355018s","start":"2026-05-27T13:46:28.032886Z","end":"2026-05-27T13:46:29.704241Z","steps":["trace[2102489116] 'process raft request' (duration: 1.670556111s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704274Z","caller":"traceutil/trace.go:171","msg":"trace[974179238] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"1.669282832s","start":"2026-05-27T13:46:28.034981Z","end":"2026-05-27T13:46:29.704264Z","steps":["trace[974179238] 'process raft request' (duration: 1.668630982s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.032873Z","time spent":"1.671424432s","remote":"127.0.0.1:47564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.704346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.034958Z","time spent":"1.669356026s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.704393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.034462Z","time spent":"1.669805707s","remote":"127.0.0.1:47624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.704432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.671674633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-vvx8m\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-27T13:46:29.704488Z","caller":"traceutil/trace.go:171","msg":"trace[1187607556] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-vvx8m; range_end:; response_count:1; response_revision:31; }","duration":"1.671768058s","start":"2026-05-27T13:46:28.032704Z","end":"2026-05-27T13:46:29.704472Z","steps":["trace[1187607556] 'agreement among raft nodes before linearized reading' (duration: 1.671638022s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670476957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:29.704543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.032677Z","time spent":"1.671854282s","remote":"127.0.0.1:47416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":885,"request content":"key:\"/registry/certificatesigningrequests/csr-vvx8m\" "} {"level":"info","ts":"2026-05-27T13:46:29.704561Z","caller":"traceutil/trace.go:171","msg":"trace[1722311339] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:31; }","duration":"1.670558251s","start":"2026-05-27T13:46:28.033989Z","end":"2026-05-27T13:46:29.704547Z","steps":["trace[1722311339] 'agreement among raft nodes before linearized reading' (duration: 1.670464387s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704576Z","caller":"traceutil/trace.go:171","msg":"trace[47652633] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"1.670430925s","start":"2026-05-27T13:46:28.034131Z","end":"2026-05-27T13:46:29.704562Z","steps":["trace[47652633] 'process raft request' (duration: 1.669387167s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.033981Z","time spent":"1.670618294s","remote":"127.0.0.1:47252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-05-27T13:46:29.704633Z","caller":"traceutil/trace.go:171","msg":"trace[508902953] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"1.668739317s","start":"2026-05-27T13:46:28.035883Z","end":"2026-05-27T13:46:29.704622Z","steps":["trace[508902953] 'process raft request' (duration: 1.667761832s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.035862Z","time spent":"1.66880732s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.704723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.034122Z","time spent":"1.670477888s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:29.704767Z","caller":"traceutil/trace.go:171","msg":"trace[728450753] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"1.665952267s","start":"2026-05-27T13:46:28.038796Z","end":"2026-05-27T13:46:29.704748Z","steps":["trace[728450753] 'process raft request' (duration: 1.665032184s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.480493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-27T13:46:29.704878Z","caller":"traceutil/trace.go:171","msg":"trace[442786385] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"1.66883003s","start":"2026-05-27T13:46:28.035978Z","end":"2026-05-27T13:46:29.704808Z","steps":["trace[442786385] 'process raft request' (duration: 1.667708909s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.704906Z","caller":"traceutil/trace.go:171","msg":"trace[1988787428] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:31; }","duration":"811.552066ms","start":"2026-05-27T13:46:28.893343Z","end":"2026-05-27T13:46:29.704895Z","steps":["trace[1988787428] 'agreement among raft nodes before linearized reading' (duration: 811.490674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.893317Z","time spent":"811.62737ms","remote":"127.0.0.1:47286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-05-27T13:46:29.705126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670807473s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:29.704912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669824467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:29.704215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.036045Z","time spent":"1.668095747s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.705185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207244547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:29.705183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.038786Z","time spent":"1.666014519s","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:29.705228Z","caller":"traceutil/trace.go:171","msg":"trace[119572465] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:31; }","duration":"1.207324231s","start":"2026-05-27T13:46:28.497894Z","end":"2026-05-27T13:46:29.705219Z","steps":["trace[119572465] 'agreement among raft nodes before linearized reading' (duration: 1.207260138s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:29.70523Z","caller":"traceutil/trace.go:171","msg":"trace[7689276] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:31; }","duration":"1.670164423s","start":"2026-05-27T13:46:28.035046Z","end":"2026-05-27T13:46:29.70521Z","steps":["trace[7689276] 'agreement among raft nodes before linearized reading' (duration: 1.669809017s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.705261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.497867Z","time spent":"1.207388844s","remote":"127.0.0.1:47176","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:46:29.704259Z","caller":"traceutil/trace.go:171","msg":"trace[1366201059] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"1.668107328s","start":"2026-05-27T13:46:28.03614Z","end":"2026-05-27T13:46:29.704248Z","steps":["trace[1366201059] 'process raft request' (duration: 1.667647636s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.705358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.619207277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-27T13:46:29.705405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.036107Z","time spent":"1.669217738s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:29.70542Z","caller":"traceutil/trace.go:171","msg":"trace[1919034676] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:31; }","duration":"1.619299552s","start":"2026-05-27T13:46:28.086107Z","end":"2026-05-27T13:46:29.705407Z","steps":["trace[1919034676] 'agreement among raft nodes before linearized reading' (duration: 1.619213998s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.704953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.035965Z","time spent":"1.668949176s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:29.705461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.086082Z","time spent":"1.619371155s","remote":"127.0.0.1:47266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-05-27T13:46:29.704224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.03602Z","time spent":"1.668035354s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:29.705174Z","caller":"traceutil/trace.go:171","msg":"trace[1135334510] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:31; }","duration":"1.670858876s","start":"2026-05-27T13:46:28.034298Z","end":"2026-05-27T13:46:29.705157Z","steps":["trace[1135334510] 'agreement among raft nodes before linearized reading' (duration: 1.670799453s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:29.705585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.034293Z","time spent":"1.671268424s","remote":"127.0.0.1:47528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-05-27T13:46:29.705294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:28.035034Z","time spent":"1.670241126s","remote":"127.0.0.1:47258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-05-27T13:47:04.114547Z","caller":"traceutil/trace.go:171","msg":"trace[601475231] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"404.181378ms","start":"2026-05-27T13:47:03.710337Z","end":"2026-05-27T13:47:04.114519Z","steps":["trace[601475231] 'process raft request' (duration: 404.060164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.114759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.710316Z","time spent":"404.369495ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:04.789501Z","caller":"traceutil/trace.go:171","msg":"trace[124506095] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.036631541s","start":"2026-05-27T13:47:03.752833Z","end":"2026-05-27T13:47:04.789464Z","steps":["trace[124506095] 'process raft request' (duration: 1.036518398s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.789633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.752812Z","time spent":"1.036757565s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.789606Z","caller":"traceutil/trace.go:171","msg":"trace[576281528] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.030067491s","start":"2026-05-27T13:47:03.759468Z","end":"2026-05-27T13:47:04.789536Z","steps":["trace[576281528] 'process raft request' (duration: 1.029947457s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.789743Z","caller":"traceutil/trace.go:171","msg":"trace[534287238] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:539; }","duration":"818.897782ms","start":"2026-05-27T13:47:03.970825Z","end":"2026-05-27T13:47:04.789723Z","steps":["trace[534287238] 'read index received' (duration: 144.353156ms)","trace[534287238] 'applied index is now lower than readState.Index' (duration: 674.544086ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:04.789791Z","caller":"traceutil/trace.go:171","msg":"trace[702210178] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.046238053s","start":"2026-05-27T13:47:03.743519Z","end":"2026-05-27T13:47:04.789757Z","steps":["trace[702210178] 'process raft request' (duration: 1.045740567s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.789837Z","caller":"traceutil/trace.go:171","msg":"trace[1820991370] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.02348727s","start":"2026-05-27T13:47:03.766341Z","end":"2026-05-27T13:47:04.789829Z","steps":["trace[1820991370] 'process raft request' (duration: 1.023100907s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.789833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.759447Z","time spent":"1.030269407s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:04.789912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.766327Z","time spent":"1.023531202s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:04.789923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.743495Z","time spent":"1.046362357s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.790019Z","caller":"traceutil/trace.go:171","msg":"trace[2000381381] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.00354112s","start":"2026-05-27T13:47:03.786472Z","end":"2026-05-27T13:47:04.790013Z","steps":["trace[2000381381] 'process raft request' (duration: 1.002994932s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.786454Z","time spent":"1.003576641s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.790053Z","caller":"traceutil/trace.go:171","msg":"trace[1703308496] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"940.174053ms","start":"2026-05-27T13:47:03.849867Z","end":"2026-05-27T13:47:04.790041Z","steps":["trace[1703308496] 'process raft request' (duration: 939.755269ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.79006Z","caller":"traceutil/trace.go:171","msg":"trace[1381797120] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.037102187s","start":"2026-05-27T13:47:03.752949Z","end":"2026-05-27T13:47:04.790052Z","steps":["trace[1381797120] 'process raft request' (duration: 1.036444865s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.752923Z","time spent":"1.037160619s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:04.790102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.849843Z","time spent":"940.233075ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.790165Z","caller":"traceutil/trace.go:171","msg":"trace[1799049581] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"821.980755ms","start":"2026-05-27T13:47:03.968174Z","end":"2026-05-27T13:47:04.790155Z","steps":["trace[1799049581] 'process raft request' (duration: 821.487889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.968145Z","time spent":"822.036117ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.790224Z","caller":"traceutil/trace.go:171","msg":"trace[1414667546] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"1.000913941s","start":"2026-05-27T13:47:03.7893Z","end":"2026-05-27T13:47:04.790213Z","steps":["trace[1414667546] 'process raft request' (duration: 1.000195137s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.384808ms","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-27T13:47:04.790271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.789286Z","time spent":"1.000966054s","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.79028Z","caller":"traceutil/trace.go:171","msg":"trace[1343603831] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"819.486441ms","start":"2026-05-27T13:47:03.97078Z","end":"2026-05-27T13:47:04.790266Z","steps":["trace[1343603831] 'agreement among raft nodes before linearized reading' (duration: 819.304445ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.790306Z","caller":"traceutil/trace.go:171","msg":"trace[1107956588] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"994.708203ms","start":"2026-05-27T13:47:03.795591Z","end":"2026-05-27T13:47:04.7903Z","steps":["trace[1107956588] 'process raft request' (duration: 993.941238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.970763Z","time spent":"819.546624ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:47:04.790341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.795572Z","time spent":"994.752975ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:04.790352Z","caller":"traceutil/trace.go:171","msg":"trace[54428234] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"961.52835ms","start":"2026-05-27T13:47:03.828815Z","end":"2026-05-27T13:47:04.790343Z","steps":["trace[54428234] 'process raft request' (duration: 960.773255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.285395ms","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:47:04.7904Z","caller":"traceutil/trace.go:171","msg":"trace[88943429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:536; }","duration":"752.331786ms","start":"2026-05-27T13:47:04.038062Z","end":"2026-05-27T13:47:04.790394Z","steps":["trace[88943429] 'agreement among raft nodes before linearized reading' (duration: 752.297385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.828797Z","time spent":"961.578142ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:04.790229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.510748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-27T13:47:04.790417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.038048Z","time spent":"752.365577ms","remote":"127.0.0.1:47422","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":"info","ts":"2026-05-27T13:47:04.790437Z","caller":"traceutil/trace.go:171","msg":"trace[1078289020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:536; }","duration":"757.765677ms","start":"2026-05-27T13:47:04.032664Z","end":"2026-05-27T13:47:04.79043Z","steps":["trace[1078289020] 'agreement among raft nodes before linearized reading' (duration: 757.510068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.03264Z","time spent":"757.816218ms","remote":"127.0.0.1:47422","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":"info","ts":"2026-05-27T13:47:04.79028Z","caller":"traceutil/trace.go:171","msg":"trace[833782322] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"970.361446ms","start":"2026-05-27T13:47:03.819907Z","end":"2026-05-27T13:47:04.790268Z","steps":["trace[833782322] 'process raft request' (duration: 969.653143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.790522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:03.819889Z","time spent":"970.607475ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:07.679413Z","caller":"traceutil/trace.go:171","msg":"trace[112953919] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"137.781406ms","start":"2026-05-27T13:47:07.541607Z","end":"2026-05-27T13:47:07.679388Z","steps":["trace[112953919] 'process raft request' (duration: 137.628191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:08.817107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.423767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:47:08.817235Z","caller":"traceutil/trace.go:171","msg":"trace[1819648753] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.129395031s","start":"2026-05-27T13:47:07.687819Z","end":"2026-05-27T13:47:08.817214Z","steps":["trace[1819648753] 'process raft request' (duration: 620.787268ms)","trace[1819648753] 'compare' (duration: 508.253761ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:08.817304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:07.687797Z","time spent":"1.129485093s","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:08.81941Z","caller":"traceutil/trace.go:171","msg":"trace[1816579751] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.13153109s","start":"2026-05-27T13:47:07.687853Z","end":"2026-05-27T13:47:08.819384Z","steps":["trace[1816579751] 'process raft request' (duration: 1.131327503s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:08.819536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:07.687825Z","time spent":"1.131651344s","remote":"127.0.0.1:47258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:08.820733Z","caller":"traceutil/trace.go:171","msg":"trace[212748217] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"795.159216ms","start":"2026-05-27T13:47:08.025558Z","end":"2026-05-27T13:47:08.820717Z","steps":["trace[212748217] 'read index received' (duration: 283.143403ms)","trace[212748217] 'applied index is now lower than readState.Index' (duration: 512.014743ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:08.823566Z","caller":"traceutil/trace.go:171","msg":"trace[1136325634] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"755.367163ms","start":"2026-05-27T13:47:08.065407Z","end":"2026-05-27T13:47:08.820774Z","steps":["trace[1136325634] 'process raft request' (duration: 754.745733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:08.823643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.065489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:08.823705Z","caller":"traceutil/trace.go:171","msg":"trace[526280493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"798.145002ms","start":"2026-05-27T13:47:08.02553Z","end":"2026-05-27T13:47:08.823675Z","steps":["trace[526280493] 'agreement among raft nodes before linearized reading' (duration: 795.27933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:08.823762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:08.025514Z","time spent":"798.239725ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:47:08.823817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:08.065342Z","time spent":"758.328909ms","remote":"127.0.0.1:47256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036015,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:08.82382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.545199ms","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:47:08.823956Z","caller":"traceutil/trace.go:171","msg":"trace[198149004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"674.717525ms","start":"2026-05-27T13:47:08.149188Z","end":"2026-05-27T13:47:08.823906Z","steps":["trace[198149004] 'agreement among raft nodes before linearized reading' (duration: 671.652777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:08.824027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:08.149158Z","time spent":"674.85335ms","remote":"127.0.0.1:47422","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:47:13.289528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.135216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:47:13.289639Z","caller":"traceutil/trace.go:171","msg":"trace[100350242] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"616.602687ms","start":"2026-05-27T13:47:12.673017Z","end":"2026-05-27T13:47:13.289619Z","steps":["trace[100350242] 'read index received' (duration: 331.317686ms)","trace[100350242] 'applied index is now lower than readState.Index' (duration: 285.283431ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:13.289741Z","caller":"traceutil/trace.go:171","msg":"trace[1048651336] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"746.120871ms","start":"2026-05-27T13:47:12.543609Z","end":"2026-05-27T13:47:13.28973Z","steps":["trace[1048651336] 'process raft request' (duration: 460.720347ms)","trace[1048651336] 'compare' (duration: 284.842887ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:13.289802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.543591Z","time spent":"746.183893ms","remote":"127.0.0.1:47388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:13.28996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.669671ms","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:47:13.290067Z","caller":"traceutil/trace.go:171","msg":"trace[1865749402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"438.778554ms","start":"2026-05-27T13:47:12.85126Z","end":"2026-05-27T13:47:13.290038Z","steps":["trace[1865749402] 'agreement among raft nodes before linearized reading' (duration: 438.505636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.290125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.851156Z","time spent":"438.957129ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:47:13.290391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.373671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mhd8h\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-27T13:47:13.290437Z","caller":"traceutil/trace.go:171","msg":"trace[2122537001] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mhd8h; range_end:; response_count:1; response_revision:637; }","duration":"617.439883ms","start":"2026-05-27T13:47:12.672982Z","end":"2026-05-27T13:47:13.290422Z","steps":["trace[2122537001] 'agreement among raft nodes before linearized reading' (duration: 617.36173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.290483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.672967Z","time spent":"617.505174ms","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-mhd8h\" "} {"level":"warn","ts":"2026-05-27T13:47:13.290509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.163905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:13.290569Z","caller":"traceutil/trace.go:171","msg":"trace[430205844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"264.250648ms","start":"2026-05-27T13:47:13.026304Z","end":"2026-05-27T13:47:13.290555Z","steps":["trace[430205844] 'agreement among raft nodes before linearized reading' (duration: 264.155745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.290601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.479422ms","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:47:13.290672Z","caller":"traceutil/trace.go:171","msg":"trace[238726263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"379.584486ms","start":"2026-05-27T13:47:12.911069Z","end":"2026-05-27T13:47:13.290654Z","steps":["trace[238726263] 'agreement among raft nodes before linearized reading' (duration: 379.369849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.290749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.911051Z","time spent":"379.657838ms","remote":"127.0.0.1:47422","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:47:13.290786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.418492ms","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-27T13:47:13.29085Z","caller":"traceutil/trace.go:171","msg":"trace[1030623033] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"429.504965ms","start":"2026-05-27T13:47:12.861327Z","end":"2026-05-27T13:47:13.290832Z","steps":["trace[1030623033] 'agreement among raft nodes before linearized reading' (duration: 429.35554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.290898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.861315Z","time spent":"429.572326ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:47:13.290898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.7329ms","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:47:13.290973Z","caller":"traceutil/trace.go:171","msg":"trace[1255292385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"379.822463ms","start":"2026-05-27T13:47:12.911129Z","end":"2026-05-27T13:47:13.290951Z","steps":["trace[1255292385] 'agreement among raft nodes before linearized reading' (duration: 379.620007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:13.291026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:12.911124Z","time spent":"379.888875ms","remote":"127.0.0.1:47422","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-27T13:47:14.772595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.367050187s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:47:14.772871Z","caller":"traceutil/trace.go:171","msg":"trace[1078484063] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"1.473697752s","start":"2026-05-27T13:47:13.299131Z","end":"2026-05-27T13:47:14.772829Z","steps":["trace[1078484063] 'read index received' (duration: 105.700755ms)","trace[1078484063] 'applied index is now lower than readState.Index' (duration: 1.367992807s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:14.772994Z","caller":"traceutil/trace.go:171","msg":"trace[650586625] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.376875312s","start":"2026-05-27T13:47:13.3961Z","end":"2026-05-27T13:47:14.772975Z","steps":["trace[650586625] 'process raft request' (duration: 1.376830031s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:14.773056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473904448s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-27T13:47:14.7731Z","caller":"traceutil/trace.go:171","msg":"trace[460269477] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:643; }","duration":"1.473998112s","start":"2026-05-27T13:47:13.299089Z","end":"2026-05-27T13:47:14.773087Z","steps":["trace[460269477] 'agreement among raft nodes before linearized reading' (duration: 1.473868418s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:14.773141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.299044Z","time spent":"1.474087754s","remote":"127.0.0.1:47356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-05-27T13:47:14.773264Z","caller":"traceutil/trace.go:171","msg":"trace[335424201] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.473345381s","start":"2026-05-27T13:47:13.299907Z","end":"2026-05-27T13:47:14.773253Z","steps":["trace[335424201] 'process raft request' (duration: 1.472825645s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:14.773093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.396071Z","time spent":"1.376976285s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:14.773332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.299897Z","time spent":"1.473405712s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:14.773462Z","caller":"traceutil/trace.go:171","msg":"trace[728646218] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.473499996s","start":"2026-05-27T13:47:13.299954Z","end":"2026-05-27T13:47:14.773454Z","steps":["trace[728646218] 'process raft request' (duration: 1.472853206s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:14.773532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.299951Z","time spent":"1.473546707s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:14.773517Z","caller":"traceutil/trace.go:171","msg":"trace[220903592] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.475815698s","start":"2026-05-27T13:47:13.29744Z","end":"2026-05-27T13:47:14.773256Z","steps":["trace[220903592] 'process raft request' (duration: 107.383688ms)","trace[220903592] 'compare' (duration: 1.366705807s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:14.773758Z","caller":"traceutil/trace.go:171","msg":"trace[1086506696] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.46847922s","start":"2026-05-27T13:47:13.305267Z","end":"2026-05-27T13:47:14.773746Z","steps":["trace[1086506696] 'process raft request' (duration: 1.467621634s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:14.773771Z","caller":"traceutil/trace.go:171","msg":"trace[1711373895] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.473705712s","start":"2026-05-27T13:47:13.300053Z","end":"2026-05-27T13:47:14.773758Z","steps":["trace[1711373895] 'process raft request' (duration: 1.472791674s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:14.77383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.305257Z","time spent":"1.468538221s","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:14.773867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.300047Z","time spent":"1.473758074s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:14.774053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:13.297412Z","time spent":"1.476326373s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:15.524405Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239323264,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:47:16.231058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.409395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:47:16.231226Z","caller":"traceutil/trace.go:171","msg":"trace[675495060] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.444644735s","start":"2026-05-27T13:47:14.786553Z","end":"2026-05-27T13:47:16.231198Z","steps":["trace[675495060] 'process raft request' (duration: 895.041504ms)","trace[675495060] 'compare' (duration: 548.917431ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:16.231233Z","caller":"traceutil/trace.go:171","msg":"trace[1914199161] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"1.207470067s","start":"2026-05-27T13:47:15.023736Z","end":"2026-05-27T13:47:16.231206Z","steps":["trace[1914199161] 'read index received' (duration: 657.778893ms)","trace[1914199161] 'applied index is now lower than readState.Index' (duration: 549.689633ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:16.231324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:14.786538Z","time spent":"1.444750369s","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:47:17.159189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.048953ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-05-27T13:47:17.159624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.135879341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:17.159702Z","caller":"traceutil/trace.go:171","msg":"trace[1734894185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"2.135994714s","start":"2026-05-27T13:47:15.023685Z","end":"2026-05-27T13:47:17.159679Z","steps":["trace[1734894185] 'agreement among raft nodes before linearized reading' (duration: 1.207612991s)","trace[1734894185] 'range keys from in-memory index tree' (duration: 928.27675ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:17.159741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:15.023655Z","time spent":"2.136078467s","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:47:17.159775Z","caller":"traceutil/trace.go:171","msg":"trace[2139607833] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"922.475915ms","start":"2026-05-27T13:47:16.237275Z","end":"2026-05-27T13:47:17.159751Z","steps":["trace[2139607833] 'process raft request' (duration: 922.035191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.159936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.237252Z","time spent":"922.595428ms","remote":"127.0.0.1:47250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:17.162415Z","caller":"traceutil/trace.go:171","msg":"trace[2862189] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:664; }","duration":"381.123368ms","start":"2026-05-27T13:47:16.781259Z","end":"2026-05-27T13:47:17.162382Z","steps":["trace[2862189] 'read index received' (duration: 308.274708ms)","trace[2862189] 'applied index is now lower than readState.Index' (duration: 72.84794ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:17.16265Z","caller":"traceutil/trace.go:171","msg":"trace[1808105709] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"924.318039ms","start":"2026-05-27T13:47:16.238311Z","end":"2026-05-27T13:47:17.162629Z","steps":["trace[1808105709] 'process raft request' (duration: 924.02885ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:17.162765Z","caller":"traceutil/trace.go:171","msg":"trace[276559100] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"924.714161ms","start":"2026-05-27T13:47:16.238027Z","end":"2026-05-27T13:47:17.162741Z","steps":["trace[276559100] 'process raft request' (duration: 921.710201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.162856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.579081ms","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:47:17.162894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.238015Z","time spent":"924.805184ms","remote":"127.0.0.1:47388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:17.162899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.238302Z","time spent":"924.459874ms","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:17.16294Z","caller":"traceutil/trace.go:171","msg":"trace[440292435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"381.691635ms","start":"2026-05-27T13:47:16.781222Z","end":"2026-05-27T13:47:17.162914Z","steps":["trace[440292435] 'agreement among raft nodes before linearized reading' (duration: 381.52889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.162992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.781204Z","time spent":"381.773788ms","remote":"127.0.0.1:47422","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:47:17.163039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.808522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:17.163064Z","caller":"traceutil/trace.go:171","msg":"trace[1270772789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"138.861244ms","start":"2026-05-27T13:47:17.024194Z","end":"2026-05-27T13:47:17.163055Z","steps":["trace[1270772789] 'agreement among raft nodes before linearized reading' (duration: 138.830603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.162998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.559031ms","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-27T13:47:17.163188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.984364ms","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-27T13:47:17.163208Z","caller":"traceutil/trace.go:171","msg":"trace[1489967885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"381.022044ms","start":"2026-05-27T13:47:16.78218Z","end":"2026-05-27T13:47:17.163202Z","steps":["trace[1489967885] 'agreement among raft nodes before linearized reading' (duration: 380.986023ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:17.163204Z","caller":"traceutil/trace.go:171","msg":"trace[1718213967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"381.786488ms","start":"2026-05-27T13:47:16.781407Z","end":"2026-05-27T13:47:17.163194Z","steps":["trace[1718213967] 'agreement among raft nodes before linearized reading' (duration: 381.549531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.163225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.782173Z","time spent":"381.047695ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:47:17.163238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.7814Z","time spent":"381.828439ms","remote":"127.0.0.1:47422","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-27T13:47:17.163392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.413047ms","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:47:17.163471Z","caller":"traceutil/trace.go:171","msg":"trace[1508073359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"381.505889ms","start":"2026-05-27T13:47:16.781954Z","end":"2026-05-27T13:47:17.16346Z","steps":["trace[1508073359] 'agreement among raft nodes before linearized reading' (duration: 381.326344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.163501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.781946Z","time spent":"381.54785ms","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:47:17.162452Z","caller":"traceutil/trace.go:171","msg":"trace[1891382013] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"924.33755ms","start":"2026-05-27T13:47:16.238097Z","end":"2026-05-27T13:47:17.162434Z","steps":["trace[1891382013] 'process raft request' (duration: 924.200026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:17.165368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:16.238078Z","time spent":"927.093052ms","remote":"127.0.0.1:47250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:47:22.128438Z","caller":"traceutil/trace.go:171","msg":"trace[980824537] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"261.488239ms","start":"2026-05-27T13:47:21.866913Z","end":"2026-05-27T13:47:22.128401Z","steps":["trace[980824537] 'process raft request' (duration: 261.300583ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:22.135609Z","caller":"traceutil/trace.go:171","msg":"trace[295643929] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"205.362809ms","start":"2026-05-27T13:47:21.93022Z","end":"2026-05-27T13:47:22.135583Z","steps":["trace[295643929] 'process raft request' (duration: 205.156933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:33.087413Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239323584,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:47:33.587687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239323584,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:47:34.088455Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513018239323584,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:47:34.541766Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.976069268s","expected-duration":"1s"} {"level":"info","ts":"2026-05-27T13:47:34.542306Z","caller":"traceutil/trace.go:171","msg":"trace[343458904] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"1.976686444s","start":"2026-05-27T13:47:32.565586Z","end":"2026-05-27T13:47:34.542273Z","steps":["trace[343458904] 'process raft request' (duration: 1.976469848s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.54257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:32.56557Z","time spent":"1.97687897s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:34.549559Z","caller":"traceutil/trace.go:171","msg":"trace[998459213] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"885.765849ms","start":"2026-05-27T13:47:33.663757Z","end":"2026-05-27T13:47:34.549522Z","steps":["trace[998459213] 'process raft request' (duration: 885.388428ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:34.549568Z","caller":"traceutil/trace.go:171","msg":"trace[1200122778] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:831; }","duration":"1.96294709s","start":"2026-05-27T13:47:32.58648Z","end":"2026-05-27T13:47:34.549427Z","steps":["trace[1200122778] 'read index received' (duration: 1.955603034s)","trace[1200122778] 'applied index is now lower than readState.Index' (duration: 7.342806ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:34.549754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:33.663738Z","time spent":"885.917162ms","remote":"127.0.0.1:47322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:47:34.54982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.963307489s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:47:34.549858Z","caller":"traceutil/trace.go:171","msg":"trace[607426267] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:807; }","duration":"1.963372501s","start":"2026-05-27T13:47:32.586474Z","end":"2026-05-27T13:47:34.549846Z","steps":["trace[607426267] 'agreement among raft nodes before linearized reading' (duration: 1.963232787s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.549894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:32.58642Z","time spent":"1.963464874s","remote":"127.0.0.1:47250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:47:34.549898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.781532859s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fqbmx\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-27T13:47:34.549964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234341492s","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:47:34.549985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240020696s","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-27T13:47:34.550009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.140632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:34.550032Z","caller":"traceutil/trace.go:171","msg":"trace[880079105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:807; }","duration":"1.234426765s","start":"2026-05-27T13:47:33.315587Z","end":"2026-05-27T13:47:34.550013Z","steps":["trace[880079105] 'agreement among raft nodes before linearized reading' (duration: 1.23424892s)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:34.550044Z","caller":"traceutil/trace.go:171","msg":"trace[541546655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"525.212454ms","start":"2026-05-27T13:47:34.02482Z","end":"2026-05-27T13:47:34.550032Z","steps":["trace[541546655] 'agreement among raft nodes before linearized reading' (duration: 525.144072ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:34.550042Z","caller":"traceutil/trace.go:171","msg":"trace[656705956] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:807; }","duration":"1.240102427s","start":"2026-05-27T13:47:33.309921Z","end":"2026-05-27T13:47:34.550024Z","steps":["trace[656705956] 'agreement among raft nodes before linearized reading' (duration: 1.239963283s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.550081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:33.315582Z","time spent":"1.234486586s","remote":"127.0.0.1:47422","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:47:34.550109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:33.309904Z","time spent":"1.240176679s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:47:34.550138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:34.024791Z","time spent":"525.279166ms","remote":"127.0.0.1:47176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:47:34.549938Z","caller":"traceutil/trace.go:171","msg":"trace[103334015] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fqbmx; range_end:; response_count:1; response_revision:807; }","duration":"1.781607071s","start":"2026-05-27T13:47:32.768321Z","end":"2026-05-27T13:47:34.549928Z","steps":["trace[103334015] 'agreement among raft nodes before linearized reading' (duration: 1.781478758s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.550375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:32.768304Z","time spent":"1.782063483s","remote":"127.0.0.1:47338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fqbmx\" "} {"level":"warn","ts":"2026-05-27T13:47:34.550556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236389917s","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:47:34.550603Z","caller":"traceutil/trace.go:171","msg":"trace[1375066418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:807; }","duration":"1.236453509s","start":"2026-05-27T13:47:33.314139Z","end":"2026-05-27T13:47:34.550592Z","steps":["trace[1375066418] 'agreement among raft nodes before linearized reading' (duration: 1.23572488s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.550626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:33.314131Z","time spent":"1.23649113s","remote":"127.0.0.1:47422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:47:34.551137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23499006s","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:47:34.551651Z","caller":"traceutil/trace.go:171","msg":"trace[1605279384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:807; }","duration":"1.235424941s","start":"2026-05-27T13:47:33.31589Z","end":"2026-05-27T13:47:34.551315Z","steps":["trace[1605279384] 'agreement among raft nodes before linearized reading' (duration: 1.234126777s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:34.551704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:33.315869Z","time spent":"1.235821601s","remote":"127.0.0.1:47422","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-27T13:47:48.303459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.089322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:47:48.303541Z","caller":"traceutil/trace.go:171","msg":"trace[1318917002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"278.200185ms","start":"2026-05-27T13:47:48.025322Z","end":"2026-05-27T13:47:48.303522Z","steps":["trace[1318917002] 'range keys from in-memory index tree' (duration: 278.037261ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:31.080391Z","caller":"traceutil/trace.go:171","msg":"trace[246775494] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"281.184875ms","start":"2026-05-27T13:48:30.799189Z","end":"2026-05-27T13:48:31.080373Z","steps":["trace[246775494] 'read index received' (duration: 281.070623ms)","trace[246775494] 'applied index is now lower than readState.Index' (duration: 113.372µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:48:31.080452Z","caller":"traceutil/trace.go:171","msg":"trace[215982913] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"347.073766ms","start":"2026-05-27T13:48:30.733346Z","end":"2026-05-27T13:48:31.080419Z","steps":["trace[215982913] 'process raft request' (duration: 346.901733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:31.080602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:30.733333Z","time spent":"347.194148ms","remote":"127.0.0.1:47206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:48:31.08069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.996084ms","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:48:31.080729Z","caller":"traceutil/trace.go:171","msg":"trace[904954489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1122; }","duration":"261.090637ms","start":"2026-05-27T13:48:30.819628Z","end":"2026-05-27T13:48:31.080718Z","steps":["trace[904954489] 'agreement among raft nodes before linearized reading' (duration: 261.011576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:31.080608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.409781ms","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-27T13:48:31.080874Z","caller":"traceutil/trace.go:171","msg":"trace[167989973] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1122; }","duration":"281.720776ms","start":"2026-05-27T13:48:30.799142Z","end":"2026-05-27T13:48:31.080862Z","steps":["trace[167989973] 'agreement among raft nodes before linearized reading' (duration: 281.322798ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:31.080862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.715626ms","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-27T13:48:31.08092Z","caller":"traceutil/trace.go:171","msg":"trace[1062172440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1122; }","duration":"280.805398ms","start":"2026-05-27T13:48:30.800098Z","end":"2026-05-27T13:48:31.080903Z","steps":["trace[1062172440] 'agreement among raft nodes before linearized reading' (duration: 280.631964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:31.080609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.94698ms","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:48:31.080982Z","caller":"traceutil/trace.go:171","msg":"trace[863371754] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1122; }","duration":"281.361769ms","start":"2026-05-27T13:48:30.799609Z","end":"2026-05-27T13:48:31.080971Z","steps":["trace[863371754] 'agreement among raft nodes before linearized reading' (duration: 280.91239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:31.081135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.75224ms","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:48:31.08126Z","caller":"traceutil/trace.go:171","msg":"trace[754088942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1122; }","duration":"259.921083ms","start":"2026-05-27T13:48:30.821311Z","end":"2026-05-27T13:48:31.081232Z","steps":["trace[754088942] 'agreement among raft nodes before linearized reading' (duration: 259.527715ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:59.347942Z","caller":"traceutil/trace.go:171","msg":"trace[1572670156] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"110.844392ms","start":"2026-05-27T13:48:59.237026Z","end":"2026-05-27T13:48:59.347871Z","steps":["trace[1572670156] 'process raft request' (duration: 110.567477ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.728464Z","caller":"traceutil/trace.go:171","msg":"trace[951655020] linearizableReadLoop","detail":"{readStateIndex:1396; appliedIndex:1395; }","duration":"262.785465ms","start":"2026-05-27T13:49:27.465653Z","end":"2026-05-27T13:49:27.728439Z","steps":["trace[951655020] 'read index received' (duration: 262.658322ms)","trace[951655020] 'applied index is now lower than readState.Index' (duration: 125.993µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:49:27.728569Z","caller":"traceutil/trace.go:171","msg":"trace[798842810] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"292.231466ms","start":"2026-05-27T13:49:27.436312Z","end":"2026-05-27T13:49:27.728543Z","steps":["trace[798842810] 'process raft request' (duration: 291.953881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:27.728709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.031069ms","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-27T13:49:27.728749Z","caller":"traceutil/trace.go:171","msg":"trace[1351293953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"263.125581ms","start":"2026-05-27T13:49:27.465612Z","end":"2026-05-27T13:49:27.728738Z","steps":["trace[1351293953] 'agreement among raft nodes before linearized reading' (duration: 262.950598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:27.744633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.565081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-27T13:49:27.744677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.638466ms","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:49:27.744743Z","caller":"traceutil/trace.go:171","msg":"trace[1991021472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1345; }","duration":"256.740398ms","start":"2026-05-27T13:49:27.487989Z","end":"2026-05-27T13:49:27.744729Z","steps":["trace[1991021472] 'agreement among raft nodes before linearized reading' (duration: 256.586185ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.744692Z","caller":"traceutil/trace.go:171","msg":"trace[1639128453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1345; }","duration":"223.677484ms","start":"2026-05-27T13:49:27.521002Z","end":"2026-05-27T13:49:27.744679Z","steps":["trace[1639128453] 'agreement among raft nodes before linearized reading' (duration: 223.520261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:27.745148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.731371ms","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:49:27.7452Z","caller":"traceutil/trace.go:171","msg":"trace[1425855801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1345; }","duration":"216.805842ms","start":"2026-05-27T13:49:27.528385Z","end":"2026-05-27T13:49:27.745191Z","steps":["trace[1425855801] 'agreement among raft nodes before linearized reading' (duration: 216.12671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:27.745365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.11313ms","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-27T13:49:27.746483Z","caller":"traceutil/trace.go:171","msg":"trace[2141836853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1345; }","duration":"277.264231ms","start":"2026-05-27T13:49:27.469196Z","end":"2026-05-27T13:49:27.74646Z","steps":["trace[2141836853] 'agreement among raft nodes before linearized reading' (duration: 275.408748ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.878313Z","caller":"traceutil/trace.go:171","msg":"trace[327806447] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"129.474638ms","start":"2026-05-27T13:49:27.74881Z","end":"2026-05-27T13:49:27.878284Z","steps":["trace[327806447] 'process raft request' (duration: 129.261735ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.878623Z","caller":"traceutil/trace.go:171","msg":"trace[1800384974] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"129.747713ms","start":"2026-05-27T13:49:27.748859Z","end":"2026-05-27T13:49:27.878607Z","steps":["trace[1800384974] 'process raft request' (duration: 129.382597ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.878641Z","caller":"traceutil/trace.go:171","msg":"trace[59463483] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"129.405547ms","start":"2026-05-27T13:49:27.749209Z","end":"2026-05-27T13:49:27.878615Z","steps":["trace[59463483] 'process raft request' (duration: 129.261605ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.878712Z","caller":"traceutil/trace.go:171","msg":"trace[1488008275] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"128.242396ms","start":"2026-05-27T13:49:27.750443Z","end":"2026-05-27T13:49:27.878686Z","steps":["trace[1488008275] 'process raft request' (duration: 128.119404ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:27.878716Z","caller":"traceutil/trace.go:171","msg":"trace[1492793991] linearizableReadLoop","detail":"{readStateIndex:1402; appliedIndex:1398; }","duration":"121.412557ms","start":"2026-05-27T13:49:27.757278Z","end":"2026-05-27T13:49:27.878691Z","steps":["trace[1492793991] 'read index received' (duration: 120.729354ms)","trace[1492793991] 'applied index is now lower than readState.Index' (duration: 682.203µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:49:27.878909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.566959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:49:27.878954Z","caller":"traceutil/trace.go:171","msg":"trace[1496102769] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1350; }","duration":"121.687911ms","start":"2026-05-27T13:49:27.757256Z","end":"2026-05-27T13:49:27.878944Z","steps":["trace[1496102769] 'agreement among raft nodes before linearized reading' (duration: 121.508858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:45.963675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.77214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T13:49:45.963796Z","caller":"traceutil/trace.go:171","msg":"trace[273252759] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:1410; }","duration":"127.895383ms","start":"2026-05-27T13:49:45.835856Z","end":"2026-05-27T13:49:45.963751Z","steps":["trace[273252759] 'agreement among raft nodes before linearized reading' (duration: 79.607281ms)","trace[273252759] 'range keys from in-memory index tree' (duration: 48.15621ms)"],"step_count":2}