{"level":"warn","ts":"2026-08-14T09:15:59.128277Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T09:15:59.128431Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.84: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.84:2380","--initial-cluster=instance=https://199.19.213.84:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.84:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.84: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-08-14T09:15:59.128563Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-14T09:15:59.128586Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-08-14T09:15:59.128621Z","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-08-14T09:15:59.129938Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"]} {"level":"info","ts":"2026-08-14T09:15:59.130155Z","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.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.84: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-08-14T09:15:59.295737Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"165.030596ms"} {"level":"info","ts":"2026-08-14T09:15:59.596501Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f823adf772f78a4c","cluster-id":"b5473e4c769d66"} {"level":"info","ts":"2026-08-14T09:15:59.596665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T09:15:59.596732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 0"} {"level":"info","ts":"2026-08-14T09:15:59.596767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f823adf772f78a4c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T09:15:59.596826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became follower at term 1"} {"level":"info","ts":"2026-08-14T09:15:59.596918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"warn","ts":"2026-08-14T09:15:59.859665Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T09:15:59.87349Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T09:16:00.006365Z","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-08-14T09:16:00.018227Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f823adf772f78a4c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T09:16:00.019031Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f823adf772f78a4c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T09:16:00.019007Z","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-08-14T09:16:00.019318Z","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-08-14T09:16:00.019349Z","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-08-14T09:16:00.022574Z","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-08-14T09:16:00.022707Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-08-14T09:16:00.023522Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.84:2380"} {"level":"info","ts":"2026-08-14T09:16:00.023013Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T09:16:00.022955Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f823adf772f78a4c","initial-advertise-peer-urls":["https://199.19.213.84:2380"],"listen-peer-urls":["https://199.19.213.84:2380"],"advertise-client-urls":["https://199.19.213.84:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.84:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T09:16:00.025306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c switched to configuration voters=(17880326223888353868)"} {"level":"info","ts":"2026-08-14T09:16:00.025597Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","added-peer-id":"f823adf772f78a4c","added-peer-peer-urls":["https://199.19.213.84:2380"]} {"level":"info","ts":"2026-08-14T09:16:00.31733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T09:16:00.317386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T09:16:00.317441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgPreVoteResp from f823adf772f78a4c at term 1"} {"level":"info","ts":"2026-08-14T09:16:00.317468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became candidate at term 2"} {"level":"info","ts":"2026-08-14T09:16:00.317483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c received MsgVoteResp from f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-08-14T09:16:00.31751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f823adf772f78a4c became leader at term 2"} {"level":"info","ts":"2026-08-14T09:16:00.317533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f823adf772f78a4c elected leader f823adf772f78a4c at term 2"} {"level":"info","ts":"2026-08-14T09:16:00.347383Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f823adf772f78a4c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.84:2379]}","request-path":"/0/members/f823adf772f78a4c/attributes","cluster-id":"b5473e4c769d66","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T09:16:00.347429Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T09:16:00.347413Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:16:00.347493Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T09:16:00.3484Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T09:16:00.348461Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T09:16:00.349994Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b5473e4c769d66","local-member-id":"f823adf772f78a4c","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:16:00.350164Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:16:00.350252Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T09:16:00.350354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T09:16:00.352474Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.84:2379"} {"level":"warn","ts":"2026-08-14T09:16:18.250836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421016936,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:16:18.750995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421016936,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:16:18.900396Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.202344196s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:16:18.900904Z","caller":"traceutil/trace.go:171","msg":"trace[1956171418] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"1.202951548s","start":"2026-08-14T09:16:17.697918Z","end":"2026-08-14T09:16:18.90087Z","steps":["trace[1956171418] 'process raft request' (duration: 1.202736764s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:18.901738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:17.697884Z","time spent":"1.203165683s","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:19.826821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000039163s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-14T09:16:19.826935Z","caller":"traceutil/trace.go:171","msg":"trace[1793557307] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000196677s","start":"2026-08-14T09:16:17.826718Z","end":"2026-08-14T09:16:19.826915Z","steps":["trace[1793557307] 'agreement among raft nodes before linearized reading' (duration: 2.000067304s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:19.82698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:17.8267Z","time spent":"2.000270928s","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/14 09:16:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-14T09:16:20.130816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"863.725359ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-14T09:16:20.130931Z","caller":"traceutil/trace.go:171","msg":"trace[1998328553] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:387; }","duration":"2.38076589s","start":"2026-08-14T09:16:17.750145Z","end":"2026-08-14T09:16:20.130911Z","steps":["trace[1998328553] 'read index received' (duration: 1.150522174s)","trace[1998328553] 'applied index is now lower than readState.Index' (duration: 1.230242266s)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:20.131056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.380900174s","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-08-14T09:16:20.131094Z","caller":"traceutil/trace.go:171","msg":"trace[341476529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:374; }","duration":"2.380986486s","start":"2026-08-14T09:16:17.750098Z","end":"2026-08-14T09:16:20.131084Z","steps":["trace[341476529] 'agreement among raft nodes before linearized reading' (duration: 2.380899184s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:20.13113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:17.750077Z","time spent":"2.381044737s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:16:20.131286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.376869331s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T09:16:20.131392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226350827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-08-14T09:16:20.131398Z","caller":"traceutil/trace.go:171","msg":"trace[1114827421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:374; }","duration":"2.377017953s","start":"2026-08-14T09:16:17.75436Z","end":"2026-08-14T09:16:20.131378Z","steps":["trace[1114827421] 'agreement among raft nodes before linearized reading' (duration: 2.376684567s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:20.13144Z","caller":"traceutil/trace.go:171","msg":"trace[461183620] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:374; }","duration":"1.226460418s","start":"2026-08-14T09:16:18.904957Z","end":"2026-08-14T09:16:20.131417Z","steps":["trace[461183620] 'agreement among raft nodes before linearized reading' (duration: 1.226389337s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:20.131479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:18.904935Z","time spent":"1.22653818s","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5348,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-08-14T09:16:20.131545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.384656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:16:20.131634Z","caller":"traceutil/trace.go:171","msg":"trace[2002027459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:374; }","duration":"304.531319ms","start":"2026-08-14T09:16:19.827083Z","end":"2026-08-14T09:16:20.131614Z","steps":["trace[2002027459] 'agreement among raft nodes before linearized reading' (duration: 304.351646ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:20.131658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.052007396s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-14T09:16:20.131685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:19.827061Z","time spent":"304.615991ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:16:20.131706Z","caller":"traceutil/trace.go:171","msg":"trace[1078909412] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"2.052081737s","start":"2026-08-14T09:16:18.079612Z","end":"2026-08-14T09:16:20.131694Z","steps":["trace[1078909412] 'agreement among raft nodes before linearized reading' (duration: 2.051998275s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:20.131746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:18.079591Z","time spent":"2.052148389s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:16:20.131769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.230485978s","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-08-14T09:16:20.131814Z","caller":"traceutil/trace.go:171","msg":"trace[916868834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"2.23056486s","start":"2026-08-14T09:16:17.901239Z","end":"2026-08-14T09:16:20.131804Z","steps":["trace[916868834] 'agreement among raft nodes before linearized reading' (duration: 2.230495127s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:20.131583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:17.75435Z","time spent":"2.377218007s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:16:20.132806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:17.901218Z","time spent":"2.231572019s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:16:22.353298Z","caller":"traceutil/trace.go:171","msg":"trace[1974890141] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"152.911478ms","start":"2026-08-14T09:16:22.200363Z","end":"2026-08-14T09:16:22.353275Z","steps":["trace[1974890141] 'process raft request' (duration: 152.799426ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:22.384328Z","caller":"traceutil/trace.go:171","msg":"trace[1037945385] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"183.902341ms","start":"2026-08-14T09:16:22.2004Z","end":"2026-08-14T09:16:22.384302Z","steps":["trace[1037945385] 'process raft request' (duration: 183.729658ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:22.384636Z","caller":"traceutil/trace.go:171","msg":"trace[905278682] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"184.082346ms","start":"2026-08-14T09:16:22.20053Z","end":"2026-08-14T09:16:22.384612Z","steps":["trace[905278682] 'process raft request' (duration: 183.733268ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:22.384733Z","caller":"traceutil/trace.go:171","msg":"trace[1297311731] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"144.940755ms","start":"2026-08-14T09:16:22.239758Z","end":"2026-08-14T09:16:22.384699Z","steps":["trace[1297311731] 'process raft request' (duration: 144.782141ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.674469Z","caller":"traceutil/trace.go:171","msg":"trace[1342899074] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"103.761852ms","start":"2026-08-14T09:16:26.57063Z","end":"2026-08-14T09:16:26.674392Z","steps":["trace[1342899074] 'process raft request' (duration: 102.550448ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.860989Z","caller":"traceutil/trace.go:171","msg":"trace[101113867] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"289.43009ms","start":"2026-08-14T09:16:26.571537Z","end":"2026-08-14T09:16:26.860967Z","steps":["trace[101113867] 'process raft request' (duration: 289.371279ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.861218Z","caller":"traceutil/trace.go:171","msg":"trace[590165933] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"290.457212ms","start":"2026-08-14T09:16:26.570747Z","end":"2026-08-14T09:16:26.861205Z","steps":["trace[590165933] 'process raft request' (duration: 251.120088ms)","trace[590165933] 'compare' (duration: 38.741321ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:16:26.868819Z","caller":"traceutil/trace.go:171","msg":"trace[327233509] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"190.494977ms","start":"2026-08-14T09:16:26.678301Z","end":"2026-08-14T09:16:26.868796Z","steps":["trace[327233509] 'process raft request' (duration: 190.278023ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.868961Z","caller":"traceutil/trace.go:171","msg":"trace[181903985] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"188.003505ms","start":"2026-08-14T09:16:26.680921Z","end":"2026-08-14T09:16:26.868924Z","steps":["trace[181903985] 'process raft request' (duration: 187.778521ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.869004Z","caller":"traceutil/trace.go:171","msg":"trace[1413773658] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"187.788231ms","start":"2026-08-14T09:16:26.681152Z","end":"2026-08-14T09:16:26.86894Z","steps":["trace[1413773658] 'process raft request' (duration: 187.589567ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:26.86918Z","caller":"traceutil/trace.go:171","msg":"trace[931606464] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"190.219461ms","start":"2026-08-14T09:16:26.678538Z","end":"2026-08-14T09:16:26.868757Z","steps":["trace[931606464] 'process raft request' (duration: 190.125939ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.026385Z","caller":"traceutil/trace.go:171","msg":"trace[847222118] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"120.364992ms","start":"2026-08-14T09:16:26.905999Z","end":"2026-08-14T09:16:27.026364Z","steps":["trace[847222118] 'process raft request' (duration: 120.324201ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.026437Z","caller":"traceutil/trace.go:171","msg":"trace[1136374169] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:422; }","duration":"121.332152ms","start":"2026-08-14T09:16:26.905066Z","end":"2026-08-14T09:16:27.026398Z","steps":["trace[1136374169] 'read index received' (duration: 59.705632ms)","trace[1136374169] 'applied index is now lower than readState.Index' (duration: 61.62475ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:16:27.026457Z","caller":"traceutil/trace.go:171","msg":"trace[155312626] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"150.051889ms","start":"2026-08-14T09:16:26.876316Z","end":"2026-08-14T09:16:27.026368Z","steps":["trace[155312626] 'process raft request' (duration: 88.492589ms)","trace[155312626] 'compare' (duration: 61.414087ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:27.026584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.502266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-6qgvn\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-08-14T09:16:27.02662Z","caller":"traceutil/trace.go:171","msg":"trace[1628871780] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-6qgvn; range_end:; response_count:1; response_revision:408; }","duration":"121.586457ms","start":"2026-08-14T09:16:26.90502Z","end":"2026-08-14T09:16:27.026607Z","steps":["trace[1628871780] 'agreement among raft nodes before linearized reading' (duration: 121.498916ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:27.026659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.878152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-08-14T09:16:27.026726Z","caller":"traceutil/trace.go:171","msg":"trace[644021864] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:408; }","duration":"118.987053ms","start":"2026-08-14T09:16:26.907717Z","end":"2026-08-14T09:16:27.026704Z","steps":["trace[644021864] 'agreement among raft nodes before linearized reading' (duration: 118.83342ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.218886Z","caller":"traceutil/trace.go:171","msg":"trace[397500175] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"146.19607ms","start":"2026-08-14T09:16:27.072658Z","end":"2026-08-14T09:16:27.218854Z","steps":["trace[397500175] 'process raft request' (duration: 101.680379ms)","trace[397500175] 'compare' (duration: 44.232695ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:16:27.218989Z","caller":"traceutil/trace.go:171","msg":"trace[1207545492] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"144.679409ms","start":"2026-08-14T09:16:27.074283Z","end":"2026-08-14T09:16:27.218963Z","steps":["trace[1207545492] 'process raft request' (duration: 144.642738ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.219194Z","caller":"traceutil/trace.go:171","msg":"trace[528137378] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"146.506886ms","start":"2026-08-14T09:16:27.072676Z","end":"2026-08-14T09:16:27.219183Z","steps":["trace[528137378] 'process raft request' (duration: 146.061737ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.219329Z","caller":"traceutil/trace.go:171","msg":"trace[1045558766] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"146.576199ms","start":"2026-08-14T09:16:27.072744Z","end":"2026-08-14T09:16:27.21932Z","steps":["trace[1045558766] 'process raft request' (duration: 146.061098ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.219437Z","caller":"traceutil/trace.go:171","msg":"trace[2057107177] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"145.738241ms","start":"2026-08-14T09:16:27.073691Z","end":"2026-08-14T09:16:27.219429Z","steps":["trace[2057107177] 'process raft request' (duration: 145.200359ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:27.219535Z","caller":"traceutil/trace.go:171","msg":"trace[2117077332] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"145.955246ms","start":"2026-08-14T09:16:27.073568Z","end":"2026-08-14T09:16:27.219523Z","steps":["trace[2117077332] 'process raft request' (duration: 145.273991ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.275872Z","caller":"traceutil/trace.go:171","msg":"trace[2058758398] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"570.396838ms","start":"2026-08-14T09:16:39.705442Z","end":"2026-08-14T09:16:40.275839Z","steps":["trace[2058758398] 'process raft request' (duration: 570.248265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.276136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.705422Z","time spent":"570.53428ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.284754Z","caller":"traceutil/trace.go:171","msg":"trace[2116060921] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"565.570428ms","start":"2026-08-14T09:16:39.719139Z","end":"2026-08-14T09:16:40.284709Z","steps":["trace[2116060921] 'process raft request' (duration: 565.344204ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.284808Z","caller":"traceutil/trace.go:171","msg":"trace[187967811] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"552.73542ms","start":"2026-08-14T09:16:39.732051Z","end":"2026-08-14T09:16:40.284787Z","steps":["trace[187967811] 'process raft request' (duration: 552.520716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.284854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.135109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:16:40.28488Z","caller":"traceutil/trace.go:171","msg":"trace[631246556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"458.210001ms","start":"2026-08-14T09:16:39.826663Z","end":"2026-08-14T09:16:40.284873Z","steps":["trace[631246556] 'agreement among raft nodes before linearized reading' (duration: 458.14708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.2849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.826642Z","time spent":"458.253611ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:16:40.284903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.732045Z","time spent":"552.809911ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.284923Z","caller":"traceutil/trace.go:171","msg":"trace[1733739028] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"562.178985ms","start":"2026-08-14T09:16:39.72268Z","end":"2026-08-14T09:16:40.284859Z","steps":["trace[1733739028] 'process raft request' (duration: 561.834498ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.284997Z","caller":"traceutil/trace.go:171","msg":"trace[698163712] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"505.17837ms","start":"2026-08-14T09:16:39.77977Z","end":"2026-08-14T09:16:40.284948Z","steps":["trace[698163712] 'process raft request' (duration: 504.875855ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.285061Z","caller":"traceutil/trace.go:171","msg":"trace[935114598] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"558.583969ms","start":"2026-08-14T09:16:39.726408Z","end":"2026-08-14T09:16:40.284992Z","steps":["trace[935114598] 'process raft request' (duration: 558.134511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.285085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.722673Z","time spent":"562.337577ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.285096Z","caller":"traceutil/trace.go:171","msg":"trace[448112194] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"578.065269ms","start":"2026-08-14T09:16:39.707003Z","end":"2026-08-14T09:16:40.285068Z","steps":["trace[448112194] 'process raft request' (duration: 577.392257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.285157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.779743Z","time spent":"505.341154ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.285164Z","caller":"traceutil/trace.go:171","msg":"trace[575687970] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"379.250599ms","start":"2026-08-14T09:16:39.905905Z","end":"2026-08-14T09:16:40.285155Z","steps":["trace[575687970] 'process raft request' (duration: 378.789301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.285227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.90587Z","time spent":"379.33316ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.285231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.706993Z","time spent":"578.152811ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.285308Z","caller":"traceutil/trace.go:171","msg":"trace[1460071676] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"544.682572ms","start":"2026-08-14T09:16:39.740605Z","end":"2026-08-14T09:16:40.285288Z","steps":["trace[1460071676] 'process raft request' (duration: 544.004619ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.285335Z","caller":"traceutil/trace.go:171","msg":"trace[1707561942] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"578.442787ms","start":"2026-08-14T09:16:39.706884Z","end":"2026-08-14T09:16:40.285327Z","steps":["trace[1707561942] 'process raft request' (duration: 577.443058ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.285342Z","caller":"traceutil/trace.go:171","msg":"trace[1234195597] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"566.311942ms","start":"2026-08-14T09:16:39.719023Z","end":"2026-08-14T09:16:40.285334Z","steps":["trace[1234195597] 'process raft request' (duration: 565.399045ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.285363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.740585Z","time spent":"544.755213ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.285378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.719012Z","time spent":"566.348502ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.285193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.726385Z","time spent":"558.723981ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.285373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.706799Z","time spent":"578.556439ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.285459Z","caller":"traceutil/trace.go:171","msg":"trace[998104949] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"566.347523ms","start":"2026-08-14T09:16:39.719093Z","end":"2026-08-14T09:16:40.285441Z","steps":["trace[998104949] 'process raft request' (duration: 565.363384ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.284787Z","caller":"traceutil/trace.go:171","msg":"trace[1803064337] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:508; }","duration":"458.049628ms","start":"2026-08-14T09:16:39.826727Z","end":"2026-08-14T09:16:40.284777Z","steps":["trace[1803064337] 'read index received' (duration: 449.106493ms)","trace[1803064337] 'applied index is now lower than readState.Index' (duration: 8.942565ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:40.285526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.71909Z","time spent":"566.409154ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.28531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:39.719135Z","time spent":"565.70234ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:16:40.671568Z","caller":"traceutil/trace.go:171","msg":"trace[984865186] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"341.151943ms","start":"2026-08-14T09:16:40.33039Z","end":"2026-08-14T09:16:40.671542Z","steps":["trace[984865186] 'process raft request' (duration: 336.312624ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.671752Z","caller":"traceutil/trace.go:171","msg":"trace[281751827] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"337.745292ms","start":"2026-08-14T09:16:40.333985Z","end":"2026-08-14T09:16:40.67173Z","steps":["trace[281751827] 'process raft request' (duration: 337.600118ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.671762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.330375Z","time spent":"341.266045ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:40.671866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.333957Z","time spent":"337.846263ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:40.671872Z","caller":"traceutil/trace.go:171","msg":"trace[2037048034] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"337.776912ms","start":"2026-08-14T09:16:40.334068Z","end":"2026-08-14T09:16:40.671845Z","steps":["trace[2037048034] 'process raft request' (duration: 337.623688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.671974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.33406Z","time spent":"337.860134ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:40.672045Z","caller":"traceutil/trace.go:171","msg":"trace[1236612742] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"337.832003ms","start":"2026-08-14T09:16:40.334203Z","end":"2026-08-14T09:16:40.672035Z","steps":["trace[1236612742] 'process raft request' (duration: 337.729631ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.672031Z","caller":"traceutil/trace.go:171","msg":"trace[963243114] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"337.940095ms","start":"2026-08-14T09:16:40.334066Z","end":"2026-08-14T09:16:40.672006Z","steps":["trace[963243114] 'process raft request' (duration: 337.724081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.672083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.334196Z","time spent":"337.865314ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:40.672164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.334044Z","time spent":"338.051357ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:40.672186Z","caller":"traceutil/trace.go:171","msg":"trace[1860348185] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"337.936665ms","start":"2026-08-14T09:16:40.334221Z","end":"2026-08-14T09:16:40.672158Z","steps":["trace[1860348185] 'process raft request' (duration: 337.772942ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.672219Z","caller":"traceutil/trace.go:171","msg":"trace[564770523] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"325.374333ms","start":"2026-08-14T09:16:40.346833Z","end":"2026-08-14T09:16:40.672207Z","steps":["trace[564770523] 'process raft request' (duration: 325.253411ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.672233Z","caller":"traceutil/trace.go:171","msg":"trace[1144210775] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"313.553263ms","start":"2026-08-14T09:16:40.358672Z","end":"2026-08-14T09:16:40.672225Z","steps":["trace[1144210775] 'process raft request' (duration: 313.483212ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.672214Z","caller":"traceutil/trace.go:171","msg":"trace[1684595012] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:529; }","duration":"136.101939ms","start":"2026-08-14T09:16:40.536088Z","end":"2026-08-14T09:16:40.67219Z","steps":["trace[1684595012] 'read index received' (duration: 130.519295ms)","trace[1684595012] 'applied index is now lower than readState.Index' (duration: 5.581784ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:40.672261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.334215Z","time spent":"338.008566ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:40.672271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.358646Z","time spent":"313.608074ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:40.672272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:40.346794Z","time spent":"325.453094ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:40.672357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.225862ms","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-08-14T09:16:40.672367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.756958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:16:40.672382Z","caller":"traceutil/trace.go:171","msg":"trace[1656266022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"109.276403ms","start":"2026-08-14T09:16:40.563099Z","end":"2026-08-14T09:16:40.672375Z","steps":["trace[1656266022] 'agreement among raft nodes before linearized reading' (duration: 109.228212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:40.67238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.269322ms","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-08-14T09:16:40.672401Z","caller":"traceutil/trace.go:171","msg":"trace[196258361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:514; }","duration":"132.824398ms","start":"2026-08-14T09:16:40.539565Z","end":"2026-08-14T09:16:40.67239Z","steps":["trace[196258361] 'agreement among raft nodes before linearized reading' (duration: 132.754877ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:40.672451Z","caller":"traceutil/trace.go:171","msg":"trace[1385533765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:514; }","duration":"136.367923ms","start":"2026-08-14T09:16:40.536054Z","end":"2026-08-14T09:16:40.672422Z","steps":["trace[1385533765] 'agreement among raft nodes before linearized reading' (duration: 136.238681ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:46.105188Z","caller":"traceutil/trace.go:171","msg":"trace[1229008474] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"314.96426ms","start":"2026-08-14T09:16:45.790203Z","end":"2026-08-14T09:16:46.105167Z","steps":["trace[1229008474] 'process raft request' (duration: 314.922429ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:46.105242Z","caller":"traceutil/trace.go:171","msg":"trace[1974424512] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"375.054492ms","start":"2026-08-14T09:16:45.730151Z","end":"2026-08-14T09:16:46.105206Z","steps":["trace[1974424512] 'process raft request' (duration: 374.233847ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:46.105312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:45.790179Z","time spent":"315.072681ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:46.105402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:45.730123Z","time spent":"375.192004ms","remote":"127.0.0.1:38812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:46.579258Z","caller":"traceutil/trace.go:171","msg":"trace[1552598878] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"209.501707ms","start":"2026-08-14T09:16:46.369729Z","end":"2026-08-14T09:16:46.579231Z","steps":["trace[1552598878] 'process raft request' (duration: 209.345845ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:46.742548Z","caller":"traceutil/trace.go:171","msg":"trace[2090693075] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"156.369783ms","start":"2026-08-14T09:16:46.586151Z","end":"2026-08-14T09:16:46.74252Z","steps":["trace[2090693075] 'process raft request' (duration: 155.476327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:47.321202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.9917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:16:47.32133Z","caller":"traceutil/trace.go:171","msg":"trace[1845085825] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"574.86631ms","start":"2026-08-14T09:16:46.746444Z","end":"2026-08-14T09:16:47.321311Z","steps":["trace[1845085825] 'process raft request' (duration: 44.684367ms)","trace[1845085825] 'compare' (duration: 529.777955ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:47.321389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.746399Z","time spent":"574.962002ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:16:47.326855Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421017347,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:16:47.39386Z","caller":"traceutil/trace.go:171","msg":"trace[1245114172] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"644.52148ms","start":"2026-08-14T09:16:46.749311Z","end":"2026-08-14T09:16:47.393833Z","steps":["trace[1245114172] 'process raft request' (duration: 644.482269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:47.39415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.749297Z","time spent":"644.632942ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:47.394229Z","caller":"traceutil/trace.go:171","msg":"trace[361259812] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"647.258779ms","start":"2026-08-14T09:16:46.746932Z","end":"2026-08-14T09:16:47.394191Z","steps":["trace[361259812] 'process raft request' (duration: 646.698678ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:47.394368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.746911Z","time spent":"647.388332ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:47.394509Z","caller":"traceutil/trace.go:171","msg":"trace[1974141960] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"647.047586ms","start":"2026-08-14T09:16:46.747443Z","end":"2026-08-14T09:16:47.394491Z","steps":["trace[1974141960] 'process raft request' (duration: 646.308062ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:47.394678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.747435Z","time spent":"647.144247ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:47.411118Z","caller":"traceutil/trace.go:171","msg":"trace[1385430597] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:622; }","duration":"585.275143ms","start":"2026-08-14T09:16:46.825818Z","end":"2026-08-14T09:16:47.411093Z","steps":["trace[1385430597] 'read index received' (duration: 567.87869ms)","trace[1385430597] 'applied index is now lower than readState.Index' (duration: 17.395323ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:47.411287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.449446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:16:47.411331Z","caller":"traceutil/trace.go:171","msg":"trace[1445225699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"585.545657ms","start":"2026-08-14T09:16:46.825772Z","end":"2026-08-14T09:16:47.411318Z","steps":["trace[1445225699] 'agreement among raft nodes before linearized reading' (duration: 585.429585ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:47.411283Z","caller":"traceutil/trace.go:171","msg":"trace[2127841722] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"614.641257ms","start":"2026-08-14T09:16:46.796605Z","end":"2026-08-14T09:16:47.411246Z","steps":["trace[2127841722] 'process raft request' (duration: 614.379542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:47.411374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.825754Z","time spent":"585.611979ms","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:16:47.411459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:46.796583Z","time spent":"614.802189ms","remote":"127.0.0.1:39258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:16:49.328478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421017356,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:16:49.479093Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.609393228s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:16:49.479924Z","caller":"traceutil/trace.go:171","msg":"trace[443409122] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.614117864s","start":"2026-08-14T09:16:47.865754Z","end":"2026-08-14T09:16:49.479872Z","steps":["trace[443409122] 'process raft request' (duration: 1.613680256s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:49.480044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:47.865703Z","time spent":"1.614276878s","remote":"127.0.0.1:38812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:16:49.512468Z","caller":"traceutil/trace.go:171","msg":"trace[1953244336] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"685.075821ms","start":"2026-08-14T09:16:48.827364Z","end":"2026-08-14T09:16:49.51244Z","steps":["trace[1953244336] 'read index received' (duration: 651.943767ms)","trace[1953244336] 'applied index is now lower than readState.Index' (duration: 33.130714ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:16:49.512793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.400046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:16:49.512838Z","caller":"traceutil/trace.go:171","msg":"trace[1105619710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:602; }","duration":"685.515249ms","start":"2026-08-14T09:16:48.827311Z","end":"2026-08-14T09:16:49.512827Z","steps":["trace[1105619710] 'agreement among raft nodes before linearized reading' (duration: 685.283015ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:49.513059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.336725ms","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-08-14T09:16:49.513059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.637162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:16:49.513112Z","caller":"traceutil/trace.go:171","msg":"trace[66836754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"115.444267ms","start":"2026-08-14T09:16:49.397653Z","end":"2026-08-14T09:16:49.513097Z","steps":["trace[66836754] 'agreement among raft nodes before linearized reading' (duration: 115.308894ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:49.51312Z","caller":"traceutil/trace.go:171","msg":"trace[44184502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"114.723584ms","start":"2026-08-14T09:16:49.398382Z","end":"2026-08-14T09:16:49.513105Z","steps":["trace[44184502] 'agreement among raft nodes before linearized reading' (duration: 114.53246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:49.513201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.473709ms","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-08-14T09:16:49.513171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:16:48.827288Z","time spent":"685.710052ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:16:49.513309Z","caller":"traceutil/trace.go:171","msg":"trace[1618719444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"114.606372ms","start":"2026-08-14T09:16:49.398661Z","end":"2026-08-14T09:16:49.513268Z","steps":["trace[1618719444] 'agreement among raft nodes before linearized reading' (duration: 114.298566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:16:49.513501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.915188ms","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-08-14T09:16:49.513663Z","caller":"traceutil/trace.go:171","msg":"trace[414118243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:602; }","duration":"188.113363ms","start":"2026-08-14T09:16:49.325541Z","end":"2026-08-14T09:16:49.513654Z","steps":["trace[414118243] 'agreement among raft nodes before linearized reading' (duration: 187.352008ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:16:54.696227Z","caller":"traceutil/trace.go:171","msg":"trace[626033025] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"154.427528ms","start":"2026-08-14T09:16:54.541766Z","end":"2026-08-14T09:16:54.696194Z","steps":["trace[626033025] 'process raft request' (duration: 153.846417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:05.993031Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421017676,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:17:06.136898Z","caller":"traceutil/trace.go:171","msg":"trace[1116996007] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"956.578854ms","start":"2026-08-14T09:17:05.180074Z","end":"2026-08-14T09:17:06.136653Z","steps":["trace[1116996007] 'process raft request' (duration: 956.32943ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.137161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.180058Z","time spent":"956.954422ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:06.139384Z","caller":"traceutil/trace.go:171","msg":"trace[1899572280] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:797; }","duration":"646.545386ms","start":"2026-08-14T09:17:05.492806Z","end":"2026-08-14T09:17:06.139352Z","steps":["trace[1899572280] 'read index received' (duration: 643.567521ms)","trace[1899572280] 'applied index is now lower than readState.Index' (duration: 2.976505ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:17:06.139499Z","caller":"traceutil/trace.go:171","msg":"trace[1968512594] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"664.776374ms","start":"2026-08-14T09:17:05.474709Z","end":"2026-08-14T09:17:06.139485Z","steps":["trace[1968512594] 'process raft request' (duration: 664.54735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.139669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.830361ms","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-08-14T09:17:06.139709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.474679Z","time spent":"664.922487ms","remote":"127.0.0.1:38956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:06.139727Z","caller":"traceutil/trace.go:171","msg":"trace[1384065681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:768; }","duration":"553.929102ms","start":"2026-08-14T09:17:05.585784Z","end":"2026-08-14T09:17:06.139713Z","steps":["trace[1384065681] 'agreement among raft nodes before linearized reading' (duration: 553.760039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.139763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.585764Z","time spent":"553.991914ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:17:06.139768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.111219ms","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-08-14T09:17:06.139853Z","caller":"traceutil/trace.go:171","msg":"trace[590581933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"545.222471ms","start":"2026-08-14T09:17:05.594605Z","end":"2026-08-14T09:17:06.139827Z","steps":["trace[590581933] 'agreement among raft nodes before linearized reading' (duration: 544.983787ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.139899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.594592Z","time spent":"545.297482ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:17:06.139898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.051436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:17:06.13999Z","caller":"traceutil/trace.go:171","msg":"trace[234773959] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:768; }","duration":"647.202008ms","start":"2026-08-14T09:17:05.492767Z","end":"2026-08-14T09:17:06.139969Z","steps":["trace[234773959] 'agreement among raft nodes before linearized reading' (duration: 646.998455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.14003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.444612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:17:06.140057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.49275Z","time spent":"647.284179ms","remote":"127.0.0.1:38774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:17:06.140064Z","caller":"traceutil/trace.go:171","msg":"trace[643812240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"312.514684ms","start":"2026-08-14T09:17:05.827538Z","end":"2026-08-14T09:17:06.140053Z","steps":["trace[643812240] 'agreement among raft nodes before linearized reading' (duration: 312.468183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.140094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.827509Z","time spent":"312.580305ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:17:06.140664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.711787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:17:06.140722Z","caller":"traceutil/trace.go:171","msg":"trace[109192994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"548.625014ms","start":"2026-08-14T09:17:05.59208Z","end":"2026-08-14T09:17:06.140705Z","steps":["trace[109192994] 'agreement among raft nodes before linearized reading' (duration: 547.641666ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.140764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.592061Z","time spent":"548.690325ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:17:06.140825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.809936ms","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-08-14T09:17:06.140885Z","caller":"traceutil/trace.go:171","msg":"trace[192367077] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:768; }","duration":"549.894717ms","start":"2026-08-14T09:17:05.590977Z","end":"2026-08-14T09:17:06.140872Z","steps":["trace[192367077] 'agreement among raft nodes before linearized reading' (duration: 548.856748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:06.140922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:05.590964Z","time spent":"549.950719ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:17:20.637164Z","caller":"traceutil/trace.go:171","msg":"trace[676176344] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"708.427702ms","start":"2026-08-14T09:17:19.928715Z","end":"2026-08-14T09:17:20.637143Z","steps":["trace[676176344] 'process raft request' (duration: 708.262388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.637291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:19.9287Z","time spent":"708.531814ms","remote":"127.0.0.1:38908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:20.637437Z","caller":"traceutil/trace.go:171","msg":"trace[519720467] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:932; }","duration":"439.596096ms","start":"2026-08-14T09:17:20.197833Z","end":"2026-08-14T09:17:20.63743Z","steps":["trace[519720467] 'read index received' (duration: 439.583406ms)","trace[519720467] 'applied index is now lower than readState.Index' (duration: 11.87µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:17:20.637598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.728899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-14T09:17:20.637624Z","caller":"traceutil/trace.go:171","msg":"trace[500259203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:898; }","duration":"439.819691ms","start":"2026-08-14T09:17:20.197798Z","end":"2026-08-14T09:17:20.637618Z","steps":["trace[500259203] 'agreement among raft nodes before linearized reading' (duration: 439.664638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.63764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.197783Z","time spent":"439.853651ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-14T09:17:20.763971Z","caller":"traceutil/trace.go:171","msg":"trace[1945987743] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"126.498ms","start":"2026-08-14T09:17:20.637452Z","end":"2026-08-14T09:17:20.76395Z","steps":["trace[1945987743] 'read index received' (duration: 118.439661ms)","trace[1945987743] 'applied index is now lower than readState.Index' (duration: 8.057489ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:17:20.764155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.481654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:17:20.76415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.994451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-14T09:17:20.764199Z","caller":"traceutil/trace.go:171","msg":"trace[1560331627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:899; }","duration":"553.572665ms","start":"2026-08-14T09:17:20.210614Z","end":"2026-08-14T09:17:20.764187Z","steps":["trace[1560331627] 'agreement among raft nodes before linearized reading' (duration: 553.416292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.764183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.097743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T09:17:20.764227Z","caller":"traceutil/trace.go:171","msg":"trace[1102500861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:899; }","duration":"549.136363ms","start":"2026-08-14T09:17:20.215074Z","end":"2026-08-14T09:17:20.76421Z","steps":["trace[1102500861] 'agreement among raft nodes before linearized reading' (duration: 548.886269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.76423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.210602Z","time spent":"553.620296ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:17:20.76425Z","caller":"traceutil/trace.go:171","msg":"trace[405248655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:899; }","duration":"549.193675ms","start":"2026-08-14T09:17:20.215041Z","end":"2026-08-14T09:17:20.764235Z","steps":["trace[405248655] 'agreement among raft nodes before linearized reading' (duration: 548.94882ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.764293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.215035Z","time spent":"549.247705ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:17:20.764317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.432439ms","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-08-14T09:17:20.76434Z","caller":"traceutil/trace.go:171","msg":"trace[1178151181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:899; }","duration":"549.471089ms","start":"2026-08-14T09:17:20.214864Z","end":"2026-08-14T09:17:20.764335Z","steps":["trace[1178151181] 'agreement among raft nodes before linearized reading' (duration: 549.412408ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:20.764307Z","caller":"traceutil/trace.go:171","msg":"trace[1949512755] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"199.934339ms","start":"2026-08-14T09:17:20.56435Z","end":"2026-08-14T09:17:20.764284Z","steps":["trace[1949512755] 'process raft request' (duration: 191.359691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:20.764258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.215068Z","time spent":"549.183394ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:17:20.76436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.214854Z","time spent":"549.50273ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:17:21.580174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.978933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:17:21.580383Z","caller":"traceutil/trace.go:171","msg":"trace[1772903054] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"938.290436ms","start":"2026-08-14T09:17:20.642061Z","end":"2026-08-14T09:17:21.580351Z","steps":["trace[1772903054] 'process raft request' (duration: 364.050278ms)","trace[1772903054] 'compare' (duration: 573.872011ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:17:21.580445Z","caller":"traceutil/trace.go:171","msg":"trace[1501221125] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"936.119115ms","start":"2026-08-14T09:17:20.644305Z","end":"2026-08-14T09:17:21.580425Z","steps":["trace[1501221125] 'process raft request' (duration: 936.069374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.580585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.644293Z","time spent":"936.189067ms","remote":"127.0.0.1:39220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5192,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:21.580624Z","caller":"traceutil/trace.go:171","msg":"trace[483309487] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"937.750605ms","start":"2026-08-14T09:17:20.642848Z","end":"2026-08-14T09:17:21.580598Z","steps":["trace[483309487] 'process raft request' (duration: 937.42595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.580644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.642034Z","time spent":"938.411989ms","remote":"127.0.0.1:39008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1628,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:21.580703Z","caller":"traceutil/trace.go:171","msg":"trace[1587481465] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"936.894521ms","start":"2026-08-14T09:17:20.643796Z","end":"2026-08-14T09:17:21.58069Z","steps":["trace[1587481465] 'process raft request' (duration: 936.535625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.58074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.642829Z","time spent":"937.845808ms","remote":"127.0.0.1:38882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:21.58077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.643786Z","time spent":"936.948122ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:21.862182Z","caller":"traceutil/trace.go:171","msg":"trace[1578536620] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"1.094764782s","start":"2026-08-14T09:17:20.767377Z","end":"2026-08-14T09:17:21.862141Z","steps":["trace[1578536620] 'process raft request' (duration: 1.083556385s)","trace[1578536620] 'compare' (duration: 11.021074ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:17:21.86221Z","caller":"traceutil/trace.go:171","msg":"trace[2020711395] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"1.093824975s","start":"2026-08-14T09:17:20.768361Z","end":"2026-08-14T09:17:21.862186Z","steps":["trace[2020711395] 'process raft request' (duration: 1.093688843s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:21.862199Z","caller":"traceutil/trace.go:171","msg":"trace[631581380] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"1.093751934s","start":"2026-08-14T09:17:20.768426Z","end":"2026-08-14T09:17:21.862178Z","steps":["trace[631581380] 'process raft request' (duration: 1.093702233s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:21.862288Z","caller":"traceutil/trace.go:171","msg":"trace[1726300008] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:933; }","duration":"1.034585209s","start":"2026-08-14T09:17:20.827691Z","end":"2026-08-14T09:17:21.862276Z","steps":["trace[1726300008] 'read index received' (duration: 178.403261ms)","trace[1726300008] 'applied index is now lower than readState.Index' (duration: 856.181058ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:17:21.862309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.767362Z","time spent":"1.094884965s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:21.862308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.768343Z","time spent":"1.093916187s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:21.862343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.768418Z","time spent":"1.093854726s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:21.862379Z","caller":"traceutil/trace.go:171","msg":"trace[1104399902] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"1.090437932s","start":"2026-08-14T09:17:20.771933Z","end":"2026-08-14T09:17:21.862371Z","steps":["trace[1104399902] 'process raft request' (duration: 1.090222377s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.862349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03465353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:17:21.862414Z","caller":"traceutil/trace.go:171","msg":"trace[1520992739] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"1.067824845s","start":"2026-08-14T09:17:20.794577Z","end":"2026-08-14T09:17:21.862402Z","steps":["trace[1520992739] 'process raft request' (duration: 1.067637551s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.862451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.771921Z","time spent":"1.090477873s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:21.862464Z","caller":"traceutil/trace.go:171","msg":"trace[463858623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:908; }","duration":"1.034789593s","start":"2026-08-14T09:17:20.827656Z","end":"2026-08-14T09:17:21.862446Z","steps":["trace[463858623] 'agreement among raft nodes before linearized reading' (duration: 1.03466482s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.862477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.79455Z","time spent":"1.067905026s","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:17:21.862513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:20.827639Z","time spent":"1.034861024s","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:17:21.946978Z","caller":"traceutil/trace.go:171","msg":"trace[1074872986] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"358.318222ms","start":"2026-08-14T09:17:21.588634Z","end":"2026-08-14T09:17:21.946952Z","steps":["trace[1074872986] 'process raft request' (duration: 358.20006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:21.947113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:21.588612Z","time spent":"358.430264ms","remote":"127.0.0.1:39192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5626,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:31.812411Z","caller":"traceutil/trace.go:171","msg":"trace[31809118] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"193.167975ms","start":"2026-08-14T09:17:31.619216Z","end":"2026-08-14T09:17:31.812384Z","steps":["trace[31809118] 'process raft request' (duration: 193.021183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:32.065065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.702915ms","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-08-14T09:17:32.065136Z","caller":"traceutil/trace.go:171","msg":"trace[1869157597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"160.798686ms","start":"2026-08-14T09:17:31.904319Z","end":"2026-08-14T09:17:32.065117Z","steps":["trace[1869157597] 'range keys from in-memory index tree' (duration: 160.582711ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:32.065134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.515346ms","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-08-14T09:17:32.065213Z","caller":"traceutil/trace.go:171","msg":"trace[905453452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:943; }","duration":"163.646199ms","start":"2026-08-14T09:17:31.901545Z","end":"2026-08-14T09:17:32.065191Z","steps":["trace[905453452] 'range keys from in-memory index tree' (duration: 163.331313ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:32.065183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.694506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T09:17:32.065245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.102859ms","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-08-14T09:17:32.065297Z","caller":"traceutil/trace.go:171","msg":"trace[282603508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:943; }","duration":"159.826418ms","start":"2026-08-14T09:17:31.905445Z","end":"2026-08-14T09:17:32.065271Z","steps":["trace[282603508] 'range keys from in-memory index tree' (duration: 159.558083ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:32.0653Z","caller":"traceutil/trace.go:171","msg":"trace[382840030] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:943; }","duration":"163.17238ms","start":"2026-08-14T09:17:31.90211Z","end":"2026-08-14T09:17:32.065283Z","steps":["trace[382840030] 'range keys from in-memory index tree' (duration: 162.947026ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:32.197303Z","caller":"traceutil/trace.go:171","msg":"trace[118944886] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"128.360646ms","start":"2026-08-14T09:17:32.068919Z","end":"2026-08-14T09:17:32.197279Z","steps":["trace[118944886] 'process raft request' (duration: 128.101762ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:32.209717Z","caller":"traceutil/trace.go:171","msg":"trace[1482007303] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"140.235615ms","start":"2026-08-14T09:17:32.069459Z","end":"2026-08-14T09:17:32.209695Z","steps":["trace[1482007303] 'process raft request' (duration: 140.071892ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:32.20983Z","caller":"traceutil/trace.go:171","msg":"trace[1470744499] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"140.208805ms","start":"2026-08-14T09:17:32.069614Z","end":"2026-08-14T09:17:32.209822Z","steps":["trace[1470744499] 'process raft request' (duration: 140.000481ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:32.209861Z","caller":"traceutil/trace.go:171","msg":"trace[1866247287] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"140.278006ms","start":"2026-08-14T09:17:32.069548Z","end":"2026-08-14T09:17:32.209826Z","steps":["trace[1866247287] 'process raft request' (duration: 140.045502ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:33.36468Z","caller":"traceutil/trace.go:171","msg":"trace[1031884714] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:983; }","duration":"133.598703ms","start":"2026-08-14T09:17:33.231061Z","end":"2026-08-14T09:17:33.36466Z","steps":["trace[1031884714] 'read index received' (duration: 133.533272ms)","trace[1031884714] 'applied index is now lower than readState.Index' (duration: 64.711µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:17:33.364845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.767997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.84\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-14T09:17:33.364881Z","caller":"traceutil/trace.go:171","msg":"trace[162350382] range","detail":"{range_begin:/registry/masterleases/199.19.213.84; range_end:; response_count:1; response_revision:948; }","duration":"133.850478ms","start":"2026-08-14T09:17:33.231021Z","end":"2026-08-14T09:17:33.364872Z","steps":["trace[162350382] 'agreement among raft nodes before linearized reading' (duration: 133.714655ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:33.365003Z","caller":"traceutil/trace.go:171","msg":"trace[206994942] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"531.000327ms","start":"2026-08-14T09:17:32.833973Z","end":"2026-08-14T09:17:33.364973Z","steps":["trace[206994942] 'process raft request' (duration: 530.5665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:33.365156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:32.833956Z","time spent":"531.1292ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:52.062899Z","caller":"traceutil/trace.go:171","msg":"trace[371535281] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"132.490264ms","start":"2026-08-14T09:17:51.930382Z","end":"2026-08-14T09:17:52.062872Z","steps":["trace[371535281] 'process raft request' (duration: 132.361171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:52.683383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.008629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:17:52.683462Z","caller":"traceutil/trace.go:171","msg":"trace[1935435652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"386.130141ms","start":"2026-08-14T09:17:52.297311Z","end":"2026-08-14T09:17:52.683441Z","steps":["trace[1935435652] 'range keys from in-memory index tree' (duration: 385.855256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:52.683508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:52.297297Z","time spent":"386.202392ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:17:52.683532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.499678ms","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-08-14T09:17:52.683609Z","caller":"traceutil/trace.go:171","msg":"trace[1553103671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"393.639441ms","start":"2026-08-14T09:17:52.28995Z","end":"2026-08-14T09:17:52.683589Z","steps":["trace[1553103671] 'range keys from in-memory index tree' (duration: 393.296635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:52.683654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:52.289928Z","time spent":"393.718162ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:17:52.683818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.374143ms","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-08-14T09:17:52.683852Z","caller":"traceutil/trace.go:171","msg":"trace[1872300066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1013; }","duration":"411.435234ms","start":"2026-08-14T09:17:52.272407Z","end":"2026-08-14T09:17:52.683842Z","steps":["trace[1872300066] 'range keys from in-memory index tree' (duration: 411.285061ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:52.683884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:52.27239Z","time spent":"411.488824ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T09:17:52.684094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.788353ms","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-08-14T09:17:52.684293Z","caller":"traceutil/trace.go:171","msg":"trace[1707216254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1013; }","duration":"387.007107ms","start":"2026-08-14T09:17:52.297272Z","end":"2026-08-14T09:17:52.684279Z","steps":["trace[1707216254] 'range keys from in-memory index tree' (duration: 386.457327ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:52.684499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:52.297263Z","time spent":"387.221431ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T09:17:53.564868Z","caller":"traceutil/trace.go:171","msg":"trace[1764029364] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"113.637382ms","start":"2026-08-14T09:17:53.451206Z","end":"2026-08-14T09:17:53.564844Z","steps":["trace[1764029364] 'process raft request' (duration: 113.486629ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:54.410878Z","caller":"traceutil/trace.go:171","msg":"trace[1333097847] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"339.51703ms","start":"2026-08-14T09:17:54.071334Z","end":"2026-08-14T09:17:54.410851Z","steps":["trace[1333097847] 'process raft request' (duration: 339.340767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:54.411026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.071305Z","time spent":"339.649492ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:54.441847Z","caller":"traceutil/trace.go:171","msg":"trace[11722669] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"312.289071ms","start":"2026-08-14T09:17:54.129532Z","end":"2026-08-14T09:17:54.441822Z","steps":["trace[11722669] 'process raft request' (duration: 312.158219ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:54.442035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.129505Z","time spent":"312.421485ms","remote":"127.0.0.1:38992","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-08-14T09:17:54.91353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.736021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:17:54.913593Z","caller":"traceutil/trace.go:171","msg":"trace[1302731756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1021; }","duration":"145.853914ms","start":"2026-08-14T09:17:54.767724Z","end":"2026-08-14T09:17:54.913578Z","steps":["trace[1302731756] 'range keys from in-memory index tree' (duration: 145.475306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:54.91391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.237611ms","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-08-14T09:17:54.914003Z","caller":"traceutil/trace.go:171","msg":"trace[206558676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1021; }","duration":"146.347474ms","start":"2026-08-14T09:17:54.767643Z","end":"2026-08-14T09:17:54.91399Z","steps":["trace[206558676] 'range keys from in-memory index tree' (duration: 146.14941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:54.914057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.698569ms","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-08-14T09:17:54.914148Z","caller":"traceutil/trace.go:171","msg":"trace[1675520390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1021; }","duration":"177.842181ms","start":"2026-08-14T09:17:54.736287Z","end":"2026-08-14T09:17:54.914129Z","steps":["trace[1675520390] 'range keys from in-memory index tree' (duration: 177.441104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:54.914059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.210209ms","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-08-14T09:17:54.914301Z","caller":"traceutil/trace.go:171","msg":"trace[96884933] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1021; }","duration":"147.509044ms","start":"2026-08-14T09:17:54.766781Z","end":"2026-08-14T09:17:54.91429Z","steps":["trace[96884933] 'range keys from in-memory index tree' (duration: 147.033026ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:55.261963Z","caller":"traceutil/trace.go:171","msg":"trace[1339831241] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"344.002974ms","start":"2026-08-14T09:17:54.91793Z","end":"2026-08-14T09:17:55.261933Z","steps":["trace[1339831241] 'process raft request' (duration: 343.828021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:55.262115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.917913Z","time spent":"344.125176ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:17:55.290803Z","caller":"traceutil/trace.go:171","msg":"trace[888547906] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"371.454568ms","start":"2026-08-14T09:17:54.919323Z","end":"2026-08-14T09:17:55.290777Z","steps":["trace[888547906] 'process raft request' (duration: 371.418937ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:55.290824Z","caller":"traceutil/trace.go:171","msg":"trace[1627821385] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"372.760891ms","start":"2026-08-14T09:17:54.918033Z","end":"2026-08-14T09:17:55.290794Z","steps":["trace[1627821385] 'process raft request' (duration: 372.541267ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:55.290854Z","caller":"traceutil/trace.go:171","msg":"trace[99741043] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"372.532027ms","start":"2026-08-14T09:17:54.918299Z","end":"2026-08-14T09:17:55.290831Z","steps":["trace[99741043] 'process raft request' (duration: 372.404864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:55.291228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.918011Z","time spent":"373.128698ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:55.29134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.918282Z","time spent":"372.980555ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:55.291203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:17:54.919305Z","time spent":"371.665561ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:17:59.63837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.167886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:17:59.638482Z","caller":"traceutil/trace.go:171","msg":"trace[602134129] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1038; }","duration":"171.34798ms","start":"2026-08-14T09:17:59.467115Z","end":"2026-08-14T09:17:59.638462Z","steps":["trace[602134129] 'count revisions from in-memory index tree' (duration: 171.054725ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:17:59.935582Z","caller":"traceutil/trace.go:171","msg":"trace[305325074] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1081; }","duration":"233.998499ms","start":"2026-08-14T09:17:59.70155Z","end":"2026-08-14T09:17:59.935548Z","steps":["trace[305325074] 'read index received' (duration: 233.824016ms)","trace[305325074] 'applied index is now lower than readState.Index' (duration: 172.823µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:17:59.935697Z","caller":"traceutil/trace.go:171","msg":"trace[2120978914] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"256.472589ms","start":"2026-08-14T09:17:59.679188Z","end":"2026-08-14T09:17:59.93566Z","steps":["trace[2120978914] 'process raft request' (duration: 256.184754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:59.935772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.202813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:17:59.935809Z","caller":"traceutil/trace.go:171","msg":"trace[947362031] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1039; }","duration":"234.306305ms","start":"2026-08-14T09:17:59.701491Z","end":"2026-08-14T09:17:59.935798Z","steps":["trace[947362031] 'agreement among raft nodes before linearized reading' (duration: 234.211773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:17:59.935841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.008193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:17:59.93592Z","caller":"traceutil/trace.go:171","msg":"trace[836523807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1039; }","duration":"111.131885ms","start":"2026-08-14T09:17:59.824768Z","end":"2026-08-14T09:17:59.9359Z","steps":["trace[836523807] 'agreement among raft nodes before linearized reading' (duration: 110.982122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:13.880529Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018546,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:18:14.191087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.234792Z","time spent":"956.291589ms","remote":"127.0.0.1:38758","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-14T09:18:14.191098Z","caller":"traceutil/trace.go:171","msg":"trace[585848829] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1178; }","duration":"811.061307ms","start":"2026-08-14T09:18:13.380011Z","end":"2026-08-14T09:18:14.191072Z","steps":["trace[585848829] 'read index received' (duration: 811.051197ms)","trace[585848829] 'applied index is now lower than readState.Index' (duration: 8.18µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:14.1913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.277131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:18:14.191329Z","caller":"traceutil/trace.go:171","msg":"trace[152740056] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1130; }","duration":"811.361523ms","start":"2026-08-14T09:18:13.37996Z","end":"2026-08-14T09:18:14.191322Z","steps":["trace[152740056] 'agreement among raft nodes before linearized reading' (duration: 811.21085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.191354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.379939Z","time spent":"811.409333ms","remote":"127.0.0.1:38992","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-08-14T09:18:14.563728Z","caller":"traceutil/trace.go:171","msg":"trace[1948747344] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"517.962933ms","start":"2026-08-14T09:18:14.045738Z","end":"2026-08-14T09:18:14.563701Z","steps":["trace[1948747344] 'process raft request' (duration: 517.197259ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:14.563808Z","caller":"traceutil/trace.go:171","msg":"trace[1193761878] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"372.633989ms","start":"2026-08-14T09:18:14.191148Z","end":"2026-08-14T09:18:14.563782Z","steps":["trace[1193761878] 'read index received' (duration: 371.780253ms)","trace[1193761878] 'applied index is now lower than readState.Index' (duration: 851.456µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:14.563842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:14.045718Z","time spent":"518.066215ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:18:14.563813Z","caller":"traceutil/trace.go:171","msg":"trace[762336189] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"368.633824ms","start":"2026-08-14T09:18:14.195155Z","end":"2026-08-14T09:18:14.563789Z","steps":["trace[762336189] 'process raft request' (duration: 368.594623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.563932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.768089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:14.563954Z","caller":"traceutil/trace.go:171","msg":"trace[1223010872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"736.836771ms","start":"2026-08-14T09:18:13.82711Z","end":"2026-08-14T09:18:14.563947Z","steps":["trace[1223010872] 'agreement among raft nodes before linearized reading' (duration: 736.77896ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.563974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.82709Z","time spent":"736.878421ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:18:14.563959Z","caller":"traceutil/trace.go:171","msg":"trace[1766905836] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"371.757313ms","start":"2026-08-14T09:18:14.192181Z","end":"2026-08-14T09:18:14.563939Z","steps":["trace[1766905836] 'process raft request' (duration: 371.510038ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.563977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:14.195146Z","time spent":"368.755076ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:14.564046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:14.192164Z","time spent":"371.837795ms","remote":"127.0.0.1:38758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:14.564124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12180542s","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-08-14T09:18:14.564121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127017567s","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-08-14T09:18:14.564149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126325914s","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-08-14T09:18:14.564162Z","caller":"traceutil/trace.go:171","msg":"trace[1621350164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1133; }","duration":"1.12185717s","start":"2026-08-14T09:18:13.442286Z","end":"2026-08-14T09:18:14.564143Z","steps":["trace[1621350164] 'agreement among raft nodes before linearized reading' (duration: 1.121756309s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:14.564176Z","caller":"traceutil/trace.go:171","msg":"trace[547504119] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1133; }","duration":"1.126376795s","start":"2026-08-14T09:18:13.437792Z","end":"2026-08-14T09:18:14.564169Z","steps":["trace[547504119] 'agreement among raft nodes before linearized reading' (duration: 1.126321664s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.564179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.442275Z","time spent":"1.121900172s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T09:18:14.564188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.437777Z","time spent":"1.126408375s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-14T09:18:14.564183Z","caller":"traceutil/trace.go:171","msg":"trace[841274379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1133; }","duration":"1.12712387s","start":"2026-08-14T09:18:13.437044Z","end":"2026-08-14T09:18:14.564168Z","steps":["trace[841274379] 'agreement among raft nodes before linearized reading' (duration: 1.126925636s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:14.564218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:13.437028Z","time spent":"1.127183611s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-14T09:18:26.894021Z","caller":"traceutil/trace.go:171","msg":"trace[1123180667] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"270.359058ms","start":"2026-08-14T09:18:26.623637Z","end":"2026-08-14T09:18:26.893996Z","steps":["trace[1123180667] 'read index received' (duration: 270.205386ms)","trace[1123180667] 'applied index is now lower than readState.Index' (duration: 152.422µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:26.894249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.594354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:18:26.894291Z","caller":"traceutil/trace.go:171","msg":"trace[1851913925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1172; }","duration":"270.678356ms","start":"2026-08-14T09:18:26.6236Z","end":"2026-08-14T09:18:26.894279Z","steps":["trace[1851913925] 'agreement among raft nodes before linearized reading' (duration: 270.537772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:26.894314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.021995ms","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-08-14T09:18:26.894348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.09962ms","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-08-14T09:18:26.894377Z","caller":"traceutil/trace.go:171","msg":"trace[1138800138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1172; }","duration":"246.097926ms","start":"2026-08-14T09:18:26.648257Z","end":"2026-08-14T09:18:26.894355Z","steps":["trace[1138800138] 'agreement among raft nodes before linearized reading' (duration: 245.969044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:26.894349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.925566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T09:18:26.894458Z","caller":"traceutil/trace.go:171","msg":"trace[1260383104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1172; }","duration":"244.053799ms","start":"2026-08-14T09:18:26.650393Z","end":"2026-08-14T09:18:26.894447Z","steps":["trace[1260383104] 'agreement among raft nodes before linearized reading' (duration: 243.843645ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:26.894408Z","caller":"traceutil/trace.go:171","msg":"trace[1318490431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1172; }","duration":"251.195432ms","start":"2026-08-14T09:18:26.643198Z","end":"2026-08-14T09:18:26.894393Z","steps":["trace[1318490431] 'agreement among raft nodes before linearized reading' (duration: 251.053869ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:26.89464Z","caller":"traceutil/trace.go:171","msg":"trace[1246175851] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"293.329628ms","start":"2026-08-14T09:18:26.601266Z","end":"2026-08-14T09:18:26.894596Z","steps":["trace[1246175851] 'process raft request' (duration: 292.595174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:26.894843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.343941ms","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-08-14T09:18:26.894874Z","caller":"traceutil/trace.go:171","msg":"trace[1746170187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1172; }","duration":"254.412951ms","start":"2026-08-14T09:18:26.640454Z","end":"2026-08-14T09:18:26.894866Z","steps":["trace[1746170187] 'agreement among raft nodes before linearized reading' (duration: 253.711797ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:29.093073Z","caller":"traceutil/trace.go:171","msg":"trace[596975645] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"135.493561ms","start":"2026-08-14T09:18:28.95755Z","end":"2026-08-14T09:18:29.093043Z","steps":["trace[596975645] 'process raft request' (duration: 45.5008ms)","trace[596975645] 'compare' (duration: 89.761346ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:29.146005Z","caller":"traceutil/trace.go:171","msg":"trace[588223743] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"184.511826ms","start":"2026-08-14T09:18:28.961471Z","end":"2026-08-14T09:18:29.145983Z","steps":["trace[588223743] 'process raft request' (duration: 184.478046ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:29.146192Z","caller":"traceutil/trace.go:171","msg":"trace[1558431779] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"187.359499ms","start":"2026-08-14T09:18:28.95882Z","end":"2026-08-14T09:18:29.146179Z","steps":["trace[1558431779] 'process raft request' (duration: 186.832209ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:29.146406Z","caller":"traceutil/trace.go:171","msg":"trace[1220123855] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"184.906183ms","start":"2026-08-14T09:18:28.961405Z","end":"2026-08-14T09:18:29.146311Z","steps":["trace[1220123855] 'process raft request' (duration: 184.517626ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:29.146277Z","caller":"traceutil/trace.go:171","msg":"trace[473205747] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"186.685946ms","start":"2026-08-14T09:18:28.959561Z","end":"2026-08-14T09:18:29.146247Z","steps":["trace[473205747] 'process raft request' (duration: 186.211767ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:33.174794Z","caller":"traceutil/trace.go:171","msg":"trace[821429562] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"188.954259ms","start":"2026-08-14T09:18:32.985819Z","end":"2026-08-14T09:18:33.174774Z","steps":["trace[821429562] 'process raft request' (duration: 188.792136ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:33.292317Z","caller":"traceutil/trace.go:171","msg":"trace[2023814523] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"113.363357ms","start":"2026-08-14T09:18:33.178914Z","end":"2026-08-14T09:18:33.292277Z","steps":["trace[2023814523] 'process raft request' (duration: 108.050168ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:33.292875Z","caller":"traceutil/trace.go:171","msg":"trace[31847150] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"113.862898ms","start":"2026-08-14T09:18:33.178988Z","end":"2026-08-14T09:18:33.292851Z","steps":["trace[31847150] 'process raft request' (duration: 113.588632ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:33.295552Z","caller":"traceutil/trace.go:171","msg":"trace[1457036527] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"116.049867ms","start":"2026-08-14T09:18:33.179486Z","end":"2026-08-14T09:18:33.295536Z","steps":["trace[1457036527] 'process raft request' (duration: 115.512397ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:33.295745Z","caller":"traceutil/trace.go:171","msg":"trace[1615480138] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"116.288252ms","start":"2026-08-14T09:18:33.179417Z","end":"2026-08-14T09:18:33.295705Z","steps":["trace[1615480138] 'process raft request' (duration: 115.483407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:35.699536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018754,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:18:36.200182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018754,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:18:36.70085Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018754,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:18:36.974776Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.808393681s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:18:36.975226Z","caller":"traceutil/trace.go:171","msg":"trace[1780817075] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"1.808947473s","start":"2026-08-14T09:18:35.16625Z","end":"2026-08-14T09:18:36.975198Z","steps":["trace[1780817075] 'process raft request' (duration: 1.808760069s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:36.975398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.166221Z","time spent":"1.809074705s","remote":"127.0.0.1:38992","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-08-14T09:18:37.826819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999974851s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-14T09:18:37.826904Z","caller":"traceutil/trace.go:171","msg":"trace[1455926976] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000159104s","start":"2026-08-14T09:18:35.826726Z","end":"2026-08-14T09:18:37.826886Z","steps":["trace[1455926976] 'agreement among raft nodes before linearized reading' (duration: 2.000014072s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:37.826969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.8267Z","time spent":"2.000256465s","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:18:38.749779Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.774838806s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:18:38.827195Z","caller":"traceutil/trace.go:171","msg":"trace[1223903027] linearizableReadLoop","detail":"{readStateIndex:1278; appliedIndex:1276; }","duration":"3.628438781s","start":"2026-08-14T09:18:35.198736Z","end":"2026-08-14T09:18:38.827174Z","steps":["trace[1223903027] 'read index received' (duration: 1.776277022s)","trace[1223903027] 'applied index is now lower than readState.Index' (duration: 1.852160719s)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:38.827405Z","caller":"traceutil/trace.go:171","msg":"trace[1461648137] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"616.688017ms","start":"2026-08-14T09:18:38.210686Z","end":"2026-08-14T09:18:38.827374Z","steps":["trace[1461648137] 'process raft request' (duration: 616.463153ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:38.827212Z","caller":"traceutil/trace.go:171","msg":"trace[1543400240] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"3.646867695s","start":"2026-08-14T09:18:35.180311Z","end":"2026-08-14T09:18:38.827179Z","steps":["trace[1543400240] 'process raft request' (duration: 3.569774605s)","trace[1543400240] 'compare' (duration: 76.881236ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:38.828396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.180291Z","time spent":"3.647994926s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:38.827549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:38.210659Z","time spent":"616.819029ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:38.923898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.72532182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T09:18:38.923964Z","caller":"traceutil/trace.go:171","msg":"trace[854436548] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1227; }","duration":"3.725432232s","start":"2026-08-14T09:18:35.198515Z","end":"2026-08-14T09:18:38.923947Z","steps":["trace[854436548] 'agreement among raft nodes before linearized reading' (duration: 3.628750397s)","trace[854436548] 'range keys from in-memory index tree' (duration: 96.505512ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:38.923994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.198495Z","time spent":"3.725492063s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-14T09:18:38.923978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.626676228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-14T09:18:38.92406Z","caller":"traceutil/trace.go:171","msg":"trace[356924552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1227; }","duration":"3.626807331s","start":"2026-08-14T09:18:35.297235Z","end":"2026-08-14T09:18:38.924042Z","steps":["trace[356924552] 'agreement among raft nodes before linearized reading' (duration: 3.626592497s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.297218Z","time spent":"3.626880302s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-14T09:18:38.924112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011205894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-14T09:18:38.924158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.791038322s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:18:38.924225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096773913s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:38.924219Z","caller":"traceutil/trace.go:171","msg":"trace[923276341] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1227; }","duration":"3.011375419s","start":"2026-08-14T09:18:35.912817Z","end":"2026-08-14T09:18:38.924192Z","steps":["trace[923276341] 'agreement among raft nodes before linearized reading' (duration: 3.011159134s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:38.924247Z","caller":"traceutil/trace.go:171","msg":"trace[636488169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1227; }","duration":"1.096826354s","start":"2026-08-14T09:18:37.827416Z","end":"2026-08-14T09:18:38.924242Z","steps":["trace[636488169] 'agreement among raft nodes before linearized reading' (duration: 1.096788253s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:38.924232Z","caller":"traceutil/trace.go:171","msg":"trace[1158998017] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1227; }","duration":"2.791137305s","start":"2026-08-14T09:18:36.133073Z","end":"2026-08-14T09:18:38.92421Z","steps":["trace[1158998017] 'agreement among raft nodes before linearized reading' (duration: 2.791009192s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:37.8274Z","time spent":"1.096864925s","remote":"127.0.0.1:38720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:18:38.92429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:36.133017Z","time spent":"2.791262617s","remote":"127.0.0.1:48098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:18:38.924244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800767571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"warn","ts":"2026-08-14T09:18:38.924291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.912796Z","time spent":"3.01147868s","remote":"127.0.0.1:39176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:18:38.924361Z","caller":"traceutil/trace.go:171","msg":"trace[823451357] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1227; }","duration":"1.800937373s","start":"2026-08-14T09:18:37.123402Z","end":"2026-08-14T09:18:38.924339Z","steps":["trace[823451357] 'agreement among raft nodes before linearized reading' (duration: 1.800664037s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.624102452s","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-08-14T09:18:38.924422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:37.123381Z","time spent":"1.801028196s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-14T09:18:38.92445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.625696641s","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-08-14T09:18:38.924457Z","caller":"traceutil/trace.go:171","msg":"trace[1280978334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1227; }","duration":"3.624157042s","start":"2026-08-14T09:18:35.30029Z","end":"2026-08-14T09:18:38.924447Z","steps":["trace[1280978334] 'agreement among raft nodes before linearized reading' (duration: 3.62405525s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:38.92447Z","caller":"traceutil/trace.go:171","msg":"trace[1631107441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1227; }","duration":"3.625745672s","start":"2026-08-14T09:18:35.298719Z","end":"2026-08-14T09:18:38.924465Z","steps":["trace[1631107441] 'agreement among raft nodes before linearized reading' (duration: 3.625692991s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.298651Z","time spent":"3.625829924s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-14T09:18:38.924485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.300277Z","time spent":"3.624202023s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:18:38.924607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.625817343s","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-08-14T09:18:38.924632Z","caller":"traceutil/trace.go:171","msg":"trace[251023860] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1227; }","duration":"3.625882224s","start":"2026-08-14T09:18:35.298743Z","end":"2026-08-14T09:18:38.924625Z","steps":["trace[251023860] 'agreement among raft nodes before linearized reading' (duration: 3.625819283s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:35.298719Z","time spent":"3.625925445s","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-14T09:18:38.924679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670010048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:38.924724Z","caller":"traceutil/trace.go:171","msg":"trace[384420719] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1227; }","duration":"1.670096949s","start":"2026-08-14T09:18:37.254616Z","end":"2026-08-14T09:18:38.924713Z","steps":["trace[384420719] 'agreement among raft nodes before linearized reading' (duration: 1.670030328s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.924759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:37.254594Z","time spent":"1.670157901s","remote":"127.0.0.1:48260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:18:38.924373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.69851073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:38.924957Z","caller":"traceutil/trace.go:171","msg":"trace[203208906] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1227; }","duration":"1.699407927s","start":"2026-08-14T09:18:37.225528Z","end":"2026-08-14T09:18:38.924936Z","steps":["trace[203208906] 'agreement among raft nodes before linearized reading' (duration: 1.698377487s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:38.925367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:37.225506Z","time spent":"1.699842224s","remote":"127.0.0.1:35992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:18:38.925018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.984969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:38.926244Z","caller":"traceutil/trace.go:171","msg":"trace[1037143572] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1227; }","duration":"198.223493ms","start":"2026-08-14T09:18:38.727984Z","end":"2026-08-14T09:18:38.926208Z","steps":["trace[1037143572] 'agreement among raft nodes before linearized reading' (duration: 196.031471ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.193789Z","caller":"traceutil/trace.go:171","msg":"trace[818227521] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"264.740426ms","start":"2026-08-14T09:18:38.929022Z","end":"2026-08-14T09:18:39.193763Z","steps":["trace[818227521] 'process raft request' (duration: 264.065034ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.194016Z","caller":"traceutil/trace.go:171","msg":"trace[998029506] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"264.776297ms","start":"2026-08-14T09:18:38.929229Z","end":"2026-08-14T09:18:39.194005Z","steps":["trace[998029506] 'process raft request' (duration: 264.484421ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.194391Z","caller":"traceutil/trace.go:171","msg":"trace[980539283] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"263.855271ms","start":"2026-08-14T09:18:38.930519Z","end":"2026-08-14T09:18:39.194374Z","steps":["trace[980539283] 'process raft request' (duration: 263.438732ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.194907Z","caller":"traceutil/trace.go:171","msg":"trace[664013178] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1280; }","duration":"265.723385ms","start":"2026-08-14T09:18:38.929161Z","end":"2026-08-14T09:18:39.194884Z","steps":["trace[664013178] 'read index received' (duration: 91.993288ms)","trace[664013178] 'applied index is now lower than readState.Index' (duration: 173.728667ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:39.194953Z","caller":"traceutil/trace.go:171","msg":"trace[1480111505] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"263.82247ms","start":"2026-08-14T09:18:38.931104Z","end":"2026-08-14T09:18:39.194926Z","steps":["trace[1480111505] 'process raft request' (duration: 263.186057ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:39.195012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.833357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18cba1418f6f7e89\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-08-14T09:18:39.195824Z","caller":"traceutil/trace.go:171","msg":"trace[102262628] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18cba1418f6f7e89; range_end:; response_count:1; response_revision:1233; }","duration":"266.695434ms","start":"2026-08-14T09:18:38.929112Z","end":"2026-08-14T09:18:39.195808Z","steps":["trace[102262628] 'agreement among raft nodes before linearized reading' (duration: 265.842577ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.195032Z","caller":"traceutil/trace.go:171","msg":"trace[1934396095] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"263.735538ms","start":"2026-08-14T09:18:38.931287Z","end":"2026-08-14T09:18:39.195023Z","steps":["trace[1934396095] 'process raft request' (duration: 263.508954ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:39.348692Z","caller":"traceutil/trace.go:171","msg":"trace[433033469] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"321.266254ms","start":"2026-08-14T09:18:39.027391Z","end":"2026-08-14T09:18:39.348657Z","steps":["trace[433033469] 'process raft request' (duration: 287.688657ms)","trace[433033469] 'compare' (duration: 33.311632ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:39.348839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:39.027374Z","time spent":"321.385896ms","remote":"127.0.0.1:38894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6104,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:39.348832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.340338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:39.34891Z","caller":"traceutil/trace.go:171","msg":"trace[1949842698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1234; }","duration":"417.453579ms","start":"2026-08-14T09:18:38.931437Z","end":"2026-08-14T09:18:39.34889Z","steps":["trace[1949842698] 'agreement among raft nodes before linearized reading' (duration: 417.299627ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:39.348955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:38.931429Z","time spent":"417.516872ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-14T09:18:39.348927Z","caller":"traceutil/trace.go:171","msg":"trace[502784613] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1286; }","duration":"152.887686ms","start":"2026-08-14T09:18:39.19568Z","end":"2026-08-14T09:18:39.348568Z","steps":["trace[502784613] 'read index received' (duration: 119.635036ms)","trace[502784613] 'applied index is now lower than readState.Index' (duration: 33.25159ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:39.359237Z","caller":"traceutil/trace.go:171","msg":"trace[1407694169] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"161.201426ms","start":"2026-08-14T09:18:39.197988Z","end":"2026-08-14T09:18:39.359189Z","steps":["trace[1407694169] 'process raft request' (duration: 160.825079ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:41.037633Z","caller":"traceutil/trace.go:171","msg":"trace[1477760324] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"203.890069ms","start":"2026-08-14T09:18:40.833716Z","end":"2026-08-14T09:18:41.037606Z","steps":["trace[1477760324] 'process raft request' (duration: 203.518572ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:41.307021Z","caller":"traceutil/trace.go:171","msg":"trace[1707576073] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"108.532881ms","start":"2026-08-14T09:18:41.198462Z","end":"2026-08-14T09:18:41.306995Z","steps":["trace[1707576073] 'read index received' (duration: 108.442299ms)","trace[1707576073] 'applied index is now lower than readState.Index' (duration: 89.382µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:41.307078Z","caller":"traceutil/trace.go:171","msg":"trace[2073371628] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"265.428904ms","start":"2026-08-14T09:18:41.041612Z","end":"2026-08-14T09:18:41.30704Z","steps":["trace[2073371628] 'process raft request' (duration: 265.21836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:41.307271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.754757ms","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-08-14T09:18:41.307312Z","caller":"traceutil/trace.go:171","msg":"trace[1415367201] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"108.853668ms","start":"2026-08-14T09:18:41.198448Z","end":"2026-08-14T09:18:41.307301Z","steps":["trace[1415367201] 'agreement among raft nodes before linearized reading' (duration: 108.699745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:41.307338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.854478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T09:18:41.307421Z","caller":"traceutil/trace.go:171","msg":"trace[1831885855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1238; }","duration":"109.009351ms","start":"2026-08-14T09:18:41.198393Z","end":"2026-08-14T09:18:41.307402Z","steps":["trace[1831885855] 'agreement among raft nodes before linearized reading' (duration: 108.740675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:41.307477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.93032ms","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-08-14T09:18:41.30751Z","caller":"traceutil/trace.go:171","msg":"trace[779722356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1238; }","duration":"107.9824ms","start":"2026-08-14T09:18:41.199519Z","end":"2026-08-14T09:18:41.307501Z","steps":["trace[779722356] 'agreement among raft nodes before linearized reading' (duration: 107.897469ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:41.307461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.140225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T09:18:41.307663Z","caller":"traceutil/trace.go:171","msg":"trace[1148149898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"107.319599ms","start":"2026-08-14T09:18:41.200252Z","end":"2026-08-14T09:18:41.307571Z","steps":["trace[1148149898] 'agreement among raft nodes before linearized reading' (duration: 107.017213ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:41.507198Z","caller":"traceutil/trace.go:171","msg":"trace[1193925185] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"195.68666ms","start":"2026-08-14T09:18:41.311476Z","end":"2026-08-14T09:18:41.507162Z","steps":["trace[1193925185] 'process raft request' (duration: 102.457394ms)","trace[1193925185] 'compare' (duration: 92.88961ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:41.507262Z","caller":"traceutil/trace.go:171","msg":"trace[1890801906] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"195.69262ms","start":"2026-08-14T09:18:41.311538Z","end":"2026-08-14T09:18:41.50723Z","steps":["trace[1890801906] 'process raft request' (duration: 195.515997ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:41.507634Z","caller":"traceutil/trace.go:171","msg":"trace[297357410] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"195.341305ms","start":"2026-08-14T09:18:41.312259Z","end":"2026-08-14T09:18:41.5076Z","steps":["trace[297357410] 'process raft request' (duration: 194.915596ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:41.875572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.664725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:18:41.875901Z","caller":"traceutil/trace.go:171","msg":"trace[1830219341] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"172.150037ms","start":"2026-08-14T09:18:41.703732Z","end":"2026-08-14T09:18:41.875882Z","steps":["trace[1830219341] 'read index received' (duration: 65.145735ms)","trace[1830219341] 'applied index is now lower than readState.Index' (duration: 107.002182ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:41.87601Z","caller":"traceutil/trace.go:171","msg":"trace[799248253] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"257.613534ms","start":"2026-08-14T09:18:41.618379Z","end":"2026-08-14T09:18:41.875992Z","steps":["trace[799248253] 'process raft request' (duration: 150.463349ms)","trace[799248253] 'compare' (duration: 106.552643ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:41.876167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.423713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:41.876585Z","caller":"traceutil/trace.go:171","msg":"trace[1275914226] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1243; }","duration":"172.876931ms","start":"2026-08-14T09:18:41.703685Z","end":"2026-08-14T09:18:41.876562Z","steps":["trace[1275914226] 'agreement among raft nodes before linearized reading' (duration: 172.3314ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:42.18631Z","caller":"traceutil/trace.go:171","msg":"trace[66954532] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"302.277763ms","start":"2026-08-14T09:18:41.884006Z","end":"2026-08-14T09:18:42.186283Z","steps":["trace[66954532] 'process raft request' (duration: 302.12971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:42.18647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:41.883984Z","time spent":"302.398697ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:18:42.391221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.385912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:18:42.391685Z","caller":"traceutil/trace.go:171","msg":"trace[568433786] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1297; }","duration":"201.123826ms","start":"2026-08-14T09:18:42.190541Z","end":"2026-08-14T09:18:42.391665Z","steps":["trace[568433786] 'read index received' (duration: 70.236004ms)","trace[568433786] 'applied index is now lower than readState.Index' (duration: 130.886122ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:42.391652Z","caller":"traceutil/trace.go:171","msg":"trace[663840566] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"278.256202ms","start":"2026-08-14T09:18:42.113365Z","end":"2026-08-14T09:18:42.391621Z","steps":["trace[663840566] 'process raft request' (duration: 147.399471ms)","trace[663840566] 'compare' (duration: 130.164168ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:42.391922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.36243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-14T09:18:42.391996Z","caller":"traceutil/trace.go:171","msg":"trace[1691597447] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1245; }","duration":"201.477612ms","start":"2026-08-14T09:18:42.1905Z","end":"2026-08-14T09:18:42.391977Z","steps":["trace[1691597447] 'agreement among raft nodes before linearized reading' (duration: 201.232168ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:42.392312Z","caller":"traceutil/trace.go:171","msg":"trace[1107729469] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"200.714048ms","start":"2026-08-14T09:18:42.191583Z","end":"2026-08-14T09:18:42.392297Z","steps":["trace[1107729469] 'process raft request' (duration: 200.042885ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:42.740004Z","caller":"traceutil/trace.go:171","msg":"trace[49283679] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"343.814695ms","start":"2026-08-14T09:18:42.39615Z","end":"2026-08-14T09:18:42.739964Z","steps":["trace[49283679] 'process raft request' (duration: 313.895348ms)","trace[49283679] 'compare' (duration: 29.808665ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:42.74016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:42.396133Z","time spent":"343.943127ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:43.204687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.619456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:18:43.20501Z","caller":"traceutil/trace.go:171","msg":"trace[860534360] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1299; }","duration":"760.302049ms","start":"2026-08-14T09:18:42.44469Z","end":"2026-08-14T09:18:43.204992Z","steps":["trace[860534360] 'read index received' (duration: 265.371952ms)","trace[860534360] 'applied index is now lower than readState.Index' (duration: 494.928187ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:43.205065Z","caller":"traceutil/trace.go:171","msg":"trace[354327943] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"808.510668ms","start":"2026-08-14T09:18:42.396513Z","end":"2026-08-14T09:18:43.205024Z","steps":["trace[354327943] 'process raft request' (duration: 443.487144ms)","trace[354327943] 'compare' (duration: 364.340801ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:43.205243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:42.396492Z","time spent":"808.718142ms","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":843,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:18:43.205269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.561535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:18:43.205445Z","caller":"traceutil/trace.go:171","msg":"trace[990129974] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1248; }","duration":"760.779778ms","start":"2026-08-14T09:18:42.444649Z","end":"2026-08-14T09:18:43.205429Z","steps":["trace[990129974] 'agreement among raft nodes before linearized reading' (duration: 760.489953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:43.205486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:42.444638Z","time spent":"760.837209ms","remote":"127.0.0.1:39276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:18:43.214069Z","caller":"traceutil/trace.go:171","msg":"trace[891004032] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"170.76928ms","start":"2026-08-14T09:18:43.043276Z","end":"2026-08-14T09:18:43.214046Z","steps":["trace[891004032] 'process raft request' (duration: 170.671258ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:43.714175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.492773ms","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-08-14T09:18:43.714319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.676303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-14T09:18:43.714293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.134386ms","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-08-14T09:18:43.714293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.182654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T09:18:43.714347Z","caller":"traceutil/trace.go:171","msg":"trace[1315026484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1250; }","duration":"355.723544ms","start":"2026-08-14T09:18:43.358615Z","end":"2026-08-14T09:18:43.714338Z","steps":["trace[1315026484] 'range keys from in-memory index tree' (duration: 355.597111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:43.714376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.358604Z","time spent":"355.766085ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-14T09:18:43.714378Z","caller":"traceutil/trace.go:171","msg":"trace[1164882926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1250; }","duration":"201.281149ms","start":"2026-08-14T09:18:43.513075Z","end":"2026-08-14T09:18:43.714356Z","steps":["trace[1164882926] 'range keys from in-memory index tree' (duration: 200.967833ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:43.714378Z","caller":"traceutil/trace.go:171","msg":"trace[1856136989] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1250; }","duration":"203.367848ms","start":"2026-08-14T09:18:43.510995Z","end":"2026-08-14T09:18:43.714363Z","steps":["trace[1856136989] 'range keys from in-memory index tree' (duration: 203.011981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:43.714229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.067376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-14T09:18:43.714497Z","caller":"traceutil/trace.go:171","msg":"trace[1048314183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1250; }","duration":"403.369292ms","start":"2026-08-14T09:18:43.311112Z","end":"2026-08-14T09:18:43.714481Z","steps":["trace[1048314183] 'range keys from in-memory index tree' (duration: 402.896443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:43.714544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.311091Z","time spent":"403.440544ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-14T09:18:43.714321Z","caller":"traceutil/trace.go:171","msg":"trace[225896818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"201.677586ms","start":"2026-08-14T09:18:43.512623Z","end":"2026-08-14T09:18:43.7143Z","steps":["trace[225896818] 'range keys from in-memory index tree' (duration: 201.222876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.326735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018808,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-14T09:18:44.528108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.112587ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:44.528226Z","caller":"traceutil/trace.go:171","msg":"trace[2009373856] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1251; }","duration":"567.24043ms","start":"2026-08-14T09:18:43.960967Z","end":"2026-08-14T09:18:44.528207Z","steps":["trace[2009373856] 'range keys from in-memory index tree' (duration: 567.096547ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:44.693089Z","caller":"traceutil/trace.go:171","msg":"trace[46462735] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"975.072839ms","start":"2026-08-14T09:18:43.717993Z","end":"2026-08-14T09:18:44.693065Z","steps":["trace[46462735] 'process raft request' (duration: 974.895435ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.693226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.717976Z","time spent":"975.18046ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:18:44.693673Z","caller":"traceutil/trace.go:171","msg":"trace[1953246211] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"975.17726ms","start":"2026-08-14T09:18:43.718481Z","end":"2026-08-14T09:18:44.693659Z","steps":["trace[1953246211] 'process raft request' (duration: 975.014737ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:44.693681Z","caller":"traceutil/trace.go:171","msg":"trace[1397585294] linearizableReadLoop","detail":"{readStateIndex:1309; appliedIndex:1305; }","duration":"866.914214ms","start":"2026-08-14T09:18:43.826635Z","end":"2026-08-14T09:18:44.693549Z","steps":["trace[1397585294] 'read index received' (duration: 866.1913ms)","trace[1397585294] 'applied index is now lower than readState.Index' (duration: 721.823µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:44.693682Z","caller":"traceutil/trace.go:171","msg":"trace[1714793987] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"975.22108ms","start":"2026-08-14T09:18:43.718372Z","end":"2026-08-14T09:18:44.693593Z","steps":["trace[1714793987] 'process raft request' (duration: 974.868844ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.693899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.244829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:44.693943Z","caller":"traceutil/trace.go:171","msg":"trace[632661627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1255; }","duration":"867.346432ms","start":"2026-08-14T09:18:43.826586Z","end":"2026-08-14T09:18:44.693932Z","steps":["trace[632661627] 'agreement among raft nodes before linearized reading' (duration: 867.194669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.693937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.718345Z","time spent":"975.439884ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:44.693985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.826565Z","time spent":"867.410043ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:18:44.693748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.718458Z","time spent":"975.254861ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:18:44.694455Z","caller":"traceutil/trace.go:171","msg":"trace[790365135] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"975.094037ms","start":"2026-08-14T09:18:43.718341Z","end":"2026-08-14T09:18:44.693366Z","steps":["trace[790365135] 'process raft request' (duration: 974.68616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.694598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:43.718223Z","time spent":"976.302812ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:44.694182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.717353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-08-14T09:18:44.695954Z","caller":"traceutil/trace.go:171","msg":"trace[1881990123] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1255; }","duration":"495.533458ms","start":"2026-08-14T09:18:44.200404Z","end":"2026-08-14T09:18:44.695937Z","steps":["trace[1881990123] 'agreement among raft nodes before linearized reading' (duration: 493.472398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:44.696008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:44.20038Z","time spent":"495.61234ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-14T09:18:45.328083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9965515995421018816,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T09:18:45.607186Z","caller":"traceutil/trace.go:171","msg":"trace[968847331] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"906.867744ms","start":"2026-08-14T09:18:44.700289Z","end":"2026-08-14T09:18:45.607157Z","steps":["trace[968847331] 'process raft request' (duration: 876.57888ms)","trace[968847331] 'compare' (duration: 30.131191ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:18:45.60729Z","caller":"traceutil/trace.go:171","msg":"trace[1355205768] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1309; }","duration":"780.143342ms","start":"2026-08-14T09:18:44.827125Z","end":"2026-08-14T09:18:45.607269Z","steps":["trace[1355205768] 'read index received' (duration: 749.738756ms)","trace[1355205768] 'applied index is now lower than readState.Index' (duration: 30.403646ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:45.607326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:44.700272Z","time spent":"906.983576ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:18:45.607484Z","caller":"traceutil/trace.go:171","msg":"trace[314967796] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"387.792972ms","start":"2026-08-14T09:18:45.219682Z","end":"2026-08-14T09:18:45.607475Z","steps":["trace[314967796] 'process raft request' (duration: 387.433996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:45.607563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:45.219657Z","time spent":"387.848203ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:18:45.607707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.56921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:45.607789Z","caller":"traceutil/trace.go:171","msg":"trace[175082399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"780.657582ms","start":"2026-08-14T09:18:44.827112Z","end":"2026-08-14T09:18:45.60777Z","steps":["trace[175082399] 'agreement among raft nodes before linearized reading' (duration: 780.523389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:45.607835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:44.827027Z","time spent":"780.800595ms","remote":"127.0.0.1:38708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-14T09:18:45.607837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.345588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:18:45.608567Z","caller":"traceutil/trace.go:171","msg":"trace[541917438] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1257; }","duration":"533.076492ms","start":"2026-08-14T09:18:45.075459Z","end":"2026-08-14T09:18:45.608536Z","steps":["trace[541917438] 'agreement among raft nodes before linearized reading' (duration: 532.262726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:45.608649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:18:45.075366Z","time spent":"533.263215ms","remote":"127.0.0.1:48240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:18:46.057256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.583708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:18:46.057324Z","caller":"traceutil/trace.go:171","msg":"trace[2026333484] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1258; }","duration":"114.67327ms","start":"2026-08-14T09:18:45.942636Z","end":"2026-08-14T09:18:46.05731Z","steps":["trace[2026333484] 'count revisions from in-memory index tree' (duration: 114.517197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:18:48.647261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.577735ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-14T09:18:48.647396Z","caller":"traceutil/trace.go:171","msg":"trace[243543320] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"148.759686ms","start":"2026-08-14T09:18:48.498613Z","end":"2026-08-14T09:18:48.647372Z","steps":["trace[243543320] 'read index received' (duration: 55.631µs)","trace[243543320] 'applied index is now lower than readState.Index' (duration: 148.698565ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:18:48.647513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.889148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:18:48.647597Z","caller":"traceutil/trace.go:171","msg":"trace[410510841] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1273; }","duration":"149.029681ms","start":"2026-08-14T09:18:48.498548Z","end":"2026-08-14T09:18:48.647577Z","steps":["trace[410510841] 'agreement among raft nodes before linearized reading' (duration: 148.888239ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:48.819303Z","caller":"traceutil/trace.go:171","msg":"trace[1381202980] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"106.660275ms","start":"2026-08-14T09:18:48.712623Z","end":"2026-08-14T09:18:48.819283Z","steps":["trace[1381202980] 'process raft request' (duration: 106.42581ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:48.819299Z","caller":"traceutil/trace.go:171","msg":"trace[1837636288] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"106.526943ms","start":"2026-08-14T09:18:48.712746Z","end":"2026-08-14T09:18:48.819273Z","steps":["trace[1837636288] 'process raft request' (duration: 106.453521ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:18:48.819422Z","caller":"traceutil/trace.go:171","msg":"trace[1587532618] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"105.928821ms","start":"2026-08-14T09:18:48.713486Z","end":"2026-08-14T09:18:48.819414Z","steps":["trace[1587532618] 'process raft request' (duration: 105.751878ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:19:23.949751Z","caller":"traceutil/trace.go:171","msg":"trace[1897768994] linearizableReadLoop","detail":"{readStateIndex:1517; appliedIndex:1516; }","duration":"122.666374ms","start":"2026-08-14T09:19:23.827067Z","end":"2026-08-14T09:19:23.949733Z","steps":["trace[1897768994] 'read index received' (duration: 122.462469ms)","trace[1897768994] 'applied index is now lower than readState.Index' (duration: 203.025µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:19:23.949837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.754455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:19:23.949855Z","caller":"traceutil/trace.go:171","msg":"trace[57476370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1455; }","duration":"122.822777ms","start":"2026-08-14T09:19:23.827026Z","end":"2026-08-14T09:19:23.949849Z","steps":["trace[57476370] 'agreement among raft nodes before linearized reading' (duration: 122.776696ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:19:23.949844Z","caller":"traceutil/trace.go:171","msg":"trace[1783421300] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"144.78265ms","start":"2026-08-14T09:19:23.805029Z","end":"2026-08-14T09:19:23.949812Z","steps":["trace[1783421300] 'process raft request' (duration: 144.583477ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:21:41.305688Z","caller":"traceutil/trace.go:171","msg":"trace[289477701] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"222.393242ms","start":"2026-08-14T09:21:41.083195Z","end":"2026-08-14T09:21:41.305588Z","steps":["trace[289477701] 'process raft request' (duration: 222.134847ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:21:41.30552Z","caller":"traceutil/trace.go:171","msg":"trace[1273660139] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2198; }","duration":"102.591272ms","start":"2026-08-14T09:21:41.202906Z","end":"2026-08-14T09:21:41.305497Z","steps":["trace[1273660139] 'read index received' (duration: 102.354307ms)","trace[1273660139] 'applied index is now lower than readState.Index' (duration: 233.735µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:21:41.306042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.148663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-08-14T09:21:41.306106Z","caller":"traceutil/trace.go:171","msg":"trace[294757820] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2109; }","duration":"103.265475ms","start":"2026-08-14T09:21:41.202825Z","end":"2026-08-14T09:21:41.306091Z","steps":["trace[294757820] 'agreement among raft nodes before linearized reading' (duration: 102.900198ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:21:42.226064Z","caller":"traceutil/trace.go:171","msg":"trace[296979593] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"357.985853ms","start":"2026-08-14T09:21:41.868056Z","end":"2026-08-14T09:21:42.226042Z","steps":["trace[296979593] 'process raft request' (duration: 357.861131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:21:42.226222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:21:41.868019Z","time spent":"358.134696ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:21:42.226405Z","caller":"traceutil/trace.go:171","msg":"trace[613590444] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2201; }","duration":"301.477717ms","start":"2026-08-14T09:21:41.924906Z","end":"2026-08-14T09:21:42.226384Z","steps":["trace[613590444] 'read index received' (duration: 301.470587ms)","trace[613590444] 'applied index is now lower than readState.Index' (duration: 5.78µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:21:42.226642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.718731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:21:42.226741Z","caller":"traceutil/trace.go:171","msg":"trace[445826354] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2111; }","duration":"301.845104ms","start":"2026-08-14T09:21:41.924879Z","end":"2026-08-14T09:21:42.226724Z","steps":["trace[445826354] 'agreement among raft nodes before linearized reading' (duration: 301.694532ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:21:42.226782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.09515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-14T09:21:42.226853Z","caller":"traceutil/trace.go:171","msg":"trace[229391572] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2111; }","duration":"156.202113ms","start":"2026-08-14T09:21:42.070632Z","end":"2026-08-14T09:21:42.226835Z","steps":["trace[229391572] 'agreement among raft nodes before linearized reading' (duration: 156.05139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:21:42.227216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.26987ms","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-08-14T09:21:42.227278Z","caller":"traceutil/trace.go:171","msg":"trace[310251491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2111; }","duration":"160.369442ms","start":"2026-08-14T09:21:42.066893Z","end":"2026-08-14T09:21:42.227263Z","steps":["trace[310251491] 'agreement among raft nodes before linearized reading' (duration: 160.22621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:21:42.227441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.076094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-14T09:21:42.227486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:21:41.924866Z","time spent":"301.950007ms","remote":"127.0.0.1:38882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-08-14T09:21:42.227499Z","caller":"traceutil/trace.go:171","msg":"trace[1708120920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2111; }","duration":"162.90773ms","start":"2026-08-14T09:21:42.064575Z","end":"2026-08-14T09:21:42.227483Z","steps":["trace[1708120920] 'agreement among raft nodes before linearized reading' (duration: 162.026883ms)"],"step_count":1}