{"level":"warn","ts":"2026-08-13T07:55:15.873493Z","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-13T07:55:15.873654Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.212: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.212:2380","--initial-cluster=instance=https://199.19.213.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.212: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-13T07:55:15.873713Z","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-13T07:55:15.873724Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-08-13T07:55:15.873852Z","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-13T07:55:15.87446Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"]} {"level":"info","ts":"2026-08-13T07:55:15.874525Z","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.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.212: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-13T07:55:15.880014Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.240268ms"} {"level":"info","ts":"2026-08-13T07:55:15.891455Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1ab0380b9290bdc","cluster-id":"a3ed131e36ad6843"} {"level":"info","ts":"2026-08-13T07:55:15.891554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T07:55:15.891577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 0"} {"level":"info","ts":"2026-08-13T07:55:15.891635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1ab0380b9290bdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T07:55:15.891649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 1"} {"level":"info","ts":"2026-08-13T07:55:15.89169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"warn","ts":"2026-08-13T07:55:15.898914Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T07:55:15.901642Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T07:55:15.902938Z","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-13T07:55:15.906033Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1ab0380b9290bdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T07:55:15.906215Z","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-13T07:55:15.906355Z","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-13T07:55:15.906373Z","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-13T07:55:15.906253Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1ab0380b9290bdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T07:55:15.909798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"info","ts":"2026-08-13T07:55:15.910329Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","added-peer-id":"e1ab0380b9290bdc","added-peer-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-08-13T07:55:15.911949Z","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-13T07:55:15.912058Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-08-13T07:55:15.912136Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-08-13T07:55:15.91246Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1ab0380b9290bdc","initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T07:55:15.912502Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T07:55:15.992847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T07:55:15.992931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T07:55:15.992956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgPreVoteResp from e1ab0380b9290bdc at term 1"} {"level":"info","ts":"2026-08-13T07:55:15.992966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became candidate at term 2"} {"level":"info","ts":"2026-08-13T07:55:15.992983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgVoteResp from e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-08-13T07:55:15.992992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became leader at term 2"} {"level":"info","ts":"2026-08-13T07:55:15.993001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1ab0380b9290bdc elected leader e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-08-13T07:55:15.9951Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:55:15.997268Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1ab0380b9290bdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.212:2379]}","request-path":"/0/members/e1ab0380b9290bdc/attributes","cluster-id":"a3ed131e36ad6843","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T07:55:15.997286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:55:15.998179Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:55:15.998284Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:55:15.99831Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:55:15.99833Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:55:15.999113Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T07:55:15.999191Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T07:55:16.004377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T07:55:16.00606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.212:2379"} {"level":"info","ts":"2026-08-13T07:55:18.613993Z","caller":"traceutil/trace.go:171","msg":"trace[1258009610] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"205.812485ms","start":"2026-08-13T07:55:18.408159Z","end":"2026-08-13T07:55:18.613972Z","steps":["trace[1258009610] 'read index received' (duration: 205.593109ms)","trace[1258009610] 'applied index is now lower than readState.Index' (duration: 218.476µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:55:18.614158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.97751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:55:18.614207Z","caller":"traceutil/trace.go:171","msg":"trace[1170453807] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:72; }","duration":"206.055981ms","start":"2026-08-13T07:55:18.408143Z","end":"2026-08-13T07:55:18.614199Z","steps":["trace[1170453807] 'agreement among raft nodes before linearized reading' (duration: 205.942919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:18.614336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.189774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:55:18.614453Z","caller":"traceutil/trace.go:171","msg":"trace[2144051359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"106.313407ms","start":"2026-08-13T07:55:18.508094Z","end":"2026-08-13T07:55:18.614407Z","steps":["trace[2144051359] 'agreement among raft nodes before linearized reading' (duration: 106.096811ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:18.614091Z","caller":"traceutil/trace.go:171","msg":"trace[624256953] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"207.190972ms","start":"2026-08-13T07:55:18.40687Z","end":"2026-08-13T07:55:18.614061Z","steps":["trace[624256953] 'process raft request' (duration: 206.962406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:19.06078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.850907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-cluster-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:55:19.060876Z","caller":"traceutil/trace.go:171","msg":"trace[466511971] range","detail":"{range_begin:/registry/priorityclasses/system-cluster-critical; range_end:; response_count:0; response_revision:72; }","duration":"443.98262ms","start":"2026-08-13T07:55:18.616867Z","end":"2026-08-13T07:55:19.060849Z","steps":["trace[466511971] 'range keys from in-memory index tree' (duration: 443.749644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:19.060882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.869977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-13T07:55:19.061004Z","caller":"traceutil/trace.go:171","msg":"trace[243812137] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:72; }","duration":"444.049462ms","start":"2026-08-13T07:55:18.616936Z","end":"2026-08-13T07:55:19.060986Z","steps":["trace[243812137] 'range keys from in-memory index tree' (duration: 443.776254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:55:19.061101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:55:18.616926Z","time spent":"444.162355ms","remote":"127.0.0.1:47728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"warn","ts":"2026-08-13T07:55:19.060909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:55:18.616851Z","time spent":"444.050102ms","remote":"127.0.0.1:47746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":0,"response size":28,"request content":"key:\"/registry/priorityclasses/system-cluster-critical\" "} {"level":"info","ts":"2026-08-13T07:55:54.150998Z","caller":"traceutil/trace.go:171","msg":"trace[1970780226] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"172.821081ms","start":"2026-08-13T07:55:53.978155Z","end":"2026-08-13T07:55:54.150976Z","steps":["trace[1970780226] 'process raft request' (duration: 85.225834ms)","trace[1970780226] 'compare' (duration: 87.257208ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:00.775678Z","caller":"traceutil/trace.go:171","msg":"trace[915833228] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"335.129604ms","start":"2026-08-13T07:56:00.440526Z","end":"2026-08-13T07:56:00.775655Z","steps":["trace[915833228] 'process raft request' (duration: 333.48147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:00.776225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:00.440502Z","time spent":"335.255437ms","remote":"127.0.0.1:47486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:56:01.272099Z","caller":"traceutil/trace.go:171","msg":"trace[2099461545] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"420.001686ms","start":"2026-08-13T07:56:00.852065Z","end":"2026-08-13T07:56:01.272066Z","steps":["trace[2099461545] 'read index received' (duration: 368.725593ms)","trace[2099461545] 'applied index is now lower than readState.Index' (duration: 51.274773ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:01.27219Z","caller":"traceutil/trace.go:171","msg":"trace[96767808] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"421.507835ms","start":"2026-08-13T07:56:00.850658Z","end":"2026-08-13T07:56:01.272166Z","steps":["trace[96767808] 'process raft request' (duration: 370.13031ms)","trace[96767808] 'compare' (duration: 51.044847ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:56:01.272286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:00.850638Z","time spent":"421.600918ms","remote":"127.0.0.1:47580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:56:01.272427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.073555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:56:01.272449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.364655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c4v9x\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-13T07:56:01.27251Z","caller":"traceutil/trace.go:171","msg":"trace[1017216038] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c4v9x; range_end:; response_count:1; response_revision:589; }","duration":"420.468778ms","start":"2026-08-13T07:56:00.852029Z","end":"2026-08-13T07:56:01.272497Z","steps":["trace[1017216038] 'agreement among raft nodes before linearized reading' (duration: 420.223521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:01.272549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:00.852013Z","time spent":"420.527979ms","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-c4v9x\" "} {"level":"info","ts":"2026-08-13T07:56:01.272493Z","caller":"traceutil/trace.go:171","msg":"trace[1440573896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"143.173708ms","start":"2026-08-13T07:56:01.129303Z","end":"2026-08-13T07:56:01.272477Z","steps":["trace[1440573896] 'agreement among raft nodes before linearized reading' (duration: 143.071606ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:01.471474Z","caller":"traceutil/trace.go:171","msg":"trace[1475995760] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"178.819321ms","start":"2026-08-13T07:56:01.29263Z","end":"2026-08-13T07:56:01.471449Z","steps":["trace[1475995760] 'process raft request' (duration: 177.896867ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:30.617148Z","caller":"traceutil/trace.go:171","msg":"trace[690653107] linearizableReadLoop","detail":"{readStateIndex:922; appliedIndex:921; }","duration":"374.386862ms","start":"2026-08-13T07:56:30.242733Z","end":"2026-08-13T07:56:30.61712Z","steps":["trace[690653107] 'read index received' (duration: 374.195337ms)","trace[690653107] 'applied index is now lower than readState.Index' (duration: 189.995µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:30.617302Z","caller":"traceutil/trace.go:171","msg":"trace[789826033] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"409.310385ms","start":"2026-08-13T07:56:30.20798Z","end":"2026-08-13T07:56:30.617291Z","steps":["trace[789826033] 'process raft request' (duration: 408.974857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:30.617405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:30.207967Z","time spent":"409.364177ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:56:30.61771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.39752ms","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-13T07:56:30.617813Z","caller":"traceutil/trace.go:171","msg":"trace[1570025026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:893; }","duration":"309.557753ms","start":"2026-08-13T07:56:30.308231Z","end":"2026-08-13T07:56:30.617789Z","steps":["trace[1570025026] 'agreement among raft nodes before linearized reading' (duration: 309.251595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:30.617823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.054599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:56:30.617867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:30.308214Z","time spent":"309.642636ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:56:30.617875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.930601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-6tv68\" ","response":"range_response_count:1 size:5677"} {"level":"info","ts":"2026-08-13T07:56:30.617911Z","caller":"traceutil/trace.go:171","msg":"trace[1005078866] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:893; }","duration":"375.190583ms","start":"2026-08-13T07:56:30.2427Z","end":"2026-08-13T07:56:30.617891Z","steps":["trace[1005078866] 'agreement among raft nodes before linearized reading' (duration: 375.025729ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:30.617941Z","caller":"traceutil/trace.go:171","msg":"trace[2076918818] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-6tv68; range_end:; response_count:1; response_revision:893; }","duration":"156.036934ms","start":"2026-08-13T07:56:30.461887Z","end":"2026-08-13T07:56:30.617924Z","steps":["trace[2076918818] 'agreement among raft nodes before linearized reading' (duration: 155.842919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:30.617971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:30.242686Z","time spent":"375.273375ms","remote":"127.0.0.1:47484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:56:30.913251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.764378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:56:30.91335Z","caller":"traceutil/trace.go:171","msg":"trace[358042874] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"292.301143ms","start":"2026-08-13T07:56:30.621034Z","end":"2026-08-13T07:56:30.913335Z","steps":["trace[358042874] 'process raft request' (duration: 157.287899ms)","trace[358042874] 'compare' (duration: 134.539192ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:31.028062Z","caller":"traceutil/trace.go:171","msg":"trace[567183586] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"399.92486ms","start":"2026-08-13T07:56:30.628118Z","end":"2026-08-13T07:56:31.028043Z","steps":["trace[567183586] 'process raft request' (duration: 390.275227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:31.028238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:30.628095Z","time spent":"400.076424ms","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:56:31.275617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.308437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:56:31.275684Z","caller":"traceutil/trace.go:171","msg":"trace[1895135192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:900; }","duration":"147.493421ms","start":"2026-08-13T07:56:31.128176Z","end":"2026-08-13T07:56:31.275669Z","steps":["trace[1895135192] 'range keys from in-memory index tree' (duration: 147.168243ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:44.93712Z","caller":"traceutil/trace.go:171","msg":"trace[1046903581] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"123.727179ms","start":"2026-08-13T07:56:44.813375Z","end":"2026-08-13T07:56:44.937103Z","steps":["trace[1046903581] 'read index received' (duration: 123.627786ms)","trace[1046903581] 'applied index is now lower than readState.Index' (duration: 98.853µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:44.937168Z","caller":"traceutil/trace.go:171","msg":"trace[132591411] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"256.791743ms","start":"2026-08-13T07:56:44.680359Z","end":"2026-08-13T07:56:44.937151Z","steps":["trace[132591411] 'process raft request' (duration: 256.644139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:44.937227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.838442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:56:44.937248Z","caller":"traceutil/trace.go:171","msg":"trace[1851822293] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:950; }","duration":"123.908393ms","start":"2026-08-13T07:56:44.813333Z","end":"2026-08-13T07:56:44.937241Z","steps":["trace[1851822293] 'agreement among raft nodes before linearized reading' (duration: 123.839172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:45.597761Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111117,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T07:56:45.640787Z","caller":"traceutil/trace.go:171","msg":"trace[1597828560] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"670.276097ms","start":"2026-08-13T07:56:44.970483Z","end":"2026-08-13T07:56:45.640759Z","steps":["trace[1597828560] 'process raft request' (duration: 670.096042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:45.640999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:44.970472Z","time spent":"670.40874ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:56:45.664238Z","caller":"traceutil/trace.go:171","msg":"trace[1212023606] linearizableReadLoop","detail":"{readStateIndex:984; appliedIndex:981; }","duration":"567.138597ms","start":"2026-08-13T07:56:45.097082Z","end":"2026-08-13T07:56:45.664221Z","steps":["trace[1212023606] 'read index received' (duration: 543.529559ms)","trace[1212023606] 'applied index is now lower than readState.Index' (duration: 23.608178ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:45.664317Z","caller":"traceutil/trace.go:171","msg":"trace[754077711] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"285.127804ms","start":"2026-08-13T07:56:45.379172Z","end":"2026-08-13T07:56:45.6643Z","steps":["trace[754077711] 'process raft request' (duration: 284.922319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:45.664424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.336362ms","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-13T07:56:45.664464Z","caller":"traceutil/trace.go:171","msg":"trace[893541677] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"567.416294ms","start":"2026-08-13T07:56:45.097034Z","end":"2026-08-13T07:56:45.66445Z","steps":["trace[893541677] 'agreement among raft nodes before linearized reading' (duration: 567.290731ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:45.664502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:45.097007Z","time spent":"567.484536ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T07:56:45.664592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.246475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:56:45.664625Z","caller":"traceutil/trace.go:171","msg":"trace[1013141990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"534.315297ms","start":"2026-08-13T07:56:45.1303Z","end":"2026-08-13T07:56:45.664615Z","steps":["trace[1013141990] 'agreement among raft nodes before linearized reading' (duration: 534.275416ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:45.664648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:45.130276Z","time spent":"534.366049ms","remote":"127.0.0.1:47406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T07:56:45.664867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.484944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:56:45.664989Z","caller":"traceutil/trace.go:171","msg":"trace[1171689758] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:952; }","duration":"285.677729ms","start":"2026-08-13T07:56:45.379291Z","end":"2026-08-13T07:56:45.664969Z","steps":["trace[1171689758] 'agreement among raft nodes before linearized reading' (duration: 285.471023ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:47.43171Z","caller":"traceutil/trace.go:171","msg":"trace[813190893] linearizableReadLoop","detail":"{readStateIndex:988; appliedIndex:987; }","duration":"302.643994ms","start":"2026-08-13T07:56:47.129049Z","end":"2026-08-13T07:56:47.431693Z","steps":["trace[813190893] 'read index received' (duration: 302.51816ms)","trace[813190893] 'applied index is now lower than readState.Index' (duration: 124.944µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:56:47.431735Z","caller":"traceutil/trace.go:171","msg":"trace[809313567] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"486.816895ms","start":"2026-08-13T07:56:46.944901Z","end":"2026-08-13T07:56:47.431718Z","steps":["trace[809313567] 'process raft request' (duration: 486.682832ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:47.4318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.737406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:56:47.431831Z","caller":"traceutil/trace.go:171","msg":"trace[1983467580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:956; }","duration":"302.820718ms","start":"2026-08-13T07:56:47.129002Z","end":"2026-08-13T07:56:47.431822Z","steps":["trace[1983467580] 'agreement among raft nodes before linearized reading' (duration: 302.763846ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:47.431844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:46.944881Z","time spent":"486.903457ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:56:47.431855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:56:47.12898Z","time spent":"302.870359ms","remote":"127.0.0.1:47406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-13T07:56:50.136318Z","caller":"traceutil/trace.go:171","msg":"trace[1157386310] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"118.618596ms","start":"2026-08-13T07:56:50.017677Z","end":"2026-08-13T07:56:50.136296Z","steps":["trace[1157386310] 'process raft request' (duration: 118.486033ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:56:50.149094Z","caller":"traceutil/trace.go:171","msg":"trace[584026499] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"129.752827ms","start":"2026-08-13T07:56:50.01931Z","end":"2026-08-13T07:56:50.149062Z","steps":["trace[584026499] 'process raft request' (duration: 129.539761ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:56:50.313065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.35936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-08-13T07:56:50.313218Z","caller":"traceutil/trace.go:171","msg":"trace[342154938] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:972; }","duration":"123.554644ms","start":"2026-08-13T07:56:50.189643Z","end":"2026-08-13T07:56:50.313197Z","steps":["trace[342154938] 'range keys from in-memory index tree' (duration: 123.261437ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:22.136299Z","caller":"traceutil/trace.go:171","msg":"trace[1037441291] linearizableReadLoop","detail":"{readStateIndex:1165; appliedIndex:1164; }","duration":"279.494507ms","start":"2026-08-13T07:57:21.856703Z","end":"2026-08-13T07:57:22.136198Z","steps":["trace[1037441291] 'read index received' (duration: 279.383454ms)","trace[1037441291] 'applied index is now lower than readState.Index' (duration: 110.313µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:22.136305Z","caller":"traceutil/trace.go:171","msg":"trace[1855577813] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"550.435368ms","start":"2026-08-13T07:57:21.585834Z","end":"2026-08-13T07:57:22.13627Z","steps":["trace[1855577813] 'process raft request' (duration: 550.243163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:22.136478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.761973ms","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-13T07:57:22.136512Z","caller":"traceutil/trace.go:171","msg":"trace[1326283979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1124; }","duration":"279.841035ms","start":"2026-08-13T07:57:21.85666Z","end":"2026-08-13T07:57:22.136501Z","steps":["trace[1326283979] 'agreement among raft nodes before linearized reading' (duration: 279.704342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:22.136519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:21.585805Z","time spent":"550.664975ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:57:22.138314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.735474ms","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-13T07:57:22.138385Z","caller":"traceutil/trace.go:171","msg":"trace[1632119350] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1125; }","duration":"141.848997ms","start":"2026-08-13T07:57:21.996519Z","end":"2026-08-13T07:57:22.138368Z","steps":["trace[1632119350] 'agreement among raft nodes before linearized reading' (duration: 141.690243ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:22.138451Z","caller":"traceutil/trace.go:171","msg":"trace[2102943909] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"251.424369ms","start":"2026-08-13T07:57:21.887015Z","end":"2026-08-13T07:57:22.138439Z","steps":["trace[2102943909] 'process raft request' (duration: 249.683744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:22.138671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.468643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:57:22.138696Z","caller":"traceutil/trace.go:171","msg":"trace[2016162537] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1125; }","duration":"129.549646ms","start":"2026-08-13T07:57:22.00914Z","end":"2026-08-13T07:57:22.13869Z","steps":["trace[2016162537] 'agreement among raft nodes before linearized reading' (duration: 129.494824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:24.645089Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:25.153013Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:25.653833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:26.223238Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:26.723884Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854733925892111552,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:57:26.732421Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.58850389s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T07:57:26.732836Z","caller":"traceutil/trace.go:171","msg":"trace[1001185973] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"2.588996173s","start":"2026-08-13T07:57:24.143822Z","end":"2026-08-13T07:57:26.732818Z","steps":["trace[1001185973] 'process raft request' (duration: 2.58887461s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.732938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.143803Z","time spent":"2.589071495s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:26.740026Z","caller":"traceutil/trace.go:171","msg":"trace[1256055809] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"2.488879028s","start":"2026-08-13T07:57:24.251125Z","end":"2026-08-13T07:57:26.740004Z","steps":["trace[1256055809] 'process raft request' (duration: 2.488313044s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.74015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.251096Z","time spent":"2.488985641s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:26.742511Z","caller":"traceutil/trace.go:171","msg":"trace[1745778520] linearizableReadLoop","detail":"{readStateIndex:1173; appliedIndex:1170; }","duration":"2.59797278s","start":"2026-08-13T07:57:24.144521Z","end":"2026-08-13T07:57:26.742494Z","steps":["trace[1745778520] 'read index received' (duration: 2.588165732s)","trace[1745778520] 'applied index is now lower than readState.Index' (duration: 9.806038ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:26.743494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.598968425s","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-13T07:57:26.743529Z","caller":"traceutil/trace.go:171","msg":"trace[727263997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1131; }","duration":"2.599049247s","start":"2026-08-13T07:57:24.144472Z","end":"2026-08-13T07:57:26.743521Z","steps":["trace[727263997] 'agreement among raft nodes before linearized reading' (duration: 2.598927524s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.743555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.144445Z","time spent":"2.599102998s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:57:26.743686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281677445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-13T07:57:26.743795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.958413394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:26.743802Z","caller":"traceutil/trace.go:171","msg":"trace[2022710510] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1131; }","duration":"1.281818769s","start":"2026-08-13T07:57:25.461975Z","end":"2026-08-13T07:57:26.743794Z","steps":["trace[2022710510] 'agreement among raft nodes before linearized reading' (duration: 1.281668075s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.744179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.103896098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:57:26.744245Z","caller":"traceutil/trace.go:171","msg":"trace[1801173252] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1131; }","duration":"2.104015131s","start":"2026-08-13T07:57:24.640215Z","end":"2026-08-13T07:57:26.74423Z","steps":["trace[1801173252] 'agreement among raft nodes before linearized reading' (duration: 2.103874037s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.744279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.640197Z","time spent":"2.104073763s","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:57:26.744296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.422262652s","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-13T07:57:26.744341Z","caller":"traceutil/trace.go:171","msg":"trace[112765286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1131; }","duration":"2.422322064s","start":"2026-08-13T07:57:24.321993Z","end":"2026-08-13T07:57:26.744316Z","steps":["trace[112765286] 'agreement among raft nodes before linearized reading' (duration: 2.422247172s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.74436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.321976Z","time spent":"2.422379647s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:26.744375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197498391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:57:26.74441Z","caller":"traceutil/trace.go:171","msg":"trace[790446932] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1131; }","duration":"1.197561703s","start":"2026-08-13T07:57:25.546837Z","end":"2026-08-13T07:57:26.744398Z","steps":["trace[790446932] 'agreement among raft nodes before linearized reading' (duration: 1.197414558s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.744435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:25.546821Z","time spent":"1.197607084s","remote":"127.0.0.1:47810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:57:26.744507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.269617351s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:26.744527Z","caller":"traceutil/trace.go:171","msg":"trace[1735265502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1131; }","duration":"1.269647591s","start":"2026-08-13T07:57:25.474872Z","end":"2026-08-13T07:57:26.74452Z","steps":["trace[1735265502] 'agreement among raft nodes before linearized reading' (duration: 1.26961781s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.74454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:25.474858Z","time spent":"1.269679812s","remote":"127.0.0.1:47406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T07:57:26.744581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.75914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:57:26.744596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.582046531s","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-13T07:57:26.744606Z","caller":"traceutil/trace.go:171","msg":"trace[1215601724] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1131; }","duration":"499.785291ms","start":"2026-08-13T07:57:26.244812Z","end":"2026-08-13T07:57:26.744598Z","steps":["trace[1215601724] 'agreement among raft nodes before linearized reading' (duration: 499.72723ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:26.74462Z","caller":"traceutil/trace.go:171","msg":"trace[424889856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1131; }","duration":"2.582101032s","start":"2026-08-13T07:57:24.16251Z","end":"2026-08-13T07:57:26.744611Z","steps":["trace[424889856] 'agreement among raft nodes before linearized reading' (duration: 2.5820062s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.744628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:26.244768Z","time spent":"499.854143ms","remote":"127.0.0.1:43850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:57:26.744637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.162492Z","time spent":"2.582139864s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:26.744641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.589320092s","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-13T07:57:26.744722Z","caller":"traceutil/trace.go:171","msg":"trace[440786632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1131; }","duration":"2.589415795s","start":"2026-08-13T07:57:24.155285Z","end":"2026-08-13T07:57:26.744701Z","steps":["trace[440786632] 'agreement among raft nodes before linearized reading' (duration: 2.588179042s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.74476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.155233Z","time spent":"2.589516647s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-13T07:57:26.744779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.27874897s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:57:26.7448Z","caller":"traceutil/trace.go:171","msg":"trace[895665125] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1131; }","duration":"1.27878526s","start":"2026-08-13T07:57:25.466008Z","end":"2026-08-13T07:57:26.744793Z","steps":["trace[895665125] 'agreement among raft nodes before linearized reading' (duration: 1.278735459s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.744822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:25.466002Z","time spent":"1.278811761s","remote":"127.0.0.1:47492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:57:26.743766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.418855873s","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-13T07:57:26.745027Z","caller":"traceutil/trace.go:171","msg":"trace[885931789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1131; }","duration":"2.420142408s","start":"2026-08-13T07:57:24.324876Z","end":"2026-08-13T07:57:26.745019Z","steps":["trace[885931789] 'agreement among raft nodes before linearized reading' (duration: 2.418845993s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.745055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.324861Z","time spent":"2.420186099s","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T07:57:26.745871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:25.461959Z","time spent":"1.28186424s","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":17,"response size":31,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:57:26.743815Z","caller":"traceutil/trace.go:171","msg":"trace[1364096065] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1131; }","duration":"1.958478077s","start":"2026-08-13T07:57:24.785328Z","end":"2026-08-13T07:57:26.743806Z","steps":["trace[1364096065] 'agreement among raft nodes before linearized reading' (duration: 1.958451396s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.746537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:24.785299Z","time spent":"1.961219438s","remote":"127.0.0.1:47586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:57:26.881416Z","caller":"traceutil/trace.go:171","msg":"trace[1683884034] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"131.454825ms","start":"2026-08-13T07:57:26.749945Z","end":"2026-08-13T07:57:26.8814Z","steps":["trace[1683884034] 'process raft request' (duration: 131.401574ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:26.881417Z","caller":"traceutil/trace.go:171","msg":"trace[2122383473] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"132.222656ms","start":"2026-08-13T07:57:26.749168Z","end":"2026-08-13T07:57:26.881391Z","steps":["trace[2122383473] 'process raft request' (duration: 132.074842ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:26.881603Z","caller":"traceutil/trace.go:171","msg":"trace[1121737170] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"131.61466ms","start":"2026-08-13T07:57:26.749979Z","end":"2026-08-13T07:57:26.881594Z","steps":["trace[1121737170] 'process raft request' (duration: 131.393113ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:26.881661Z","caller":"traceutil/trace.go:171","msg":"trace[1886065374] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1174; }","duration":"126.385434ms","start":"2026-08-13T07:57:26.755269Z","end":"2026-08-13T07:57:26.881655Z","steps":["trace[1886065374] 'read index received' (duration: 125.921061ms)","trace[1886065374] 'applied index is now lower than readState.Index' (duration: 463.923µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:26.881721Z","caller":"traceutil/trace.go:171","msg":"trace[1754494423] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"131.366053ms","start":"2026-08-13T07:57:26.750349Z","end":"2026-08-13T07:57:26.881715Z","steps":["trace[1754494423] 'process raft request' (duration: 131.194328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:26.881727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.439885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:26.881748Z","caller":"traceutil/trace.go:171","msg":"trace[1814256530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1136; }","duration":"126.516947ms","start":"2026-08-13T07:57:26.755223Z","end":"2026-08-13T07:57:26.88174Z","steps":["trace[1814256530] 'agreement among raft nodes before linearized reading' (duration: 126.455965ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:48.129129Z","caller":"traceutil/trace.go:171","msg":"trace[1035634174] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"451.312989ms","start":"2026-08-13T07:57:47.677792Z","end":"2026-08-13T07:57:48.129105Z","steps":["trace[1035634174] 'read index received' (duration: 451.091124ms)","trace[1035634174] 'applied index is now lower than readState.Index' (duration: 220.595µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:57:48.129192Z","caller":"traceutil/trace.go:171","msg":"trace[323826404] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"468.386527ms","start":"2026-08-13T07:57:47.660772Z","end":"2026-08-13T07:57:48.129158Z","steps":["trace[323826404] 'process raft request' (duration: 468.13429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:48.129354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:47.660711Z","time spent":"468.563822ms","remote":"127.0.0.1:47470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:57:48.129409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.22545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T07:57:48.129353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.531315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:48.129452Z","caller":"traceutil/trace.go:171","msg":"trace[1680852135] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1224; }","duration":"371.287882ms","start":"2026-08-13T07:57:47.758151Z","end":"2026-08-13T07:57:48.129439Z","steps":["trace[1680852135] 'agreement among raft nodes before linearized reading' (duration: 371.239131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:48.129496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:47.758137Z","time spent":"371.347773ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-08-13T07:57:48.129487Z","caller":"traceutil/trace.go:171","msg":"trace[1928763153] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1224; }","duration":"451.70051ms","start":"2026-08-13T07:57:47.677766Z","end":"2026-08-13T07:57:48.129467Z","steps":["trace[1928763153] 'agreement among raft nodes before linearized reading' (duration: 451.507225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:48.129551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:47.677753Z","time spent":"451.777521ms","remote":"127.0.0.1:51358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:57:48.648946Z","caller":"traceutil/trace.go:171","msg":"trace[2080950675] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"514.890946ms","start":"2026-08-13T07:57:48.13402Z","end":"2026-08-13T07:57:48.648911Z","steps":["trace[2080950675] 'process raft request' (duration: 514.681221ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:48.649079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:48.133996Z","time spent":"515.01942ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T07:57:48.674652Z","caller":"traceutil/trace.go:171","msg":"trace[2007281999] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"539.975855ms","start":"2026-08-13T07:57:48.134631Z","end":"2026-08-13T07:57:48.674607Z","steps":["trace[2007281999] 'process raft request' (duration: 539.836301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:48.674836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:48.134614Z","time spent":"540.144899ms","remote":"127.0.0.1:47470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:57:49.054368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.119ms","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-13T07:57:49.054439Z","caller":"traceutil/trace.go:171","msg":"trace[1798431243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1230; }","duration":"104.240403ms","start":"2026-08-13T07:57:48.950182Z","end":"2026-08-13T07:57:49.054423Z","steps":["trace[1798431243] 'range keys from in-memory index tree' (duration: 103.813042ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:53.40326Z","caller":"traceutil/trace.go:171","msg":"trace[1547114311] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"249.041318ms","start":"2026-08-13T07:57:53.154182Z","end":"2026-08-13T07:57:53.403223Z","steps":["trace[1547114311] 'process raft request' (duration: 248.831453ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:53.424078Z","caller":"traceutil/trace.go:171","msg":"trace[734694554] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"268.60283ms","start":"2026-08-13T07:57:53.155441Z","end":"2026-08-13T07:57:53.424044Z","steps":["trace[734694554] 'process raft request' (duration: 268.545539ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:53.424548Z","caller":"traceutil/trace.go:171","msg":"trace[1136018593] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"269.445303ms","start":"2026-08-13T07:57:53.155087Z","end":"2026-08-13T07:57:53.424533Z","steps":["trace[1136018593] 'process raft request' (duration: 268.630412ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:53.424765Z","caller":"traceutil/trace.go:171","msg":"trace[990936740] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"269.66561ms","start":"2026-08-13T07:57:53.155081Z","end":"2026-08-13T07:57:53.424746Z","steps":["trace[990936740] 'process raft request' (duration: 268.802746ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:53.42493Z","caller":"traceutil/trace.go:171","msg":"trace[271998379] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"269.67166ms","start":"2026-08-13T07:57:53.155245Z","end":"2026-08-13T07:57:53.424917Z","steps":["trace[271998379] 'process raft request' (duration: 268.697134ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:57:55.402848Z","caller":"traceutil/trace.go:171","msg":"trace[1598576097] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"473.169312ms","start":"2026-08-13T07:57:54.929641Z","end":"2026-08-13T07:57:55.40281Z","steps":["trace[1598576097] 'process raft request' (duration: 472.933996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:55.403092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:54.92961Z","time spent":"473.344617ms","remote":"127.0.0.1:47548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6320,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:55.403719Z","caller":"traceutil/trace.go:171","msg":"trace[613193163] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"440.011113ms","start":"2026-08-13T07:57:54.963692Z","end":"2026-08-13T07:57:55.403703Z","steps":["trace[613193163] 'process raft request' (duration: 439.562492ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:57:55.403807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:57:54.963654Z","time spent":"440.109396ms","remote":"127.0.0.1:47658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:57:55.404966Z","caller":"traceutil/trace.go:171","msg":"trace[522896756] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1311; }","duration":"272.774329ms","start":"2026-08-13T07:57:55.132169Z","end":"2026-08-13T07:57:55.404943Z","steps":["trace[522896756] 'read index received' (duration: 270.46496ms)","trace[522896756] 'applied index is now lower than readState.Index' (duration: 2.308429ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:57:55.405251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.041776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:57:55.405352Z","caller":"traceutil/trace.go:171","msg":"trace[838202654] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"273.214702ms","start":"2026-08-13T07:57:55.132126Z","end":"2026-08-13T07:57:55.405341Z","steps":["trace[838202654] 'agreement among raft nodes before linearized reading' (duration: 273.038276ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:04.263979Z","caller":"traceutil/trace.go:171","msg":"trace[1842858609] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"229.719657ms","start":"2026-08-13T07:59:04.034241Z","end":"2026-08-13T07:59:04.26396Z","steps":["trace[1842858609] 'process raft request' (duration: 229.607204ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:04.267495Z","caller":"traceutil/trace.go:171","msg":"trace[260825245] linearizableReadLoop","detail":"{readStateIndex:1665; appliedIndex:1662; }","duration":"194.009196ms","start":"2026-08-13T07:59:04.073476Z","end":"2026-08-13T07:59:04.267485Z","steps":["trace[260825245] 'read index received' (duration: 190.415172ms)","trace[260825245] 'applied index is now lower than readState.Index' (duration: 3.593294ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:59:04.267523Z","caller":"traceutil/trace.go:171","msg":"trace[182224344] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"230.643831ms","start":"2026-08-13T07:59:04.03687Z","end":"2026-08-13T07:59:04.267514Z","steps":["trace[182224344] 'process raft request' (duration: 230.59263ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:59:04.267526Z","caller":"traceutil/trace.go:171","msg":"trace[1091817341] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"231.73127ms","start":"2026-08-13T07:59:04.035772Z","end":"2026-08-13T07:59:04.267503Z","steps":["trace[1091817341] 'process raft request' (duration: 231.643588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:04.267624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.135489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-08-13T07:59:04.267647Z","caller":"traceutil/trace.go:171","msg":"trace[1764200628] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1604; }","duration":"194.212501ms","start":"2026-08-13T07:59:04.073428Z","end":"2026-08-13T07:59:04.26764Z","steps":["trace[1764200628] 'agreement among raft nodes before linearized reading' (duration: 194.114819ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:04.26767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.107372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:59:04.267764Z","caller":"traceutil/trace.go:171","msg":"trace[579311194] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1604; }","duration":"139.242915ms","start":"2026-08-13T07:59:04.128505Z","end":"2026-08-13T07:59:04.267748Z","steps":["trace[579311194] 'agreement among raft nodes before linearized reading' (duration: 139.125752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:59:06.638345Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.429106389s","expected-duration":"1s"}