{"level":"warn","ts":"2026-08-24T15:41:05.239983Z","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-24T15:41:05.240065Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.243: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.243:2380","--initial-cluster=instance=https://199.19.213.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.243: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-24T15:41:05.240133Z","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-24T15:41:05.240147Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-08-24T15:41:05.240168Z","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-24T15:41:05.240791Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"]} {"level":"info","ts":"2026-08-24T15:41:05.240863Z","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.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.243: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-24T15:41:05.245775Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.713592ms"} {"level":"info","ts":"2026-08-24T15:41:05.259631Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"864e14457b828f9c","cluster-id":"6c0ae60a355554b9"} {"level":"info","ts":"2026-08-24T15:41:05.259714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:41:05.259734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 0"} {"level":"info","ts":"2026-08-24T15:41:05.259744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 864e14457b828f9c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:41:05.259751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 1"} {"level":"info","ts":"2026-08-24T15:41:05.259788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"warn","ts":"2026-08-24T15:41:05.272733Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:41:05.275219Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:41:05.27701Z","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-24T15:41:05.280208Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"864e14457b828f9c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:41:05.28043Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"864e14457b828f9c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:41:05.280614Z","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-24T15:41:05.280697Z","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-24T15:41:05.280713Z","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-24T15:41:05.282721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"info","ts":"2026-08-24T15:41:05.283018Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","added-peer-id":"864e14457b828f9c","added-peer-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-08-24T15:41:05.286126Z","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-24T15:41:05.286291Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-08-24T15:41:05.286386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-08-24T15:41:05.286554Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"864e14457b828f9c","initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:41:05.286621Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:41:06.061053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:41:06.06111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:41:06.061148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgPreVoteResp from 864e14457b828f9c at term 1"} {"level":"info","ts":"2026-08-24T15:41:06.061172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:41:06.061196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgVoteResp from 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-08-24T15:41:06.061216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became leader at term 2"} {"level":"info","ts":"2026-08-24T15:41:06.061234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 864e14457b828f9c elected leader 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-08-24T15:41:06.062666Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"864e14457b828f9c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.243:2379]}","request-path":"/0/members/864e14457b828f9c/attributes","cluster-id":"6c0ae60a355554b9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:41:06.062731Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:41:06.063358Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:41:06.063696Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:41:06.065074Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:41:06.065113Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:41:06.065468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.243:2379"} {"level":"info","ts":"2026-08-24T15:41:06.06559Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:41:06.065715Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:41:06.065753Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:41:06.067071Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-24T15:41:12.659497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.226375ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:41:12.659629Z","caller":"traceutil/trace.go:171","msg":"trace[1882777237] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:297; }","duration":"261.104282ms","start":"2026-08-24T15:41:12.398507Z","end":"2026-08-24T15:41:12.659611Z","steps":["trace[1882777237] 'read index received' (duration: 41.18µs)","trace[1882777237] 'applied index is now lower than readState.Index' (duration: 261.061722ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:12.659762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.246195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T15:41:12.659797Z","caller":"traceutil/trace.go:171","msg":"trace[597540384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:285; }","duration":"261.307446ms","start":"2026-08-24T15:41:12.39848Z","end":"2026-08-24T15:41:12.659787Z","steps":["trace[597540384] 'agreement among raft nodes before linearized reading' (duration: 261.204884ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:12.659844Z","caller":"traceutil/trace.go:171","msg":"trace[440923737] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"281.973ms","start":"2026-08-24T15:41:12.377766Z","end":"2026-08-24T15:41:12.659739Z","steps":["trace[440923737] 'process raft request' (duration: 13.001086ms)","trace[440923737] 'compare' (duration: 268.065133ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:13.167165Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348322190846553507,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:41:13.795936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.777597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:41:13.796103Z","caller":"traceutil/trace.go:171","msg":"trace[579956038] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:298; }","duration":"1.129572121s","start":"2026-08-24T15:41:12.666469Z","end":"2026-08-24T15:41:13.796041Z","steps":["trace[579956038] 'read index received' (duration: 760.352158ms)","trace[579956038] 'applied index is now lower than readState.Index' (duration: 369.218832ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:13.796225Z","caller":"traceutil/trace.go:171","msg":"trace[1876779689] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"1.130847917s","start":"2026-08-24T15:41:12.665363Z","end":"2026-08-24T15:41:13.79621Z","steps":["trace[1876779689] 'process raft request' (duration: 761.579974ms)","trace[1876779689] 'compare' (duration: 368.646345ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:13.796331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:12.665346Z","time spent":"1.130917307s","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:41:13.796573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114671539s","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-24T15:41:13.79696Z","caller":"traceutil/trace.go:171","msg":"trace[1647645508] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:286; }","duration":"1.115041454s","start":"2026-08-24T15:41:12.681874Z","end":"2026-08-24T15:41:13.796915Z","steps":["trace[1647645508] 'agreement among raft nodes before linearized reading' (duration: 1.114623018s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:13.797166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:12.681812Z","time spent":"1.115339898s","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:41:13.796723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13024848s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-24T15:41:13.797323Z","caller":"traceutil/trace.go:171","msg":"trace[2072116912] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:286; }","duration":"1.130842996s","start":"2026-08-24T15:41:12.66644Z","end":"2026-08-24T15:41:13.797283Z","steps":["trace[2072116912] 'agreement among raft nodes before linearized reading' (duration: 1.130200868s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:13.797401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:12.666431Z","time spent":"1.130931987s","remote":"127.0.0.1:54146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-24T15:41:14.463189Z","caller":"traceutil/trace.go:171","msg":"trace[77598759] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"657.28819ms","start":"2026-08-24T15:41:13.805877Z","end":"2026-08-24T15:41:14.463165Z","steps":["trace[77598759] 'process raft request' (duration: 657.150577ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:14.463399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:13.805859Z","time spent":"657.441291ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:41:14.466723Z","caller":"traceutil/trace.go:171","msg":"trace[2010324846] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:299; }","duration":"139.20491ms","start":"2026-08-24T15:41:14.327488Z","end":"2026-08-24T15:41:14.466693Z","steps":["trace[2010324846] 'read index received' (duration: 135.515393ms)","trace[2010324846] 'applied index is now lower than readState.Index' (duration: 3.688317ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:14.466926Z","caller":"traceutil/trace.go:171","msg":"trace[471309379] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"660.784223ms","start":"2026-08-24T15:41:13.806119Z","end":"2026-08-24T15:41:14.466903Z","steps":["trace[471309379] 'process raft request' (duration: 660.362578ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:14.467033Z","caller":"traceutil/trace.go:171","msg":"trace[1335305176] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"646.628413ms","start":"2026-08-24T15:41:13.820386Z","end":"2026-08-24T15:41:14.467014Z","steps":["trace[1335305176] 'process raft request' (duration: 646.229578ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:14.467453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:13.820372Z","time spent":"647.014259ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:41:14.46707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.566495ms","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-24T15:41:14.467647Z","caller":"traceutil/trace.go:171","msg":"trace[1277327607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:289; }","duration":"140.190743ms","start":"2026-08-24T15:41:14.327437Z","end":"2026-08-24T15:41:14.467628Z","steps":["trace[1277327607] 'agreement among raft nodes before linearized reading' (duration: 139.551994ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:14.467355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:13.806113Z","time spent":"661.164518ms","remote":"127.0.0.1:54222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-24T15:41:16.096921Z","caller":"traceutil/trace.go:171","msg":"trace[1900549232] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:328; }","duration":"122.54846ms","start":"2026-08-24T15:41:15.974352Z","end":"2026-08-24T15:41:16.0969Z","steps":["trace[1900549232] 'read index received' (duration: 108.464002ms)","trace[1900549232] 'applied index is now lower than readState.Index' (duration: 14.083438ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:16.096989Z","caller":"traceutil/trace.go:171","msg":"trace[1105127216] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"148.005583ms","start":"2026-08-24T15:41:15.94896Z","end":"2026-08-24T15:41:16.096965Z","steps":["trace[1105127216] 'process raft request' (duration: 133.892695ms)","trace[1105127216] 'compare' (duration: 13.930286ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:16.097148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.784884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-08-24T15:41:16.097195Z","caller":"traceutil/trace.go:171","msg":"trace[1212217871] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:316; }","duration":"122.869354ms","start":"2026-08-24T15:41:15.974311Z","end":"2026-08-24T15:41:16.09718Z","steps":["trace[1212217871] 'agreement among raft nodes before linearized reading' (duration: 122.699751ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.873172Z","caller":"traceutil/trace.go:171","msg":"trace[126314709] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"210.041204ms","start":"2026-08-24T15:41:41.663107Z","end":"2026-08-24T15:41:41.873149Z","steps":["trace[126314709] 'process raft request' (duration: 209.924853ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883518Z","caller":"traceutil/trace.go:171","msg":"trace[1773505511] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"218.076159ms","start":"2026-08-24T15:41:41.665416Z","end":"2026-08-24T15:41:41.883492Z","steps":["trace[1773505511] 'process raft request' (duration: 217.909857ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883626Z","caller":"traceutil/trace.go:171","msg":"trace[1166939956] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"217.818246ms","start":"2026-08-24T15:41:41.665766Z","end":"2026-08-24T15:41:41.883584Z","steps":["trace[1166939956] 'process raft request' (duration: 217.644404ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883683Z","caller":"traceutil/trace.go:171","msg":"trace[950324458] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"179.108538ms","start":"2026-08-24T15:41:41.704565Z","end":"2026-08-24T15:41:41.883673Z","steps":["trace[950324458] 'process raft request' (duration: 178.967246ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883764Z","caller":"traceutil/trace.go:171","msg":"trace[2088497859] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"179.045837ms","start":"2026-08-24T15:41:41.704659Z","end":"2026-08-24T15:41:41.883705Z","steps":["trace[2088497859] 'process raft request' (duration: 178.902736ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883768Z","caller":"traceutil/trace.go:171","msg":"trace[321668386] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"206.524433ms","start":"2026-08-24T15:41:41.677217Z","end":"2026-08-24T15:41:41.883741Z","steps":["trace[321668386] 'process raft request' (duration: 206.222729ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883805Z","caller":"traceutil/trace.go:171","msg":"trace[1825097680] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"188.134804ms","start":"2026-08-24T15:41:41.695663Z","end":"2026-08-24T15:41:41.883798Z","steps":["trace[1825097680] 'process raft request' (duration: 187.822201ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883853Z","caller":"traceutil/trace.go:171","msg":"trace[859970336] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"174.633125ms","start":"2026-08-24T15:41:41.709208Z","end":"2026-08-24T15:41:41.883841Z","steps":["trace[859970336] 'process raft request' (duration: 174.390442ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.883874Z","caller":"traceutil/trace.go:171","msg":"trace[1466018252] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"174.27564ms","start":"2026-08-24T15:41:41.709592Z","end":"2026-08-24T15:41:41.883867Z","steps":["trace[1466018252] 'process raft request' (duration: 174.047108ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.88393Z","caller":"traceutil/trace.go:171","msg":"trace[214375543] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"171.657251ms","start":"2026-08-24T15:41:41.712267Z","end":"2026-08-24T15:41:41.883924Z","steps":["trace[214375543] 'process raft request' (duration: 171.517249ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.88394Z","caller":"traceutil/trace.go:171","msg":"trace[916696450] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"162.719564ms","start":"2026-08-24T15:41:41.721213Z","end":"2026-08-24T15:41:41.883933Z","steps":["trace[916696450] 'process raft request' (duration: 162.609443ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:41.884048Z","caller":"traceutil/trace.go:171","msg":"trace[193621175] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"146.137708ms","start":"2026-08-24T15:41:41.737903Z","end":"2026-08-24T15:41:41.884041Z","steps":["trace[193621175] 'process raft request' (duration: 145.954986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:42.160795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.756993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:41:42.160962Z","caller":"traceutil/trace.go:171","msg":"trace[1553067388] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:532; }","duration":"222.956872ms","start":"2026-08-24T15:41:41.937977Z","end":"2026-08-24T15:41:42.160934Z","steps":["trace[1553067388] 'read index received' (duration: 4.21385ms)","trace[1553067388] 'applied index is now lower than readState.Index' (duration: 218.742572ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:42.161066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.087963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-24T15:41:42.161081Z","caller":"traceutil/trace.go:171","msg":"trace[1498664407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"223.127283ms","start":"2026-08-24T15:41:41.937949Z","end":"2026-08-24T15:41:42.161076Z","steps":["trace[1498664407] 'agreement among raft nodes before linearized reading' (duration: 223.034122ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.161266Z","caller":"traceutil/trace.go:171","msg":"trace[1752103040] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"223.497769ms","start":"2026-08-24T15:41:41.937738Z","end":"2026-08-24T15:41:42.161236Z","steps":["trace[1752103040] 'process raft request' (duration: 223.141395ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.161372Z","caller":"traceutil/trace.go:171","msg":"trace[974936985] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"225.468251ms","start":"2026-08-24T15:41:41.935894Z","end":"2026-08-24T15:41:42.161362Z","steps":["trace[974936985] 'process raft request' (duration: 22.071471ms)","trace[974936985] 'compare' (duration: 202.647532ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:42.166253Z","caller":"traceutil/trace.go:171","msg":"trace[1841595260] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"197.439699ms","start":"2026-08-24T15:41:41.968789Z","end":"2026-08-24T15:41:42.166229Z","steps":["trace[1841595260] 'process raft request' (duration: 197.317478ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.173515Z","caller":"traceutil/trace.go:171","msg":"trace[789221839] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"203.694664ms","start":"2026-08-24T15:41:41.969799Z","end":"2026-08-24T15:41:42.173494Z","steps":["trace[789221839] 'process raft request' (duration: 203.398001ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.173802Z","caller":"traceutil/trace.go:171","msg":"trace[1158720285] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"203.651293ms","start":"2026-08-24T15:41:41.970132Z","end":"2026-08-24T15:41:42.173783Z","steps":["trace[1158720285] 'process raft request' (duration: 203.259569ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.174017Z","caller":"traceutil/trace.go:171","msg":"trace[1075539808] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"203.809364ms","start":"2026-08-24T15:41:41.97018Z","end":"2026-08-24T15:41:42.17399Z","steps":["trace[1075539808] 'process raft request' (duration: 203.516841ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.174206Z","caller":"traceutil/trace.go:171","msg":"trace[1017607286] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"203.889786ms","start":"2026-08-24T15:41:41.970302Z","end":"2026-08-24T15:41:42.174192Z","steps":["trace[1017607286] 'process raft request' (duration: 203.646083ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:42.17443Z","caller":"traceutil/trace.go:171","msg":"trace[1170871834] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"177.670956ms","start":"2026-08-24T15:41:41.996735Z","end":"2026-08-24T15:41:42.174406Z","steps":["trace[1170871834] 'process raft request' (duration: 177.406942ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:48.164524Z","caller":"traceutil/trace.go:171","msg":"trace[1115263079] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"126.708256ms","start":"2026-08-24T15:41:48.037782Z","end":"2026-08-24T15:41:48.16449Z","steps":["trace[1115263079] 'process raft request' (duration: 125.796865ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:48.390917Z","caller":"traceutil/trace.go:171","msg":"trace[1407865880] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"212.737828ms","start":"2026-08-24T15:41:48.178135Z","end":"2026-08-24T15:41:48.390872Z","steps":["trace[1407865880] 'process raft request' (duration: 163.753757ms)","trace[1407865880] 'compare' (duration: 48.771518ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:48.390942Z","caller":"traceutil/trace.go:171","msg":"trace[1937925856] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"186.427382ms","start":"2026-08-24T15:41:48.204496Z","end":"2026-08-24T15:41:48.390924Z","steps":["trace[1937925856] 'read index received' (duration: 137.503452ms)","trace[1937925856] 'applied index is now lower than readState.Index' (duration: 48.923009ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:48.391455Z","caller":"traceutil/trace.go:171","msg":"trace[589896514] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"150.428223ms","start":"2026-08-24T15:41:48.240998Z","end":"2026-08-24T15:41:48.391426Z","steps":["trace[589896514] 'process raft request' (duration: 149.777065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:48.39267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.153203ms","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-24T15:41:48.39273Z","caller":"traceutil/trace.go:171","msg":"trace[2044929369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"188.314624ms","start":"2026-08-24T15:41:48.2044Z","end":"2026-08-24T15:41:48.392715Z","steps":["trace[2044929369] 'agreement among raft nodes before linearized reading' (duration: 186.579144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:48.904024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348322190846554168,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-24T15:41:49.252948Z","caller":"traceutil/trace.go:171","msg":"trace[1951576568] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"849.430779ms","start":"2026-08-24T15:41:48.403455Z","end":"2026-08-24T15:41:49.252886Z","steps":["trace[1951576568] 'read index received' (duration: 774.263215ms)","trace[1951576568] 'applied index is now lower than readState.Index' (duration: 75.166574ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:49.253169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.613676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:41:49.253249Z","caller":"traceutil/trace.go:171","msg":"trace[642527738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"482.787817ms","start":"2026-08-24T15:41:48.770448Z","end":"2026-08-24T15:41:49.253236Z","steps":["trace[642527738] 'agreement among raft nodes before linearized reading' (duration: 482.612655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:49.253238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.981828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.243\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-24T15:41:49.25332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.770417Z","time spent":"482.894709ms","remote":"127.0.0.1:53998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:41:49.253236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.736608ms","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-24T15:41:49.253309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.747079ms","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-24T15:41:49.253363Z","caller":"traceutil/trace.go:171","msg":"trace[1729063978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"525.901789ms","start":"2026-08-24T15:41:48.727451Z","end":"2026-08-24T15:41:49.253353Z","steps":["trace[1729063978] 'agreement among raft nodes before linearized reading' (duration: 525.670027ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:49.253352Z","caller":"traceutil/trace.go:171","msg":"trace[501501153] range","detail":"{range_begin:/registry/masterleases/199.19.213.243; range_end:; response_count:1; response_revision:598; }","duration":"177.137499ms","start":"2026-08-24T15:41:49.076185Z","end":"2026-08-24T15:41:49.253322Z","steps":["trace[501501153] 'agreement among raft nodes before linearized reading' (duration: 176.949227ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:49.253416Z","caller":"traceutil/trace.go:171","msg":"trace[930265594] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"525.92766ms","start":"2026-08-24T15:41:48.727459Z","end":"2026-08-24T15:41:49.253386Z","steps":["trace[930265594] 'agreement among raft nodes before linearized reading' (duration: 525.620386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:49.253429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.727436Z","time spent":"525.960431ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-24T15:41:49.253463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.727416Z","time spent":"526.037643ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-24T15:41:49.253536Z","caller":"traceutil/trace.go:171","msg":"trace[1289324010] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"856.196377ms","start":"2026-08-24T15:41:48.396777Z","end":"2026-08-24T15:41:49.252974Z","steps":["trace[1289324010] 'process raft request' (duration: 780.967252ms)","trace[1289324010] 'compare' (duration: 74.675759ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:49.253428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.784613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:41:49.253655Z","caller":"traceutil/trace.go:171","msg":"trace[447990813] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:598; }","duration":"850.163798ms","start":"2026-08-24T15:41:48.40342Z","end":"2026-08-24T15:41:49.253584Z","steps":["trace[447990813] 'agreement among raft nodes before linearized reading' (duration: 849.761183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:49.253728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.396748Z","time spent":"856.853885ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:41:49.253786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.403407Z","time spent":"850.315789ms","remote":"127.0.0.1:54266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-08-24T15:41:49.253861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.8143ms","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-24T15:41:49.253899Z","caller":"traceutil/trace.go:171","msg":"trace[1244816996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"636.429358ms","start":"2026-08-24T15:41:48.617459Z","end":"2026-08-24T15:41:49.253888Z","steps":["trace[1244816996] 'agreement among raft nodes before linearized reading' (duration: 635.580708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:49.253951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:48.617436Z","time spent":"636.506959ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:41:50.270951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348322190846554171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:41:50.771524Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348322190846554171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-24T15:41:50.985443Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.336924219s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-24T15:41:50.989878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.584180733s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:41:50.99215Z","caller":"traceutil/trace.go:171","msg":"trace[995068048] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.692769485s","start":"2026-08-24T15:41:49.299328Z","end":"2026-08-24T15:41:50.992097Z","steps":["trace[995068048] 'process raft request' (duration: 106.280315ms)","trace[995068048] 'compare' (duration: 1.584026522s)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:41:50.992505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:49.299291Z","time spent":"1.692980397s","remote":"127.0.0.1:54044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:41:50.998342Z","caller":"traceutil/trace.go:171","msg":"trace[1275694692] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"1.228167884s","start":"2026-08-24T15:41:49.770126Z","end":"2026-08-24T15:41:50.998294Z","steps":["trace[1275694692] 'read index received' (duration: 1.215647349s)","trace[1275694692] 'applied index is now lower than readState.Index' (duration: 12.519305ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:41:50.998355Z","caller":"traceutil/trace.go:171","msg":"trace[1003067351] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"1.352170286s","start":"2026-08-24T15:41:49.646159Z","end":"2026-08-24T15:41:50.998329Z","steps":["trace[1003067351] 'process raft request' (duration: 1.347646253s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:50.998492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228351956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:41:50.998569Z","caller":"traceutil/trace.go:171","msg":"trace[1339829121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.228468017s","start":"2026-08-24T15:41:49.770082Z","end":"2026-08-24T15:41:50.99855Z","steps":["trace[1339829121] 'agreement among raft nodes before linearized reading' (duration: 1.228303125s)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:50.998606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:49.770062Z","time spent":"1.228537178s","remote":"127.0.0.1:53988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:41:50.998645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:49.646132Z","time spent":"1.352408348s","remote":"127.0.0.1:54124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:41:55.777851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.204549ms","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-24T15:41:55.777913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.844566ms","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-24T15:41:55.777944Z","caller":"traceutil/trace.go:171","msg":"trace[554534002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"421.346501ms","start":"2026-08-24T15:41:55.356571Z","end":"2026-08-24T15:41:55.777918Z","steps":["trace[554534002] 'range keys from in-memory index tree' (duration: 420.891186ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:41:55.777998Z","caller":"traceutil/trace.go:171","msg":"trace[11601891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"420.952556ms","start":"2026-08-24T15:41:55.357017Z","end":"2026-08-24T15:41:55.77797Z","steps":["trace[11601891] 'range keys from in-memory index tree' (duration: 420.669603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:55.778003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:55.356539Z","time spent":"421.451393ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-24T15:41:55.778042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:55.357011Z","time spent":"421.021548ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:41:55.778055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.100909ms","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-24T15:41:55.778138Z","caller":"traceutil/trace.go:171","msg":"trace[824690524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"421.274481ms","start":"2026-08-24T15:41:55.356844Z","end":"2026-08-24T15:41:55.778119Z","steps":["trace[824690524] 'range keys from in-memory index tree' (duration: 420.918076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:41:55.778185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:41:55.35682Z","time spent":"421.354742ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-24T15:42:09.176653Z","caller":"traceutil/trace.go:171","msg":"trace[55740101] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"136.716344ms","start":"2026-08-24T15:42:09.039915Z","end":"2026-08-24T15:42:09.176631Z","steps":["trace[55740101] 'process raft request' (duration: 136.600333ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:42:09.179626Z","caller":"traceutil/trace.go:171","msg":"trace[2013012794] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:792; }","duration":"102.334638ms","start":"2026-08-24T15:42:09.077271Z","end":"2026-08-24T15:42:09.179605Z","steps":["trace[2013012794] 'read index received' (duration: 99.292354ms)","trace[2013012794] 'applied index is now lower than readState.Index' (duration: 3.041224ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:42:09.179728Z","caller":"traceutil/trace.go:171","msg":"trace[839652558] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"119.716823ms","start":"2026-08-24T15:42:09.05998Z","end":"2026-08-24T15:42:09.179697Z","steps":["trace[839652558] 'process raft request' (duration: 119.507921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:09.179817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.53694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.243\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:42:09.179902Z","caller":"traceutil/trace.go:171","msg":"trace[2141010607] range","detail":"{range_begin:/registry/masterleases/199.19.213.243; range_end:; response_count:1; response_revision:766; }","duration":"102.655572ms","start":"2026-08-24T15:42:09.07721Z","end":"2026-08-24T15:42:09.179866Z","steps":["trace[2141010607] 'agreement among raft nodes before linearized reading' (duration: 102.48636ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:42:10.157105Z","caller":"traceutil/trace.go:171","msg":"trace[1436915616] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"385.467633ms","start":"2026-08-24T15:42:09.77162Z","end":"2026-08-24T15:42:10.157088Z","steps":["trace[1436915616] 'read index received' (duration: 385.272731ms)","trace[1436915616] 'applied index is now lower than readState.Index' (duration: 194.362µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:42:10.157169Z","caller":"traceutil/trace.go:171","msg":"trace[1196872753] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"811.904257ms","start":"2026-08-24T15:42:09.345249Z","end":"2026-08-24T15:42:10.157153Z","steps":["trace[1196872753] 'process raft request' (duration: 811.727006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.157227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.601654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:42:10.157259Z","caller":"traceutil/trace.go:171","msg":"trace[974082732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:773; }","duration":"385.682576ms","start":"2026-08-24T15:42:09.771566Z","end":"2026-08-24T15:42:10.157249Z","steps":["trace[974082732] 'agreement among raft nodes before linearized reading' (duration: 385.619485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.157267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:09.345222Z","time spent":"811.982238ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:42:10.157286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:09.771539Z","time spent":"385.740077ms","remote":"127.0.0.1:53988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-24T15:42:10.157487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.666392ms","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-24T15:42:10.157529Z","caller":"traceutil/trace.go:171","msg":"trace[510435665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"308.739202ms","start":"2026-08-24T15:42:09.848779Z","end":"2026-08-24T15:42:10.157518Z","steps":["trace[510435665] 'agreement among raft nodes before linearized reading' (duration: 308.621021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.157556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:09.848762Z","time spent":"308.786063ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-24T15:42:10.157639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.089789ms","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-24T15:42:10.15767Z","caller":"traceutil/trace.go:171","msg":"trace[1476321760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:773; }","duration":"304.139561ms","start":"2026-08-24T15:42:09.853521Z","end":"2026-08-24T15:42:10.157661Z","steps":["trace[1476321760] 'agreement among raft nodes before linearized reading' (duration: 304.05702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.157721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:09.853513Z","time spent":"304.199831ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-24T15:42:10.15775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.763748ms","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-24T15:42:10.157827Z","caller":"traceutil/trace.go:171","msg":"trace[824142774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:773; }","duration":"304.882409ms","start":"2026-08-24T15:42:09.852928Z","end":"2026-08-24T15:42:10.15781Z","steps":["trace[824142774] 'agreement among raft nodes before linearized reading' (duration: 304.674117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.157881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:09.852907Z","time spent":"304.96148ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-24T15:42:10.15793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.837756ms","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-24T15:42:10.157988Z","caller":"traceutil/trace.go:171","msg":"trace[439820183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:773; }","duration":"106.933668ms","start":"2026-08-24T15:42:10.051039Z","end":"2026-08-24T15:42:10.157972Z","steps":["trace[439820183] 'agreement among raft nodes before linearized reading' (duration: 106.742146ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:42:10.610322Z","caller":"traceutil/trace.go:171","msg":"trace[821190027] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"448.485365ms","start":"2026-08-24T15:42:10.161804Z","end":"2026-08-24T15:42:10.61029Z","steps":["trace[821190027] 'process raft request' (duration: 399.484946ms)","trace[821190027] 'compare' (duration: 48.789977ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:42:10.610468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:10.161785Z","time spent":"448.610416ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:42:10.614813Z","caller":"traceutil/trace.go:171","msg":"trace[1653530249] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"452.51111ms","start":"2026-08-24T15:42:10.162293Z","end":"2026-08-24T15:42:10.614804Z","steps":["trace[1653530249] 'process raft request' (duration: 452.46247ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:42:10.614823Z","caller":"traceutil/trace.go:171","msg":"trace[71438677] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"452.52386ms","start":"2026-08-24T15:42:10.162277Z","end":"2026-08-24T15:42:10.614801Z","steps":["trace[71438677] 'process raft request' (duration: 452.403999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.614867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:10.162269Z","time spent":"452.572811ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:42:10.614948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:10.162252Z","time spent":"452.620531ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:42:10.615092Z","caller":"traceutil/trace.go:171","msg":"trace[478945141] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"367.305866ms","start":"2026-08-24T15:42:10.247778Z","end":"2026-08-24T15:42:10.615084Z","steps":["trace[478945141] 'process raft request' (duration: 367.157234ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.61515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:10.247748Z","time spent":"367.367707ms","remote":"127.0.0.1:54266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:42:10.615182Z","caller":"traceutil/trace.go:171","msg":"trace[43256925] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"452.120756ms","start":"2026-08-24T15:42:10.16295Z","end":"2026-08-24T15:42:10.615071Z","steps":["trace[43256925] 'process raft request' (duration: 451.828862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:42:10.615368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:42:10.162942Z","time spent":"452.325818ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:43:05.029034Z","caller":"traceutil/trace.go:171","msg":"trace[1908107988] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"126.877653ms","start":"2026-08-24T15:43:04.902127Z","end":"2026-08-24T15:43:05.029004Z","steps":["trace[1908107988] 'process raft request' (duration: 124.289295ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:05.03451Z","caller":"traceutil/trace.go:171","msg":"trace[418383245] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1128; }","duration":"103.211623ms","start":"2026-08-24T15:43:04.93128Z","end":"2026-08-24T15:43:05.034491Z","steps":["trace[418383245] 'read index received' (duration: 95.129037ms)","trace[418383245] 'applied index is now lower than readState.Index' (duration: 8.081546ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:05.034537Z","caller":"traceutil/trace.go:171","msg":"trace[1700335059] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"132.187719ms","start":"2026-08-24T15:43:04.90231Z","end":"2026-08-24T15:43:05.034498Z","steps":["trace[1700335059] 'process raft request' (duration: 132.037008ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:05.034571Z","caller":"traceutil/trace.go:171","msg":"trace[625238156] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"131.026687ms","start":"2026-08-24T15:43:04.903528Z","end":"2026-08-24T15:43:05.034555Z","steps":["trace[625238156] 'process raft request' (duration: 130.926196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:43:05.034683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.348164ms","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-24T15:43:05.03472Z","caller":"traceutil/trace.go:171","msg":"trace[2052446404] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1087; }","duration":"103.467206ms","start":"2026-08-24T15:43:04.931241Z","end":"2026-08-24T15:43:05.034709Z","steps":["trace[2052446404] 'agreement among raft nodes before linearized reading' (duration: 103.340625ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:12.908189Z","caller":"traceutil/trace.go:171","msg":"trace[1537044360] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"136.203836ms","start":"2026-08-24T15:43:12.771959Z","end":"2026-08-24T15:43:12.908163Z","steps":["trace[1537044360] 'read index received' (duration: 136.000784ms)","trace[1537044360] 'applied index is now lower than readState.Index' (duration: 202.232µs)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:43:12.90832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.340977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:43:12.90831Z","caller":"traceutil/trace.go:171","msg":"trace[672182917] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"262.494286ms","start":"2026-08-24T15:43:12.645777Z","end":"2026-08-24T15:43:12.908271Z","steps":["trace[672182917] 'process raft request' (duration: 262.234054ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:12.908371Z","caller":"traceutil/trace.go:171","msg":"trace[1133003288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1109; }","duration":"136.440248ms","start":"2026-08-24T15:43:12.771909Z","end":"2026-08-24T15:43:12.90835Z","steps":["trace[1133003288] 'agreement among raft nodes before linearized reading' (duration: 136.355127ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:13.109145Z","caller":"traceutil/trace.go:171","msg":"trace[1709145970] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"157.484859ms","start":"2026-08-24T15:43:12.951616Z","end":"2026-08-24T15:43:13.109101Z","steps":["trace[1709145970] 'process raft request' (duration: 59.952172ms)","trace[1709145970] 'compare' (duration: 97.315064ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:13.293765Z","caller":"traceutil/trace.go:171","msg":"trace[1821832230] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"102.467969ms","start":"2026-08-24T15:43:13.191271Z","end":"2026-08-24T15:43:13.293739Z","steps":["trace[1821832230] 'process raft request' (duration: 71.072629ms)","trace[1821832230] 'compare' (duration: 31.179678ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:13.293888Z","caller":"traceutil/trace.go:171","msg":"trace[806027886] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"102.256287ms","start":"2026-08-24T15:43:13.191604Z","end":"2026-08-24T15:43:13.29386Z","steps":["trace[806027886] 'process raft request' (duration: 102.090146ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:37.477867Z","caller":"traceutil/trace.go:171","msg":"trace[1237387042] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"182.766712ms","start":"2026-08-24T15:43:37.295075Z","end":"2026-08-24T15:43:37.477842Z","steps":["trace[1237387042] 'read index received' (duration: 182.50672ms)","trace[1237387042] 'applied index is now lower than readState.Index' (duration: 259.052µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:37.477928Z","caller":"traceutil/trace.go:171","msg":"trace[1834022217] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"257.689082ms","start":"2026-08-24T15:43:37.220211Z","end":"2026-08-24T15:43:37.4779Z","steps":["trace[1834022217] 'process raft request' (duration: 257.418119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:43:37.478107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.014145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-24T15:43:37.478157Z","caller":"traceutil/trace.go:171","msg":"trace[1367109947] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1189; }","duration":"183.104926ms","start":"2026-08-24T15:43:37.295034Z","end":"2026-08-24T15:43:37.478139Z","steps":["trace[1367109947] 'agreement among raft nodes before linearized reading' (duration: 182.944234ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:43:37.478969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.606352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-08-24T15:43:37.479096Z","caller":"traceutil/trace.go:171","msg":"trace[972191845] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1189; }","duration":"162.768873ms","start":"2026-08-24T15:43:37.316306Z","end":"2026-08-24T15:43:37.479074Z","steps":["trace[972191845] 'agreement among raft nodes before linearized reading' (duration: 161.795053ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:43:37.67289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.770461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:43:37.673271Z","caller":"traceutil/trace.go:171","msg":"trace[1275142027] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"190.531963ms","start":"2026-08-24T15:43:37.482709Z","end":"2026-08-24T15:43:37.673241Z","steps":["trace[1275142027] 'process raft request' (duration: 190.445532ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:37.673389Z","caller":"traceutil/trace.go:171","msg":"trace[1761786712] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"190.639065ms","start":"2026-08-24T15:43:37.48274Z","end":"2026-08-24T15:43:37.673379Z","steps":["trace[1761786712] 'process raft request' (duration: 190.469642ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:37.673268Z","caller":"traceutil/trace.go:171","msg":"trace[633534390] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"190.562782ms","start":"2026-08-24T15:43:37.482664Z","end":"2026-08-24T15:43:37.673227Z","steps":["trace[633534390] 'process raft request' (duration: 80.382447ms)","trace[633534390] 'compare' (duration: 109.67425ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:43:37.93897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.61158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T15:43:37.939367Z","caller":"traceutil/trace.go:171","msg":"trace[1493951875] linearizableReadLoop","detail":"{readStateIndex:1243; appliedIndex:1242; }","duration":"278.358856ms","start":"2026-08-24T15:43:37.660986Z","end":"2026-08-24T15:43:37.939345Z","steps":["trace[1493951875] 'read index received' (duration: 169.302702ms)","trace[1493951875] 'applied index is now lower than readState.Index' (duration: 109.053594ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:37.93943Z","caller":"traceutil/trace.go:171","msg":"trace[1580465284] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"336.586203ms","start":"2026-08-24T15:43:37.6028Z","end":"2026-08-24T15:43:37.939386Z","steps":["trace[1580465284] 'process raft request' (duration: 227.474037ms)","trace[1580465284] 'compare' (duration: 108.344167ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:43:37.939626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:43:37.602774Z","time spent":"336.747694ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:43:37.940592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.598108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-08-24T15:43:37.940652Z","caller":"traceutil/trace.go:171","msg":"trace[1509518682] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1193; }","duration":"279.684809ms","start":"2026-08-24T15:43:37.660949Z","end":"2026-08-24T15:43:37.940634Z","steps":["trace[1509518682] 'agreement among raft nodes before linearized reading' (duration: 278.475787ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:55.350749Z","caller":"traceutil/trace.go:171","msg":"trace[180767651] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"102.735081ms","start":"2026-08-24T15:43:55.24798Z","end":"2026-08-24T15:43:55.350715Z","steps":["trace[180767651] 'process raft request' (duration: 81.922136ms)","trace[180767651] 'compare' (duration: 20.558283ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:43:56.162701Z","caller":"traceutil/trace.go:171","msg":"trace[199790514] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"102.658071ms","start":"2026-08-24T15:43:56.059793Z","end":"2026-08-24T15:43:56.162451Z","steps":["trace[199790514] 'process raft request' (duration: 102.380708ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:58.3706Z","caller":"traceutil/trace.go:171","msg":"trace[1577353049] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"201.648403ms","start":"2026-08-24T15:43:58.16892Z","end":"2026-08-24T15:43:58.370568Z","steps":["trace[1577353049] 'process raft request' (duration: 201.493872ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:58.418375Z","caller":"traceutil/trace.go:171","msg":"trace[1983807828] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"168.379239ms","start":"2026-08-24T15:43:58.249971Z","end":"2026-08-24T15:43:58.418351Z","steps":["trace[1983807828] 'process raft request' (duration: 168.245447ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:43:59.245963Z","caller":"traceutil/trace.go:171","msg":"trace[919840616] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"112.554292ms","start":"2026-08-24T15:43:59.133381Z","end":"2026-08-24T15:43:59.245936Z","steps":["trace[919840616] 'process raft request' (duration: 73.409448ms)","trace[919840616] 'compare' (duration: 39.025613ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:06.796766Z","caller":"traceutil/trace.go:171","msg":"trace[1984810239] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1380; }","duration":"373.131895ms","start":"2026-08-24T15:44:06.423613Z","end":"2026-08-24T15:44:06.796745Z","steps":["trace[1984810239] 'read index received' (duration: 372.973234ms)","trace[1984810239] 'applied index is now lower than readState.Index' (duration: 157.771µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:06.797167Z","caller":"traceutil/trace.go:171","msg":"trace[1254750219] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"401.829241ms","start":"2026-08-24T15:44:06.395323Z","end":"2026-08-24T15:44:06.797153Z","steps":["trace[1254750219] 'process raft request' (duration: 401.316166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:06.797264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.634641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:44:06.797328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:44:06.395289Z","time spent":"401.918063ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:44:06.797334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.382595ms","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-24T15:44:06.797421Z","caller":"traceutil/trace.go:171","msg":"trace[651810649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1323; }","duration":"329.519106ms","start":"2026-08-24T15:44:06.467881Z","end":"2026-08-24T15:44:06.7974Z","steps":["trace[651810649] 'agreement among raft nodes before linearized reading' (duration: 329.276293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:06.79749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:44:06.46786Z","time spent":"329.620777ms","remote":"127.0.0.1:54290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-24T15:44:06.797352Z","caller":"traceutil/trace.go:171","msg":"trace[916533576] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1323; }","duration":"373.790002ms","start":"2026-08-24T15:44:06.423542Z","end":"2026-08-24T15:44:06.797332Z","steps":["trace[916533576] 'agreement among raft nodes before linearized reading' (duration: 373.62531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:06.79762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:44:06.423512Z","time spent":"374.091615ms","remote":"127.0.0.1:54390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-08-24T15:44:29.01609Z","caller":"traceutil/trace.go:171","msg":"trace[1931986015] linearizableReadLoop","detail":"{readStateIndex:1463; appliedIndex:1462; }","duration":"128.268923ms","start":"2026-08-24T15:44:28.887789Z","end":"2026-08-24T15:44:29.016058Z","steps":["trace[1931986015] 'read index received' (duration: 128.124478ms)","trace[1931986015] 'applied index is now lower than readState.Index' (duration: 143.035µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:29.01617Z","caller":"traceutil/trace.go:171","msg":"trace[445429359] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"137.926239ms","start":"2026-08-24T15:44:28.878196Z","end":"2026-08-24T15:44:29.016123Z","steps":["trace[445429359] 'process raft request' (duration: 137.693811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.016292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.4823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-08-24T15:44:29.016354Z","caller":"traceutil/trace.go:171","msg":"trace[1359818283] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1400; }","duration":"128.586232ms","start":"2026-08-24T15:44:28.887754Z","end":"2026-08-24T15:44:29.01634Z","steps":["trace[1359818283] 'agreement among raft nodes before linearized reading' (duration: 128.471318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.016372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.166608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" ","response":"range_response_count:1 size:370"} {"level":"info","ts":"2026-08-24T15:44:29.016465Z","caller":"traceutil/trace.go:171","msg":"trace[1389747153] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking; range_end:; response_count:1; response_revision:1400; }","duration":"118.364603ms","start":"2026-08-24T15:44:28.898076Z","end":"2026-08-24T15:44:29.016441Z","steps":["trace[1389747153] 'agreement among raft nodes before linearized reading' (duration: 118.166846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.531446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.116582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/local-path-storage/\" range_end:\"/registry/persistentvolumeclaims/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:44:29.531524Z","caller":"traceutil/trace.go:171","msg":"trace[821619599] range","detail":"{range_begin:/registry/persistentvolumeclaims/local-path-storage/; range_end:/registry/persistentvolumeclaims/local-path-storage0; response_count:0; response_revision:1402; }","duration":"280.237275ms","start":"2026-08-24T15:44:29.251269Z","end":"2026-08-24T15:44:29.531506Z","steps":["trace[821619599] 'range keys from in-memory index tree' (duration: 280.039529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.531738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.767393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-08-24T15:44:29.531777Z","caller":"traceutil/trace.go:171","msg":"trace[2136582004] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1402; }","duration":"326.835906ms","start":"2026-08-24T15:44:29.20493Z","end":"2026-08-24T15:44:29.531766Z","steps":["trace[2136582004] 'range keys from in-memory index tree' (duration: 326.671131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.531811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:44:29.204914Z","time spent":"326.888448ms","remote":"127.0.0.1:54140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1769,"request content":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" "} {"level":"warn","ts":"2026-08-24T15:44:29.531794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.610159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1949"} {"level":"info","ts":"2026-08-24T15:44:29.531865Z","caller":"traceutil/trace.go:171","msg":"trace[1489039525] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1402; }","duration":"290.706602ms","start":"2026-08-24T15:44:29.241142Z","end":"2026-08-24T15:44:29.531849Z","steps":["trace[1489039525] 'range keys from in-memory index tree' (duration: 290.518036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.532304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.152808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329944"} {"level":"info","ts":"2026-08-24T15:44:29.532479Z","caller":"traceutil/trace.go:171","msg":"trace[2071871136] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1402; }","duration":"250.368076ms","start":"2026-08-24T15:44:29.282093Z","end":"2026-08-24T15:44:29.532461Z","steps":["trace[2071871136] 'range keys from in-memory index tree' (duration: 249.263669ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:44:29.828593Z","caller":"traceutil/trace.go:171","msg":"trace[402607255] linearizableReadLoop","detail":"{readStateIndex:1467; appliedIndex:1466; }","duration":"142.415791ms","start":"2026-08-24T15:44:29.686162Z","end":"2026-08-24T15:44:29.828577Z","steps":["trace[402607255] 'read index received' (duration: 142.290937ms)","trace[402607255] 'applied index is now lower than readState.Index' (duration: 124.224µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:29.828672Z","caller":"traceutil/trace.go:171","msg":"trace[1612348241] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"152.297329ms","start":"2026-08-24T15:44:29.676367Z","end":"2026-08-24T15:44:29.828664Z","steps":["trace[1612348241] 'process raft request' (duration: 152.123293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.82883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.641323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubelet-config\" ","response":"range_response_count:1 size:1357"} {"level":"info","ts":"2026-08-24T15:44:29.828896Z","caller":"traceutil/trace.go:171","msg":"trace[1678679173] range","detail":"{range_begin:/registry/configmaps/kube-system/kubelet-config; range_end:; response_count:1; response_revision:1403; }","duration":"136.771778ms","start":"2026-08-24T15:44:29.69211Z","end":"2026-08-24T15:44:29.828881Z","steps":["trace[1678679173] 'agreement among raft nodes before linearized reading' (duration: 136.605633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.829054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.798521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/local-path-storage/\" range_end:\"/registry/roles/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:44:29.829132Z","caller":"traceutil/trace.go:171","msg":"trace[1698310336] range","detail":"{range_begin:/registry/roles/local-path-storage/; range_end:/registry/roles/local-path-storage0; response_count:0; response_revision:1403; }","duration":"134.911595ms","start":"2026-08-24T15:44:29.694204Z","end":"2026-08-24T15:44:29.829115Z","steps":["trace[1698310336] 'agreement among raft nodes before linearized reading' (duration: 134.76712ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.829297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.104756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/\" range_end:\"/registry/serviceaccounts/kube-system0\" limit:500 ","response":"range_response_count:37 size:8042"} {"level":"info","ts":"2026-08-24T15:44:29.829411Z","caller":"traceutil/trace.go:171","msg":"trace[1547562891] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/; range_end:/registry/serviceaccounts/kube-system0; response_count:37; response_revision:1403; }","duration":"143.210789ms","start":"2026-08-24T15:44:29.686152Z","end":"2026-08-24T15:44:29.829363Z","steps":["trace[1547562891] 'agreement among raft nodes before linearized reading' (duration: 142.66144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:29.978337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.368093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:69 size:51101"} {"level":"info","ts":"2026-08-24T15:44:29.978417Z","caller":"traceutil/trace.go:171","msg":"trace[1159010623] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:69; response_revision:1403; }","duration":"143.458966ms","start":"2026-08-24T15:44:29.834943Z","end":"2026-08-24T15:44:29.978402Z","steps":["trace[1159010623] 'range keys from in-memory index tree' (duration: 143.072664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:31.239357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.382128ms","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-24T15:44:31.239452Z","caller":"traceutil/trace.go:171","msg":"trace[367417679] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1407; }","duration":"101.488661ms","start":"2026-08-24T15:44:31.137951Z","end":"2026-08-24T15:44:31.23944Z","steps":["trace[367417679] 'range keys from in-memory index tree' (duration: 101.370347ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:44:31.239552Z","caller":"traceutil/trace.go:171","msg":"trace[1315073771] linearizableReadLoop","detail":"{readStateIndex:1472; appliedIndex:1471; }","duration":"140.737708ms","start":"2026-08-24T15:44:31.098791Z","end":"2026-08-24T15:44:31.239529Z","steps":["trace[1315073771] 'read index received' (duration: 139.946421ms)","trace[1315073771] 'applied index is now lower than readState.Index' (duration: 790.417µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:31.239616Z","caller":"traceutil/trace.go:171","msg":"trace[794697384] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"141.6972ms","start":"2026-08-24T15:44:31.097908Z","end":"2026-08-24T15:44:31.239605Z","steps":["trace[794697384] 'process raft request' (duration: 140.915413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:31.239747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.945395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-7s4b9\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-08-24T15:44:31.239782Z","caller":"traceutil/trace.go:171","msg":"trace[1747376280] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-7s4b9; range_end:; response_count:1; response_revision:1408; }","duration":"141.014887ms","start":"2026-08-24T15:44:31.098756Z","end":"2026-08-24T15:44:31.239771Z","steps":["trace[1747376280] 'agreement among raft nodes before linearized reading' (duration: 140.878843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:31.239816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.916639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-jkh96\" ","response":"range_response_count:1 size:4905"} {"level":"info","ts":"2026-08-24T15:44:31.239846Z","caller":"traceutil/trace.go:171","msg":"trace[1426064058] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-jkh96; range_end:; response_count:1; response_revision:1408; }","duration":"139.970111ms","start":"2026-08-24T15:44:31.099866Z","end":"2026-08-24T15:44:31.239836Z","steps":["trace[1426064058] 'agreement among raft nodes before linearized reading' (duration: 139.863178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:31.512462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.470533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5164"} {"level":"info","ts":"2026-08-24T15:44:31.512552Z","caller":"traceutil/trace.go:171","msg":"trace[1683892880] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:1408; }","duration":"107.579406ms","start":"2026-08-24T15:44:31.404952Z","end":"2026-08-24T15:44:31.512532Z","steps":["trace[1683892880] 'range keys from in-memory index tree' (duration: 107.39972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:31.512827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.250779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7111"} {"level":"info","ts":"2026-08-24T15:44:31.512924Z","caller":"traceutil/trace.go:171","msg":"trace[1361610412] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:1408; }","duration":"108.392893ms","start":"2026-08-24T15:44:31.404511Z","end":"2026-08-24T15:44:31.512904Z","steps":["trace[1361610412] 'range keys from in-memory index tree' (duration: 108.137775ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:44:35.398393Z","caller":"traceutil/trace.go:171","msg":"trace[1123774672] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"103.45785ms","start":"2026-08-24T15:44:35.294907Z","end":"2026-08-24T15:44:35.398365Z","steps":["trace[1123774672] 'process raft request' (duration: 51.700655ms)","trace[1123774672] 'compare' (duration: 51.554229ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:38.038052Z","caller":"traceutil/trace.go:171","msg":"trace[1495541098] linearizableReadLoop","detail":"{readStateIndex:1494; appliedIndex:1493; }","duration":"123.487499ms","start":"2026-08-24T15:44:37.914542Z","end":"2026-08-24T15:44:38.03803Z","steps":["trace[1495541098] 'read index received' (duration: 123.342964ms)","trace[1495541098] 'applied index is now lower than readState.Index' (duration: 143.605µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:44:38.03817Z","caller":"traceutil/trace.go:171","msg":"trace[1464998690] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"138.653327ms","start":"2026-08-24T15:44:37.899485Z","end":"2026-08-24T15:44:38.038139Z","steps":["trace[1464998690] 'process raft request' (duration: 138.366268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:38.038493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.462158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:1 size:201"} {"level":"info","ts":"2026-08-24T15:44:38.038545Z","caller":"traceutil/trace.go:171","msg":"trace[279090029] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:1; response_revision:1429; }","duration":"119.54231ms","start":"2026-08-24T15:44:37.918992Z","end":"2026-08-24T15:44:38.038534Z","steps":["trace[279090029] 'agreement among raft nodes before linearized reading' (duration: 119.434497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:44:38.039118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.550195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-08-24T15:44:38.039202Z","caller":"traceutil/trace.go:171","msg":"trace[1743384738] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:1429; }","duration":"124.70925ms","start":"2026-08-24T15:44:37.914469Z","end":"2026-08-24T15:44:38.039179Z","steps":["trace[1743384738] 'agreement among raft nodes before linearized reading' (duration: 123.711717ms)"],"step_count":1}