{"level":"warn","ts":"2026-06-13T22:48:11.843584Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T22:48:11.843707Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-06-13T22:48:11.843795Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T22:48:11.843811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-06-13T22:48:11.843832Z","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-06-13T22:48:11.844586Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-06-13T22:48:11.844689Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-06-13T22:48:11.849927Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.974845ms"} {"level":"info","ts":"2026-06-13T22:48:11.859093Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-06-13T22:48:11.859166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T22:48:11.859186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-06-13T22:48:11.859198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T22:48:11.859208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-06-13T22:48:11.859246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-06-13T22:48:11.874281Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T22:48:11.87572Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T22:48:11.878085Z","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-06-13T22:48:11.880365Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T22:48:11.880485Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T22:48:11.880646Z","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-06-13T22:48:11.88072Z","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-06-13T22:48:11.88073Z","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-06-13T22:48:11.882259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-06-13T22:48:11.882518Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-06-13T22:48:11.885028Z","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-06-13T22:48:11.885179Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-06-13T22:48:11.885231Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-06-13T22:48:11.885306Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T22:48:11.885345Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T22:48:12.15966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T22:48:12.159724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T22:48:12.159748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-06-13T22:48:12.159767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-06-13T22:48:12.159784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-06-13T22:48:12.159802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-06-13T22:48:12.159821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-06-13T22:48:12.160543Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:48:12.161211Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T22:48:12.161333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:48:12.161403Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:48:12.163879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-06-13T22:48:12.163912Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T22:48:12.164498Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T22:48:12.164812Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T22:48:12.170789Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:48:12.170866Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:48:12.170893Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:48:20.116826Z","caller":"traceutil/trace.go:171","msg":"trace[408836883] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"105.359759ms","start":"2026-06-13T22:48:20.011442Z","end":"2026-06-13T22:48:20.116802Z","steps":["trace[408836883] 'process raft request' (duration: 105.228636ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:20.335888Z","caller":"traceutil/trace.go:171","msg":"trace[1591563250] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"125.151573ms","start":"2026-06-13T22:48:20.21071Z","end":"2026-06-13T22:48:20.335862Z","steps":["trace[1591563250] 'process raft request' (duration: 124.99609ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:21.687355Z","caller":"traceutil/trace.go:171","msg":"trace[188872712] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"127.072528ms","start":"2026-06-13T22:48:21.560258Z","end":"2026-06-13T22:48:21.68733Z","steps":["trace[188872712] 'read index received' (duration: 122.777149ms)","trace[188872712] 'applied index is now lower than readState.Index' (duration: 4.293919ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:21.687437Z","caller":"traceutil/trace.go:171","msg":"trace[1348897080] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"127.747833ms","start":"2026-06-13T22:48:21.559659Z","end":"2026-06-13T22:48:21.687407Z","steps":["trace[1348897080] 'process raft request' (duration: 123.364383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:21.687527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.256152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-13T22:48:21.687618Z","caller":"traceutil/trace.go:171","msg":"trace[1905630592] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:309; }","duration":"127.391785ms","start":"2026-06-13T22:48:21.560216Z","end":"2026-06-13T22:48:21.687608Z","steps":["trace[1905630592] 'agreement among raft nodes before linearized reading' (duration: 127.214511ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:25.972004Z","caller":"traceutil/trace.go:171","msg":"trace[1787445564] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"188.701521ms","start":"2026-06-13T22:48:25.78328Z","end":"2026-06-13T22:48:25.971982Z","steps":["trace[1787445564] 'process raft request' (duration: 188.553397ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:27.098085Z","caller":"traceutil/trace.go:171","msg":"trace[946637672] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"184.241537ms","start":"2026-06-13T22:48:26.913824Z","end":"2026-06-13T22:48:27.098065Z","steps":["trace[946637672] 'process raft request' (duration: 184.138275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:28.675282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.676856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:48:28.675379Z","caller":"traceutil/trace.go:171","msg":"trace[1921274231] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"1.029799542s","start":"2026-06-13T22:48:27.645565Z","end":"2026-06-13T22:48:28.675365Z","steps":["trace[1921274231] 'read index received' (duration: 386.5035ms)","trace[1921274231] 'applied index is now lower than readState.Index' (duration: 643.294482ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:28.675447Z","caller":"traceutil/trace.go:171","msg":"trace[1420831627] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"1.476160026s","start":"2026-06-13T22:48:27.199279Z","end":"2026-06-13T22:48:28.675439Z","steps":["trace[1420831627] 'process raft request' (duration: 832.849684ms)","trace[1420831627] 'compare' (duration: 641.574148ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:48:28.675498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:27.199252Z","time spent":"1.476219656s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:48:28.675619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.573675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-13T22:48:28.675644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030065999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:28.675645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.564069ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:28.675736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.724804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T22:48:28.675753Z","caller":"traceutil/trace.go:171","msg":"trace[1618133236] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:369; }","duration":"787.677872ms","start":"2026-06-13T22:48:27.888056Z","end":"2026-06-13T22:48:28.675734Z","steps":["trace[1618133236] 'agreement among raft nodes before linearized reading' (duration: 787.531138ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:28.675744Z","caller":"traceutil/trace.go:171","msg":"trace[775945957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:369; }","duration":"1.030201463s","start":"2026-06-13T22:48:27.645517Z","end":"2026-06-13T22:48:28.675719Z","steps":["trace[775945957] 'agreement among raft nodes before linearized reading' (duration: 1.030054589s)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:28.675674Z","caller":"traceutil/trace.go:171","msg":"trace[1560413846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:369; }","duration":"699.656136ms","start":"2026-06-13T22:48:27.976004Z","end":"2026-06-13T22:48:28.675661Z","steps":["trace[1560413846] 'agreement among raft nodes before linearized reading' (duration: 699.550733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:28.675641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.480923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T22:48:28.675806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:27.645498Z","time spent":"1.030294114s","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:48:28.675886Z","caller":"traceutil/trace.go:171","msg":"trace[850288282] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:369; }","duration":"828.74661ms","start":"2026-06-13T22:48:27.84709Z","end":"2026-06-13T22:48:28.675837Z","steps":["trace[850288282] 'agreement among raft nodes before linearized reading' (duration: 828.411741ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:28.675766Z","caller":"traceutil/trace.go:171","msg":"trace[1070919140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:369; }","duration":"827.789896ms","start":"2026-06-13T22:48:27.847969Z","end":"2026-06-13T22:48:28.675759Z","steps":["trace[1070919140] 'agreement among raft nodes before linearized reading' (duration: 827.738764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:28.675963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:27.847071Z","time spent":"828.879163ms","remote":"127.0.0.1:47392","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-06-13T22:48:28.676056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:27.847962Z","time spent":"828.020431ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:48:28.67587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:27.975989Z","time spent":"699.832241ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-13T22:48:29.342058Z","caller":"traceutil/trace.go:171","msg":"trace[1030525239] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"656.048633ms","start":"2026-06-13T22:48:28.685978Z","end":"2026-06-13T22:48:29.342027Z","steps":["trace[1030525239] 'process raft request' (duration: 655.805057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:29.342245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:28.685949Z","time spent":"656.202267ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:48:29.352635Z","caller":"traceutil/trace.go:171","msg":"trace[1598120214] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:381; }","duration":"249.947288ms","start":"2026-06-13T22:48:29.102662Z","end":"2026-06-13T22:48:29.352609Z","steps":["trace[1598120214] 'read index received' (duration: 239.104514ms)","trace[1598120214] 'applied index is now lower than readState.Index' (duration: 10.841814ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:29.352778Z","caller":"traceutil/trace.go:171","msg":"trace[1712691770] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"666.197789ms","start":"2026-06-13T22:48:28.686567Z","end":"2026-06-13T22:48:29.352765Z","steps":["trace[1712691770] 'process raft request' (duration: 665.947093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:29.35285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.168354ms","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-06-13T22:48:29.352847Z","caller":"traceutil/trace.go:171","msg":"trace[1212265820] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"665.976154ms","start":"2026-06-13T22:48:28.686858Z","end":"2026-06-13T22:48:29.352834Z","steps":["trace[1212265820] 'process raft request' (duration: 665.715958ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:29.352901Z","caller":"traceutil/trace.go:171","msg":"trace[530156839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:373; }","duration":"250.270556ms","start":"2026-06-13T22:48:29.102616Z","end":"2026-06-13T22:48:29.352886Z","steps":["trace[530156839] 'agreement among raft nodes before linearized reading' (duration: 250.177714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:29.352934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:28.686839Z","time spent":"666.060056ms","remote":"127.0.0.1:47392","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-06-13T22:48:29.352719Z","caller":"traceutil/trace.go:171","msg":"trace[556070403] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"666.707692ms","start":"2026-06-13T22:48:28.685979Z","end":"2026-06-13T22:48:29.352687Z","steps":["trace[556070403] 'process raft request' (duration: 666.353293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:29.353086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:28.685952Z","time spent":"667.095703ms","remote":"127.0.0.1:47314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:48:29.353523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:28.686559Z","time spent":"666.316522ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:48:51.956826Z","caller":"traceutil/trace.go:171","msg":"trace[1486624576] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"375.646126ms","start":"2026-06-13T22:48:51.581157Z","end":"2026-06-13T22:48:51.956803Z","steps":["trace[1486624576] 'process raft request' (duration: 369.356387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.957023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:51.581129Z","time spent":"375.79055ms","remote":"127.0.0.1:47180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:48:51.96364Z","caller":"traceutil/trace.go:171","msg":"trace[1339621401] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:567; }","duration":"316.913701ms","start":"2026-06-13T22:48:51.64671Z","end":"2026-06-13T22:48:51.963624Z","steps":["trace[1339621401] 'read index received' (duration: 303.755309ms)","trace[1339621401] 'applied index is now lower than readState.Index' (duration: 13.157742ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:48:51.963764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.056164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.963717Z","caller":"traceutil/trace.go:171","msg":"trace[410915605] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"374.23102ms","start":"2026-06-13T22:48:51.589419Z","end":"2026-06-13T22:48:51.96365Z","steps":["trace[410915605] 'process raft request' (duration: 374.068916ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.963804Z","caller":"traceutil/trace.go:171","msg":"trace[1275724933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"317.146056ms","start":"2026-06-13T22:48:51.646648Z","end":"2026-06-13T22:48:51.963794Z","steps":["trace[1275724933] 'agreement among raft nodes before linearized reading' (duration: 317.059554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.963832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:51.646626Z","time spent":"317.200398ms","remote":"127.0.0.1:47146","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-06-13T22:48:51.964034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.516181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.964071Z","caller":"traceutil/trace.go:171","msg":"trace[1132596652] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:548; }","duration":"280.567072ms","start":"2026-06-13T22:48:51.683494Z","end":"2026-06-13T22:48:51.964061Z","steps":["trace[1132596652] 'agreement among raft nodes before linearized reading' (duration: 280.512151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.964293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.392501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:51.964288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:51.589406Z","time spent":"374.686322ms","remote":"127.0.0.1:47180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:48:51.964355Z","caller":"traceutil/trace.go:171","msg":"trace[1762896264] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:548; }","duration":"163.462353ms","start":"2026-06-13T22:48:51.800883Z","end":"2026-06-13T22:48:51.964346Z","steps":["trace[1762896264] 'agreement among raft nodes before linearized reading' (duration: 163.37707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.964536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.186531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.964571Z","caller":"traceutil/trace.go:171","msg":"trace[1263534666] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:548; }","duration":"164.253092ms","start":"2026-06-13T22:48:51.800308Z","end":"2026-06-13T22:48:51.964562Z","steps":["trace[1263534666] 'agreement among raft nodes before linearized reading' (duration: 164.18964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.964768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.602841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.964805Z","caller":"traceutil/trace.go:171","msg":"trace[747410318] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:548; }","duration":"164.652222ms","start":"2026-06-13T22:48:51.800143Z","end":"2026-06-13T22:48:51.964796Z","steps":["trace[747410318] 'agreement among raft nodes before linearized reading' (duration: 164.59364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.964978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.634122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.965014Z","caller":"traceutil/trace.go:171","msg":"trace[1410089670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:548; }","duration":"183.673313ms","start":"2026-06-13T22:48:51.781331Z","end":"2026-06-13T22:48:51.965004Z","steps":["trace[1410089670] 'agreement among raft nodes before linearized reading' (duration: 183.592761ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.965005Z","caller":"traceutil/trace.go:171","msg":"trace[1807057901] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"362.302648ms","start":"2026-06-13T22:48:51.601368Z","end":"2026-06-13T22:48:51.96367Z","steps":["trace[1807057901] 'process raft request' (duration: 362.225866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.965097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:51.601358Z","time spent":"363.689893ms","remote":"127.0.0.1:47180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T22:48:51.965173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.852127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:51.96521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.750298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.965212Z","caller":"traceutil/trace.go:171","msg":"trace[1312861599] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:548; }","duration":"183.913269ms","start":"2026-06-13T22:48:51.781286Z","end":"2026-06-13T22:48:51.9652Z","steps":["trace[1312861599] 'agreement among raft nodes before linearized reading' (duration: 183.852128ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.965254Z","caller":"traceutil/trace.go:171","msg":"trace[1586635751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:548; }","duration":"250.832501ms","start":"2026-06-13T22:48:51.714409Z","end":"2026-06-13T22:48:51.965242Z","steps":["trace[1586635751] 'agreement among raft nodes before linearized reading' (duration: 250.77056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.965446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.130378ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.965513Z","caller":"traceutil/trace.go:171","msg":"trace[908615702] 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:548; }","duration":"230.2143ms","start":"2026-06-13T22:48:51.73528Z","end":"2026-06-13T22:48:51.965494Z","steps":["trace[908615702] 'agreement among raft nodes before linearized reading' (duration: 230.113367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.965536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.475216ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.965604Z","caller":"traceutil/trace.go:171","msg":"trace[1381499386] 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:548; }","duration":"230.564448ms","start":"2026-06-13T22:48:51.735027Z","end":"2026-06-13T22:48:51.965592Z","steps":["trace[1381499386] 'agreement among raft nodes before linearized reading' (duration: 230.474446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.96573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.483169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.965769Z","caller":"traceutil/trace.go:171","msg":"trace[451957660] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:548; }","duration":"206.553511ms","start":"2026-06-13T22:48:51.759206Z","end":"2026-06-13T22:48:51.96576Z","steps":["trace[451957660] 'agreement among raft nodes before linearized reading' (duration: 206.49448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.966002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.362278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:51.96584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.753503ms","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-06-13T22:48:51.966043Z","caller":"traceutil/trace.go:171","msg":"trace[1608145924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:548; }","duration":"282.44642ms","start":"2026-06-13T22:48:51.683585Z","end":"2026-06-13T22:48:51.966032Z","steps":["trace[1608145924] 'agreement among raft nodes before linearized reading' (duration: 282.359738ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.966054Z","caller":"traceutil/trace.go:171","msg":"trace[26868228] 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:548; }","duration":"231.021201ms","start":"2026-06-13T22:48:51.73502Z","end":"2026-06-13T22:48:51.966041Z","steps":["trace[26868228] 'agreement among raft nodes before linearized reading' (duration: 230.757714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.966367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.0571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.966411Z","caller":"traceutil/trace.go:171","msg":"trace[881266097] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:548; }","duration":"208.114091ms","start":"2026-06-13T22:48:51.758285Z","end":"2026-06-13T22:48:51.966399Z","steps":["trace[881266097] 'agreement among raft nodes before linearized reading' (duration: 208.045489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:51.966416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.17474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:51.966608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.172963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:48:51.965287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.873302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:51.966648Z","caller":"traceutil/trace.go:171","msg":"trace[511364220] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:548; }","duration":"208.250885ms","start":"2026-06-13T22:48:51.758385Z","end":"2026-06-13T22:48:51.966636Z","steps":["trace[511364220] 'agreement among raft nodes before linearized reading' (duration: 208.192073ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.966672Z","caller":"traceutil/trace.go:171","msg":"trace[1028983500] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:548; }","duration":"252.289568ms","start":"2026-06-13T22:48:51.714369Z","end":"2026-06-13T22:48:51.966658Z","steps":["trace[1028983500] 'agreement among raft nodes before linearized reading' (duration: 250.865532ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:51.96647Z","caller":"traceutil/trace.go:171","msg":"trace[1171058964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:548; }","duration":"251.223201ms","start":"2026-06-13T22:48:51.715214Z","end":"2026-06-13T22:48:51.966437Z","steps":["trace[1171058964] 'agreement among raft nodes before linearized reading' (duration: 251.138948ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:52.525581Z","caller":"traceutil/trace.go:171","msg":"trace[1010715579] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"144.38164ms","start":"2026-06-13T22:48:52.381166Z","end":"2026-06-13T22:48:52.525548Z","steps":["trace[1010715579] 'process raft request' (duration: 135.201778ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:58.329493Z","caller":"traceutil/trace.go:171","msg":"trace[1400629262] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"134.353096ms","start":"2026-06-13T22:48:58.19511Z","end":"2026-06-13T22:48:58.329463Z","steps":["trace[1400629262] 'process raft request' (duration: 134.137591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:58.529529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.731266ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:48:58.529702Z","caller":"traceutil/trace.go:171","msg":"trace[1402617775] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"185.444938ms","start":"2026-06-13T22:48:58.34423Z","end":"2026-06-13T22:48:58.529675Z","steps":["trace[1402617775] 'process raft request' (duration: 69.435286ms)","trace[1402617775] 'compare' (duration: 115.448618ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:48:58.980016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.151725ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:48:58.980115Z","caller":"traceutil/trace.go:171","msg":"trace[1703876027] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"335.340537ms","start":"2026-06-13T22:48:58.644757Z","end":"2026-06-13T22:48:58.980098Z","steps":["trace[1703876027] 'read index received' (duration: 114.985467ms)","trace[1703876027] 'applied index is now lower than readState.Index' (duration: 220.3522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:48:58.980201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.444279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:48:58.980232Z","caller":"traceutil/trace.go:171","msg":"trace[510634020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"335.513931ms","start":"2026-06-13T22:48:58.64471Z","end":"2026-06-13T22:48:58.980223Z","steps":["trace[510634020] 'agreement among raft nodes before linearized reading' (duration: 335.433449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:58.980261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:58.644686Z","time spent":"335.568863ms","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:48:58.980649Z","caller":"traceutil/trace.go:171","msg":"trace[2116948518] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"635.367611ms","start":"2026-06-13T22:48:58.345252Z","end":"2026-06-13T22:48:58.980619Z","steps":["trace[2116948518] 'process raft request' (duration: 414.542849ms)","trace[2116948518] 'compare' (duration: 219.908499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:48:58.980761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:58.345242Z","time spent":"635.475374ms","remote":"127.0.0.1:47314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T22:48:59.20012Z","caller":"traceutil/trace.go:171","msg":"trace[68976582] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"213.707122ms","start":"2026-06-13T22:48:58.986387Z","end":"2026-06-13T22:48:59.200094Z","steps":["trace[68976582] 'process raft request' (duration: 144.444781ms)","trace[68976582] 'compare' (duration: 68.623375ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:59.200159Z","caller":"traceutil/trace.go:171","msg":"trace[819737605] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"212.45628ms","start":"2026-06-13T22:48:58.987681Z","end":"2026-06-13T22:48:59.200137Z","steps":["trace[819737605] 'process raft request' (duration: 212.120782ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:59.200153Z","caller":"traceutil/trace.go:171","msg":"trace[1576835460] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"211.448815ms","start":"2026-06-13T22:48:58.98866Z","end":"2026-06-13T22:48:59.200108Z","steps":["trace[1576835460] 'process raft request' (duration: 211.207049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:59.990505Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829314537281572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T22:49:00.491512Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829314537281572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T22:49:00.526933Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.039324653s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T22:49:00.527401Z","caller":"traceutil/trace.go:171","msg":"trace[1711768851] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.039885197s","start":"2026-06-13T22:48:59.487484Z","end":"2026-06-13T22:49:00.527369Z","steps":["trace[1711768851] 'process raft request' (duration: 1.039737733s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:00.527562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:59.487461Z","time spent":"1.04002884s","remote":"127.0.0.1:47392","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-06-13T22:49:01.646123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000200432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-13T22:49:01.646243Z","caller":"traceutil/trace.go:171","msg":"trace[580346250] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000347685s","start":"2026-06-13T22:48:59.645854Z","end":"2026-06-13T22:49:01.646202Z","steps":["trace[580346250] 'agreement among raft nodes before linearized reading' (duration: 2.000222932s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:01.646315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:59.645839Z","time spent":"2.000465908s","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/13 22:49:01 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-13T22:49:01.657472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.949534ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:01.657905Z","caller":"traceutil/trace.go:171","msg":"trace[1294222579] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.170345342s","start":"2026-06-13T22:48:59.487517Z","end":"2026-06-13T22:49:01.657862Z","steps":["trace[1294222579] 'process raft request' (duration: 1.376938277s)","trace[1294222579] 'compare' (duration: 792.841351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:01.658059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:59.487503Z","time spent":"2.170473905s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:49:01.691255Z","caller":"traceutil/trace.go:171","msg":"trace[169040953] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:632; }","duration":"2.201321255s","start":"2026-06-13T22:48:59.48991Z","end":"2026-06-13T22:49:01.691231Z","steps":["trace[169040953] 'read index received' (duration: 1.037382593s)","trace[169040953] 'applied index is now lower than readState.Index' (duration: 1.163936802s)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:01.691562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.201643784s","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-06-13T22:49:01.691613Z","caller":"traceutil/trace.go:171","msg":"trace[544777783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:612; }","duration":"2.201718795s","start":"2026-06-13T22:48:59.489879Z","end":"2026-06-13T22:49:01.691598Z","steps":["trace[544777783] 'agreement among raft nodes before linearized reading' (duration: 2.20150901s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:01.691621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.199794007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T22:49:01.691661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:59.489824Z","time spent":"2.201820969s","remote":"127.0.0.1:47392","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-06-13T22:49:01.691702Z","caller":"traceutil/trace.go:171","msg":"trace[108008391] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:612; }","duration":"2.19990287s","start":"2026-06-13T22:48:59.491781Z","end":"2026-06-13T22:49:01.691684Z","steps":["trace[108008391] 'agreement among raft nodes before linearized reading' (duration: 2.199610562s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:01.691752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:48:59.491755Z","time spent":"2.199987782s","remote":"127.0.0.1:47392","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-06-13T22:49:02.619357Z","caller":"traceutil/trace.go:171","msg":"trace[471642435] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"286.530853ms","start":"2026-06-13T22:49:02.332776Z","end":"2026-06-13T22:49:02.619306Z","steps":["trace[471642435] 'process raft request' (duration: 228.501776ms)","trace[471642435] 'compare' (duration: 57.840053ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:03.459529Z","caller":"traceutil/trace.go:171","msg":"trace[1524386964] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"126.065546ms","start":"2026-06-13T22:49:03.333442Z","end":"2026-06-13T22:49:03.459507Z","steps":["trace[1524386964] 'process raft request' (duration: 125.928813ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:08.554304Z","caller":"traceutil/trace.go:171","msg":"trace[1693328771] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"126.501128ms","start":"2026-06-13T22:49:08.427772Z","end":"2026-06-13T22:49:08.554273Z","steps":["trace[1693328771] 'process raft request' (duration: 126.217291ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:19.156716Z","caller":"traceutil/trace.go:171","msg":"trace[826355021] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"347.239299ms","start":"2026-06-13T22:49:18.809447Z","end":"2026-06-13T22:49:19.156687Z","steps":["trace[826355021] 'process raft request' (duration: 347.065975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:19.156862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:18.809428Z","time spent":"347.367402ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:49:19.57701Z","caller":"traceutil/trace.go:171","msg":"trace[387776772] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"150.011313ms","start":"2026-06-13T22:49:19.426976Z","end":"2026-06-13T22:49:19.576987Z","steps":["trace[387776772] 'process raft request' (duration: 149.87546ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:23.700509Z","caller":"traceutil/trace.go:171","msg":"trace[424533930] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"100.75298ms","start":"2026-06-13T22:49:23.599729Z","end":"2026-06-13T22:49:23.700482Z","steps":["trace[424533930] 'process raft request' (duration: 100.599186ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:32.010467Z","caller":"traceutil/trace.go:171","msg":"trace[696790223] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"181.77585ms","start":"2026-06-13T22:49:31.828661Z","end":"2026-06-13T22:49:32.010437Z","steps":["trace[696790223] 'process raft request' (duration: 181.414052ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:40.167819Z","caller":"traceutil/trace.go:171","msg":"trace[323911644] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"102.71628ms","start":"2026-06-13T22:49:40.064798Z","end":"2026-06-13T22:49:40.167515Z","steps":["trace[323911644] 'process raft request' (duration: 60.049247ms)","trace[323911644] 'compare' (duration: 42.52169ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:40.211224Z","caller":"traceutil/trace.go:171","msg":"trace[2133950544] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"145.661649ms","start":"2026-06-13T22:49:40.065538Z","end":"2026-06-13T22:49:40.2112Z","steps":["trace[2133950544] 'process raft request' (duration: 145.504616ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:40.211406Z","caller":"traceutil/trace.go:171","msg":"trace[1782940790] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"120.511064ms","start":"2026-06-13T22:49:40.090862Z","end":"2026-06-13T22:49:40.211373Z","steps":["trace[1782940790] 'process raft request' (duration: 120.293609ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:44.297182Z","caller":"traceutil/trace.go:171","msg":"trace[1266005176] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"111.711271ms","start":"2026-06-13T22:49:44.185442Z","end":"2026-06-13T22:49:44.297153Z","steps":["trace[1266005176] 'process raft request' (duration: 111.453065ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:46.504933Z","caller":"traceutil/trace.go:171","msg":"trace[1559251229] linearizableReadLoop","detail":"{readStateIndex:994; appliedIndex:993; }","duration":"106.052437ms","start":"2026-06-13T22:49:46.398858Z","end":"2026-06-13T22:49:46.50491Z","steps":["trace[1559251229] 'read index received' (duration: 45.517039ms)","trace[1559251229] 'applied index is now lower than readState.Index' (duration: 60.534728ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:46.505078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.208651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:49:46.505112Z","caller":"traceutil/trace.go:171","msg":"trace[206059251] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:959; }","duration":"106.301633ms","start":"2026-06-13T22:49:46.3988Z","end":"2026-06-13T22:49:46.505101Z","steps":["trace[206059251] 'agreement among raft nodes before linearized reading' (duration: 106.215741ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:46.505352Z","caller":"traceutil/trace.go:171","msg":"trace[1977635736] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"157.74713ms","start":"2026-06-13T22:49:46.347515Z","end":"2026-06-13T22:49:46.505262Z","steps":["trace[1977635736] 'process raft request' (duration: 96.919815ms)","trace[1977635736] 'compare' (duration: 60.393345ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:55.109524Z","caller":"traceutil/trace.go:171","msg":"trace[1418491219] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"225.271591ms","start":"2026-06-13T22:49:54.884225Z","end":"2026-06-13T22:49:55.109496Z","steps":["trace[1418491219] 'process raft request' (duration: 225.143858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:56.091027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.017344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:56.091418Z","caller":"traceutil/trace.go:171","msg":"trace[434439018] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"794.259621ms","start":"2026-06-13T22:49:55.297146Z","end":"2026-06-13T22:49:56.091406Z","steps":["trace[434439018] 'read index received' (duration: 477.821928ms)","trace[434439018] 'applied index is now lower than readState.Index' (duration: 316.436673ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:56.091541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.401625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T22:49:56.091562Z","caller":"traceutil/trace.go:171","msg":"trace[14170280] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:991; }","duration":"794.463326ms","start":"2026-06-13T22:49:55.297092Z","end":"2026-06-13T22:49:56.091555Z","steps":["trace[14170280] 'agreement among raft nodes before linearized reading' (duration: 794.372304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:56.091589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:55.29707Z","time spent":"794.513707ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"warn","ts":"2026-06-13T22:49:56.091585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.297274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T22:49:56.091681Z","caller":"traceutil/trace.go:171","msg":"trace[634449352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:991; }","duration":"455.403016ms","start":"2026-06-13T22:49:55.636265Z","end":"2026-06-13T22:49:56.091668Z","steps":["trace[634449352] 'agreement among raft nodes before linearized reading' (duration: 455.213152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:56.091724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:55.636185Z","time spent":"455.530089ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T22:49:56.091442Z","caller":"traceutil/trace.go:171","msg":"trace[1192154959] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"1.098961351s","start":"2026-06-13T22:49:54.992456Z","end":"2026-06-13T22:49:56.091417Z","steps":["trace[1192154959] 'process raft request' (duration: 782.457876ms)","trace[1192154959] 'compare' (duration: 315.526452ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:56.092114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:54.992435Z","time spent":"1.099589666s","remote":"127.0.0.1:47392","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-06-13T22:49:57.023497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.89721ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-13T22:49:57.023571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.09219Z","time spent":"931.378612ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-13T22:49:57.40894Z","caller":"traceutil/trace.go:171","msg":"trace[1539671415] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"1.31248413s","start":"2026-06-13T22:49:56.096415Z","end":"2026-06-13T22:49:57.408899Z","steps":["trace[1539671415] 'process raft request' (duration: 1.308693252s)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:57.409023Z","caller":"traceutil/trace.go:171","msg":"trace[1904230376] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"1.139678179s","start":"2026-06-13T22:49:56.269337Z","end":"2026-06-13T22:49:57.409015Z","steps":["trace[1904230376] 'process raft request' (duration: 1.139482504s)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:57.409121Z","caller":"traceutil/trace.go:171","msg":"trace[867465727] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"1.255159065s","start":"2026-06-13T22:49:56.153922Z","end":"2026-06-13T22:49:57.409081Z","steps":["trace[867465727] 'read index received' (duration: 330.760016ms)","trace[867465727] 'applied index is now lower than readState.Index' (duration: 924.396939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:57.409172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.096392Z","time spent":"1.312683334s","remote":"127.0.0.1:47392","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-06-13T22:49:57.409185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.269318Z","time spent":"1.139773491s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:49:57.409411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022130684s","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-06-13T22:49:57.40896Z","caller":"traceutil/trace.go:171","msg":"trace[1453418320] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"384.575818ms","start":"2026-06-13T22:49:57.024361Z","end":"2026-06-13T22:49:57.408937Z","steps":["trace[1453418320] 'process raft request' (duration: 384.508926ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:57.40946Z","caller":"traceutil/trace.go:171","msg":"trace[1384816908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:994; }","duration":"1.022211216s","start":"2026-06-13T22:49:56.38724Z","end":"2026-06-13T22:49:57.409451Z","steps":["trace[1384816908] 'agreement among raft nodes before linearized reading' (duration: 1.022072463s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:57.40949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.387219Z","time spent":"1.022264657s","remote":"127.0.0.1:47392","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-06-13T22:49:57.409525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:57.024335Z","time spent":"385.132441ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:49:57.409634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.121425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-13T22:49:57.409624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.645249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:57.409674Z","caller":"traceutil/trace.go:171","msg":"trace[1756544039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:994; }","duration":"845.199477ms","start":"2026-06-13T22:49:56.564464Z","end":"2026-06-13T22:49:57.409664Z","steps":["trace[1756544039] 'agreement among raft nodes before linearized reading' (duration: 845.098385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:57.4097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.564437Z","time spent":"845.258238ms","remote":"127.0.0.1:47392","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-06-13T22:49:57.409709Z","caller":"traceutil/trace.go:171","msg":"trace[1839262702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:994; }","duration":"763.742462ms","start":"2026-06-13T22:49:56.645943Z","end":"2026-06-13T22:49:57.409685Z","steps":["trace[1839262702] 'agreement among raft nodes before linearized reading' (duration: 763.591018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:57.409397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255466233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-13T22:49:57.409752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.645867Z","time spent":"763.878025ms","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:49:57.409771Z","caller":"traceutil/trace.go:171","msg":"trace[1700782443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:994; }","duration":"1.255884833s","start":"2026-06-13T22:49:56.153877Z","end":"2026-06-13T22:49:57.409762Z","steps":["trace[1700782443] 'agreement among raft nodes before linearized reading' (duration: 1.255348981s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:57.4098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:56.153863Z","time spent":"1.255930674s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:49:57.409949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.941206ms","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-06-13T22:49:57.410008Z","caller":"traceutil/trace.go:171","msg":"trace[1963071446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:994; }","duration":"296.031409ms","start":"2026-06-13T22:49:57.113961Z","end":"2026-06-13T22:49:57.409992Z","steps":["trace[1963071446] 'agreement among raft nodes before linearized reading' (duration: 295.820964ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:01.632917Z","caller":"traceutil/trace.go:171","msg":"trace[2099332009] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"181.36526ms","start":"2026-06-13T22:50:01.451531Z","end":"2026-06-13T22:50:01.632896Z","steps":["trace[2099332009] 'read index received' (duration: 43.634615ms)","trace[2099332009] 'applied index is now lower than readState.Index' (duration: 137.729475ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:01.633152Z","caller":"traceutil/trace.go:171","msg":"trace[2096045180] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"192.578181ms","start":"2026-06-13T22:50:01.440552Z","end":"2026-06-13T22:50:01.63313Z","steps":["trace[2096045180] 'process raft request' (duration: 192.227693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:01.633174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.628456ms","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-06-13T22:50:01.633214Z","caller":"traceutil/trace.go:171","msg":"trace[444860908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"181.695358ms","start":"2026-06-13T22:50:01.451509Z","end":"2026-06-13T22:50:01.633204Z","steps":["trace[444860908] 'agreement among raft nodes before linearized reading' (duration: 181.467253ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:10.446052Z","caller":"traceutil/trace.go:171","msg":"trace[50475876] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"122.616203ms","start":"2026-06-13T22:50:10.32341Z","end":"2026-06-13T22:50:10.446026Z","steps":["trace[50475876] 'process raft request' (duration: 122.440279ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:19.848261Z","caller":"traceutil/trace.go:171","msg":"trace[491373721] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"112.708661ms","start":"2026-06-13T22:50:19.735526Z","end":"2026-06-13T22:50:19.848235Z","steps":["trace[491373721] 'process raft request' (duration: 112.361183ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:19.998587Z","caller":"traceutil/trace.go:171","msg":"trace[1361111246] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"146.381187ms","start":"2026-06-13T22:50:19.852126Z","end":"2026-06-13T22:50:19.998507Z","steps":["trace[1361111246] 'process raft request' (duration: 127.464397ms)","trace[1361111246] 'compare' (duration: 18.820617ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:21.404799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.850121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:21.404978Z","caller":"traceutil/trace.go:171","msg":"trace[725219379] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"924.575324ms","start":"2026-06-13T22:50:20.480382Z","end":"2026-06-13T22:50:21.404957Z","steps":["trace[725219379] 'process raft request' (duration: 528.490307ms)","trace[725219379] 'compare' (duration: 395.598725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:21.405076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.480357Z","time spent":"924.684567ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:21.539906Z","caller":"traceutil/trace.go:171","msg":"trace[1609180437] linearizableReadLoop","detail":"{readStateIndex:1114; appliedIndex:1112; }","duration":"894.443463ms","start":"2026-06-13T22:50:20.645437Z","end":"2026-06-13T22:50:21.53988Z","steps":["trace[1609180437] 'read index received' (duration: 363.516179ms)","trace[1609180437] 'applied index is now lower than readState.Index' (duration: 530.926294ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:21.54001Z","caller":"traceutil/trace.go:171","msg":"trace[182161248] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"885.522085ms","start":"2026-06-13T22:50:20.654443Z","end":"2026-06-13T22:50:21.539965Z","steps":["trace[182161248] 'process raft request' (duration: 885.244969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:21.540121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.016674ms","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":"info","ts":"2026-06-13T22:50:21.540167Z","caller":"traceutil/trace.go:171","msg":"trace[990833978] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1072; }","duration":"466.123036ms","start":"2026-06-13T22:50:21.074034Z","end":"2026-06-13T22:50:21.540157Z","steps":["trace[990833978] 'agreement among raft nodes before linearized reading' (duration: 466.009203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:21.540246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:21.074014Z","time spent":"466.207218ms","remote":"127.0.0.1:47450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":16,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:21.540173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.654414Z","time spent":"885.676748ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:21.54084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.130489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:21.541081Z","caller":"traceutil/trace.go:171","msg":"trace[149291247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1072; }","duration":"895.659481ms","start":"2026-06-13T22:50:20.645378Z","end":"2026-06-13T22:50:21.541037Z","steps":["trace[149291247] 'agreement among raft nodes before linearized reading' (duration: 894.584386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:21.541339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.645357Z","time spent":"895.847795ms","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:50:21.935458Z","caller":"traceutil/trace.go:171","msg":"trace[1554957905] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1115; }","duration":"354.1211ms","start":"2026-06-13T22:50:21.58131Z","end":"2026-06-13T22:50:21.935431Z","steps":["trace[1554957905] 'read index received' (duration: 15.573063ms)","trace[1554957905] 'applied index is now lower than readState.Index' (duration: 338.546747ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:21.935596Z","caller":"traceutil/trace.go:171","msg":"trace[1524059930] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"376.736575ms","start":"2026-06-13T22:50:21.558847Z","end":"2026-06-13T22:50:21.935584Z","steps":["trace[1524059930] 'process raft request' (duration: 376.450629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:21.935699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:21.558829Z","time spent":"376.793427ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:21.935899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.698351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:50:21.93596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.656512ms","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-06-13T22:50:21.935996Z","caller":"traceutil/trace.go:171","msg":"trace[2084856128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1074; }","duration":"354.731684ms","start":"2026-06-13T22:50:21.581253Z","end":"2026-06-13T22:50:21.935985Z","steps":["trace[2084856128] 'agreement among raft nodes before linearized reading' (duration: 354.596501ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:21.935999Z","caller":"traceutil/trace.go:171","msg":"trace[488444596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"289.845595ms","start":"2026-06-13T22:50:21.646128Z","end":"2026-06-13T22:50:21.935974Z","steps":["trace[488444596] 'agreement among raft nodes before linearized reading' (duration: 289.693211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:21.936027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:21.58123Z","time spent":"354.790236ms","remote":"127.0.0.1:47392","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-06-13T22:50:22.068554Z","caller":"traceutil/trace.go:171","msg":"trace[1144092699] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"127.897356ms","start":"2026-06-13T22:50:21.940637Z","end":"2026-06-13T22:50:22.068535Z","steps":["trace[1144092699] 'process raft request' (duration: 73.837528ms)","trace[1144092699] 'compare' (duration: 53.895544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:23.336207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"981.066018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:23.33629Z","caller":"traceutil/trace.go:171","msg":"trace[383396555] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1077; }","duration":"981.209002ms","start":"2026-06-13T22:50:22.355061Z","end":"2026-06-13T22:50:23.33627Z","steps":["trace[383396555] 'count revisions from in-memory index tree' (duration: 980.907675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:23.336336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:22.35504Z","time spent":"981.282863ms","remote":"127.0.0.1:47828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:23.336467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.48418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:23.336511Z","caller":"traceutil/trace.go:171","msg":"trace[2128071888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1077; }","duration":"691.568052ms","start":"2026-06-13T22:50:22.644931Z","end":"2026-06-13T22:50:23.336499Z","steps":["trace[2128071888] 'range keys from in-memory index tree' (duration: 691.400378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:23.336541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:22.64491Z","time spent":"691.623753ms","remote":"127.0.0.1:47142","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-06-13T22:50:24.232899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.497478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:24.233039Z","caller":"traceutil/trace.go:171","msg":"trace[1613640377] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1123; }","duration":"238.428538ms","start":"2026-06-13T22:50:23.994587Z","end":"2026-06-13T22:50:24.233015Z","steps":["trace[1613640377] 'read index received' (duration: 131.629443ms)","trace[1613640377] 'applied index is now lower than readState.Index' (duration: 106.796525ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:24.233097Z","caller":"traceutil/trace.go:171","msg":"trace[1498094614] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"243.825034ms","start":"2026-06-13T22:50:23.989241Z","end":"2026-06-13T22:50:24.233066Z","steps":["trace[1498094614] 'process raft request' (duration: 137.043489ms)","trace[1498094614] 'compare' (duration: 106.274503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:24.233194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.577971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T22:50:24.233264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.246468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-13T22:50:24.233271Z","caller":"traceutil/trace.go:171","msg":"trace[1406218354] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1081; }","duration":"238.738115ms","start":"2026-06-13T22:50:23.994515Z","end":"2026-06-13T22:50:24.233254Z","steps":["trace[1406218354] 'agreement among raft nodes before linearized reading' (duration: 238.561101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.233334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.771101ms","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-06-13T22:50:24.233302Z","caller":"traceutil/trace.go:171","msg":"trace[2073587538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1081; }","duration":"111.31879ms","start":"2026-06-13T22:50:24.121972Z","end":"2026-06-13T22:50:24.233291Z","steps":["trace[2073587538] 'agreement among raft nodes before linearized reading' (duration: 111.182297ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:24.23341Z","caller":"traceutil/trace.go:171","msg":"trace[513116677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1081; }","duration":"160.898874ms","start":"2026-06-13T22:50:24.072493Z","end":"2026-06-13T22:50:24.233392Z","steps":["trace[513116677] 'agreement among raft nodes before linearized reading' (duration: 160.664679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.877224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.419287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:24.877393Z","caller":"traceutil/trace.go:171","msg":"trace[1448306081] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"201.681382ms","start":"2026-06-13T22:50:24.67569Z","end":"2026-06-13T22:50:24.877371Z","steps":["trace[1448306081] 'read index received' (duration: 48.791µs)","trace[1448306081] 'applied index is now lower than readState.Index' (duration: 201.630841ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:24.877532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.837607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:24.877545Z","caller":"traceutil/trace.go:171","msg":"trace[1337169362] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"639.912931ms","start":"2026-06-13T22:50:24.237597Z","end":"2026-06-13T22:50:24.87751Z","steps":["trace[1337169362] 'process raft request' (duration: 383.092485ms)","trace[1337169362] 'compare' (duration: 256.289983ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:24.877582Z","caller":"traceutil/trace.go:171","msg":"trace[1527421861] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1083; }","duration":"201.930739ms","start":"2026-06-13T22:50:24.675637Z","end":"2026-06-13T22:50:24.877568Z","steps":["trace[1527421861] 'agreement among raft nodes before linearized reading' (duration: 201.793096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.877697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:24.237567Z","time spent":"640.049643ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:26.145305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829314537282650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T22:50:26.58139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.281851847s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T22:50:26.581464Z","caller":"traceutil/trace.go:171","msg":"trace[1230656011] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:1083; }","duration":"1.28197138s","start":"2026-06-13T22:50:25.299476Z","end":"2026-06-13T22:50:26.581447Z","steps":["trace[1230656011] 'range keys from in-memory index tree' (duration: 1.281685083s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:26.581508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:25.299457Z","time spent":"1.282038921s","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-06-13T22:50:26.581814Z","caller":"traceutil/trace.go:171","msg":"trace[1575469584] linearizableReadLoop","detail":"{readStateIndex:1127; appliedIndex:1126; }","duration":"936.767488ms","start":"2026-06-13T22:50:25.645024Z","end":"2026-06-13T22:50:26.581791Z","steps":["trace[1575469584] 'read index received' (duration: 877.693823ms)","trace[1575469584] 'applied index is now lower than readState.Index' (duration: 59.072525ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:26.581909Z","caller":"traceutil/trace.go:171","msg":"trace[328716184] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"1.127003603s","start":"2026-06-13T22:50:25.454891Z","end":"2026-06-13T22:50:26.581894Z","steps":["trace[328716184] 'process raft request' (duration: 1.067815856s)","trace[328716184] 'compare' (duration: 58.03169ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:26.582047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:25.454868Z","time spent":"1.127079025s","remote":"127.0.0.1:47392","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-06-13T22:50:26.582228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.191057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:26.582313Z","caller":"traceutil/trace.go:171","msg":"trace[1627056775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"937.323661ms","start":"2026-06-13T22:50:25.644977Z","end":"2026-06-13T22:50:26.582301Z","steps":["trace[1627056775] 'agreement among raft nodes before linearized reading' (duration: 937.188208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:26.582372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.406751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-13T22:50:26.58241Z","caller":"traceutil/trace.go:171","msg":"trace[1577831390] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1084; }","duration":"276.481103ms","start":"2026-06-13T22:50:26.305919Z","end":"2026-06-13T22:50:26.5824Z","steps":["trace[1577831390] 'agreement among raft nodes before linearized reading' (duration: 276.385451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:26.582381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:25.64496Z","time spent":"937.410992ms","remote":"127.0.0.1:47146","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-06-13T22:50:26.582649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.310475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-13T22:50:26.582707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.172371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-13T22:50:26.582783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.057594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:50:26.582935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.228354ms","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-06-13T22:50:26.583022Z","caller":"traceutil/trace.go:171","msg":"trace[1226183540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1084; }","duration":"593.552671ms","start":"2026-06-13T22:50:25.989449Z","end":"2026-06-13T22:50:26.583001Z","steps":["trace[1226183540] 'agreement among raft nodes before linearized reading' (duration: 593.122431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:26.583074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:25.989412Z","time spent":"593.651623ms","remote":"127.0.0.1:47392","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":"info","ts":"2026-06-13T22:50:26.582887Z","caller":"traceutil/trace.go:171","msg":"trace[387958034] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1084; }","duration":"460.480184ms","start":"2026-06-13T22:50:26.122396Z","end":"2026-06-13T22:50:26.582876Z","steps":["trace[387958034] 'agreement among raft nodes before linearized reading' (duration: 460.066254ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:26.583015Z","caller":"traceutil/trace.go:171","msg":"trace[119768486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1084; }","duration":"926.528529ms","start":"2026-06-13T22:50:25.656316Z","end":"2026-06-13T22:50:26.582845Z","steps":["trace[119768486] 'agreement among raft nodes before linearized reading' (duration: 925.877384ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:26.582728Z","caller":"traceutil/trace.go:171","msg":"trace[85147971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1084; }","duration":"345.435188ms","start":"2026-06-13T22:50:26.237274Z","end":"2026-06-13T22:50:26.58271Z","steps":["trace[85147971] 'agreement among raft nodes before linearized reading' (duration: 345.036559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:26.583285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.122374Z","time spent":"460.886344ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:26.58337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.237259Z","time spent":"346.102563ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:26.583375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:25.656297Z","time spent":"927.062681ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:27.406865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.231069ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-13T22:50:27.407024Z","caller":"traceutil/trace.go:171","msg":"trace[1006624325] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"822.364465ms","start":"2026-06-13T22:50:26.584631Z","end":"2026-06-13T22:50:27.406995Z","steps":["trace[1006624325] 'read index received' (duration: 263.981973ms)","trace[1006624325] 'applied index is now lower than readState.Index' (duration: 558.380122ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:27.407143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.583734Z","time spent":"823.403919ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-13T22:50:27.408034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.731663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:27.408159Z","caller":"traceutil/trace.go:171","msg":"trace[1793854828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1084; }","duration":"823.491541ms","start":"2026-06-13T22:50:26.584602Z","end":"2026-06-13T22:50:27.408093Z","steps":["trace[1793854828] 'agreement among raft nodes before linearized reading' (duration: 822.657352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.408234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.584589Z","time spent":"823.628494ms","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:50:27.838647Z","caller":"traceutil/trace.go:171","msg":"trace[826916030] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"1.250660991s","start":"2026-06-13T22:50:26.587956Z","end":"2026-06-13T22:50:27.838617Z","steps":["trace[826916030] 'process raft request' (duration: 1.250540318s)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:27.838711Z","caller":"traceutil/trace.go:171","msg":"trace[135688931] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"1.250931658s","start":"2026-06-13T22:50:26.587664Z","end":"2026-06-13T22:50:27.838596Z","steps":["trace[135688931] 'process raft request' (duration: 1.186470128s)","trace[135688931] 'compare' (duration: 64.05239ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:27.838969Z","caller":"traceutil/trace.go:171","msg":"trace[259907135] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"1.249807661s","start":"2026-06-13T22:50:26.589129Z","end":"2026-06-13T22:50:27.838937Z","steps":["trace[259907135] 'process raft request' (duration: 1.249436032s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.838818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.587943Z","time spent":"1.250793664s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:27.839142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.589109Z","time spent":"1.249924784s","remote":"127.0.0.1:47392","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-06-13T22:50:27.839143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.587642Z","time spent":"1.251355857s","remote":"127.0.0.1:47392","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-06-13T22:50:27.839217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.404717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-13T22:50:27.839214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.443635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:27.839303Z","caller":"traceutil/trace.go:171","msg":"trace[1052581261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1088; }","duration":"957.568271ms","start":"2026-06-13T22:50:26.88172Z","end":"2026-06-13T22:50:27.839288Z","steps":["trace[1052581261] 'agreement among raft nodes before linearized reading' (duration: 957.189912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.839426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.881663Z","time spent":"957.749725ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-13T22:50:27.838715Z","caller":"traceutil/trace.go:171","msg":"trace[513362791] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1128; }","duration":"431.618684ms","start":"2026-06-13T22:50:27.407061Z","end":"2026-06-13T22:50:27.83868Z","steps":["trace[513362791] 'read index received' (duration: 367.190344ms)","trace[513362791] 'applied index is now lower than readState.Index' (duration: 64.42689ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:27.83884Z","caller":"traceutil/trace.go:171","msg":"trace[1446744433] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"1.250997298s","start":"2026-06-13T22:50:26.587805Z","end":"2026-06-13T22:50:27.838803Z","steps":["trace[1446744433] 'process raft request' (duration: 1.250549028s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.839647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:26.58778Z","time spent":"1.251826668s","remote":"127.0.0.1:47392","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-06-13T22:50:27.839975Z","caller":"traceutil/trace.go:171","msg":"trace[1092431283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1088; }","duration":"766.67966ms","start":"2026-06-13T22:50:27.072639Z","end":"2026-06-13T22:50:27.839319Z","steps":["trace[1092431283] 'agreement among raft nodes before linearized reading' (duration: 766.312232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.840165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:27.07262Z","time spent":"767.486289ms","remote":"127.0.0.1:51432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:50:27.926747Z","caller":"traceutil/trace.go:171","msg":"trace[1923136749] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"518.607717ms","start":"2026-06-13T22:50:27.408112Z","end":"2026-06-13T22:50:27.92672Z","steps":["trace[1923136749] 'process raft request' (duration: 518.379392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.926812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.939785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:27.92689Z","caller":"traceutil/trace.go:171","msg":"trace[758398787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1089; }","duration":"510.037048ms","start":"2026-06-13T22:50:27.416834Z","end":"2026-06-13T22:50:27.926871Z","steps":["trace[758398787] 'agreement among raft nodes before linearized reading' (duration: 509.827183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:27.926968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:27.408087Z","time spent":"518.72201ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:27.926943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:27.416784Z","time spent":"510.150271ms","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:50:28.098863Z","caller":"traceutil/trace.go:171","msg":"trace[1721508249] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"170.726913ms","start":"2026-06-13T22:50:27.928109Z","end":"2026-06-13T22:50:28.098836Z","steps":["trace[1721508249] 'read index received' (duration: 152.866097ms)","trace[1721508249] 'applied index is now lower than readState.Index' (duration: 17.858596ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:28.098918Z","caller":"traceutil/trace.go:171","msg":"trace[993268784] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"247.988551ms","start":"2026-06-13T22:50:27.850887Z","end":"2026-06-13T22:50:28.098876Z","steps":["trace[993268784] 'process raft request' (duration: 230.079544ms)","trace[993268784] 'compare' (duration: 17.740633ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:28.099062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.916887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:28.099154Z","caller":"traceutil/trace.go:171","msg":"trace[729903780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1090; }","duration":"171.062461ms","start":"2026-06-13T22:50:27.928066Z","end":"2026-06-13T22:50:28.099129Z","steps":["trace[729903780] 'agreement among raft nodes before linearized reading' (duration: 170.899687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:28.099181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.797291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-13T22:50:28.099301Z","caller":"traceutil/trace.go:171","msg":"trace[2017711801] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1090; }","duration":"169.980135ms","start":"2026-06-13T22:50:27.929293Z","end":"2026-06-13T22:50:28.099273Z","steps":["trace[2017711801] 'agreement among raft nodes before linearized reading' (duration: 169.73912ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:28.397474Z","caller":"traceutil/trace.go:171","msg":"trace[560772544] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"143.921689ms","start":"2026-06-13T22:50:28.253509Z","end":"2026-06-13T22:50:28.397431Z","steps":["trace[560772544] 'process raft request' (duration: 143.680483ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:42.036994Z","caller":"traceutil/trace.go:171","msg":"trace[253023259] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"164.176438ms","start":"2026-06-13T22:50:41.872784Z","end":"2026-06-13T22:50:42.036961Z","steps":["trace[253023259] 'read index received' (duration: 163.737888ms)","trace[253023259] 'applied index is now lower than readState.Index' (duration: 437.15µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:42.037047Z","caller":"traceutil/trace.go:171","msg":"trace[111056380] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"245.049924ms","start":"2026-06-13T22:50:41.791949Z","end":"2026-06-13T22:50:42.036999Z","steps":["trace[111056380] 'process raft request' (duration: 244.585623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.037283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.463115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:42.037376Z","caller":"traceutil/trace.go:171","msg":"trace[2104881594] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1184; }","duration":"164.608218ms","start":"2026-06-13T22:50:41.872747Z","end":"2026-06-13T22:50:42.037355Z","steps":["trace[2104881594] 'agreement among raft nodes before linearized reading' (duration: 164.385913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.259455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.162935ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T22:50:42.259579Z","caller":"traceutil/trace.go:171","msg":"trace[1909688701] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"222.471392ms","start":"2026-06-13T22:50:42.037083Z","end":"2026-06-13T22:50:42.259554Z","steps":["trace[1909688701] 'read index received' (duration: 73.130483ms)","trace[1909688701] 'applied index is now lower than readState.Index' (duration: 149.339209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:42.260151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.226471ms","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-06-13T22:50:42.260221Z","caller":"traceutil/trace.go:171","msg":"trace[392838702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1184; }","duration":"347.311473ms","start":"2026-06-13T22:50:41.912886Z","end":"2026-06-13T22:50:42.260197Z","steps":["trace[392838702] 'agreement among raft nodes before linearized reading' (duration: 347.211871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.260278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:41.912867Z","time spent":"347.399466ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:42.259819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.755132ms","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-06-13T22:50:42.2606Z","caller":"traceutil/trace.go:171","msg":"trace[241428161] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1184; }","duration":"342.471319ms","start":"2026-06-13T22:50:41.918022Z","end":"2026-06-13T22:50:42.260494Z","steps":["trace[241428161] 'agreement among raft nodes before linearized reading' (duration: 341.575358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.260746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:41.917982Z","time spent":"342.731255ms","remote":"127.0.0.1:47392","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-06-13T22:50:42.259973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.995819ms","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-06-13T22:50:42.260876Z","caller":"traceutil/trace.go:171","msg":"trace[1156178954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1184; }","duration":"342.937921ms","start":"2026-06-13T22:50:41.917921Z","end":"2026-06-13T22:50:42.260859Z","steps":["trace[1156178954] 'agreement among raft nodes before linearized reading' (duration: 341.985858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.260935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:41.917897Z","time spent":"343.021532ms","remote":"127.0.0.1:47392","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-06-13T22:50:42.260067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.062887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T22:50:42.261073Z","caller":"traceutil/trace.go:171","msg":"trace[2089364013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1184; }","duration":"348.099891ms","start":"2026-06-13T22:50:41.912957Z","end":"2026-06-13T22:50:42.261056Z","steps":["trace[2089364013] 'agreement among raft nodes before linearized reading' (duration: 347.050397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:42.261147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:41.912931Z","time spent":"348.197674ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:42.4929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.195778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:42.493134Z","caller":"traceutil/trace.go:171","msg":"trace[1372319684] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"223.767912ms","start":"2026-06-13T22:50:42.269346Z","end":"2026-06-13T22:50:42.493114Z","steps":["trace[1372319684] 'process raft request' (duration: 223.728501ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:42.493946Z","caller":"traceutil/trace.go:171","msg":"trace[2047984756] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"225.023332ms","start":"2026-06-13T22:50:42.268902Z","end":"2026-06-13T22:50:42.493926Z","steps":["trace[2047984756] 'process raft request' (duration: 224.09681ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:42.493946Z","caller":"traceutil/trace.go:171","msg":"trace[265589705] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"225.065723ms","start":"2026-06-13T22:50:42.26885Z","end":"2026-06-13T22:50:42.493916Z","steps":["trace[265589705] 'process raft request' (duration: 93.770469ms)","trace[265589705] 'compare' (duration: 129.975863ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:42.494096Z","caller":"traceutil/trace.go:171","msg":"trace[404755574] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"225.081834ms","start":"2026-06-13T22:50:42.268947Z","end":"2026-06-13T22:50:42.494029Z","steps":["trace[404755574] 'process raft request' (duration: 224.09295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:44.645072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999985034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-13T22:50:44.645202Z","caller":"traceutil/trace.go:171","msg":"trace[1746058367] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000202009s","start":"2026-06-13T22:50:42.644981Z","end":"2026-06-13T22:50:44.645182Z","steps":["trace[1746058367] 'agreement among raft nodes before linearized reading' (duration: 2.000041136s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:44.645259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:42.64496Z","time spent":"2.000284831s","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T22:50:45.113402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.678063ms","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-06-13T22:50:45.113545Z","caller":"traceutil/trace.go:171","msg":"trace[825821589] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1189; }","duration":"971.846597ms","start":"2026-06-13T22:50:44.141679Z","end":"2026-06-13T22:50:45.113526Z","steps":["trace[825821589] 'range keys from in-memory index tree' (duration: 971.654343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.114124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466164507s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:45.114247Z","caller":"traceutil/trace.go:171","msg":"trace[1790750853] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1238; }","duration":"2.469169158s","start":"2026-06-13T22:50:42.64506Z","end":"2026-06-13T22:50:45.114229Z","steps":["trace[1790750853] 'read index received' (duration: 2.846527ms)","trace[1790750853] 'applied index is now lower than readState.Index' (duration: 2.466320451s)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:45.11432Z","caller":"traceutil/trace.go:171","msg":"trace[1328249524] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"2.483597198s","start":"2026-06-13T22:50:42.630704Z","end":"2026-06-13T22:50:45.114302Z","steps":["trace[1328249524] 'process raft request' (duration: 17.127654ms)","trace[1328249524] 'compare' (duration: 2.465940461s)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:45.114374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.837563626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:45.114414Z","caller":"traceutil/trace.go:171","msg":"trace[1171020329] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1190; }","duration":"1.837639628s","start":"2026-06-13T22:50:43.276762Z","end":"2026-06-13T22:50:45.114401Z","steps":["trace[1171020329] 'agreement among raft nodes before linearized reading' (duration: 1.837570986s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.114446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:42.630667Z","time spent":"2.48370383s","remote":"127.0.0.1:47392","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-06-13T22:50:45.114458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:43.276734Z","time spent":"1.837710179s","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:45.114641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.540668ms","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-06-13T22:50:45.114679Z","caller":"traceutil/trace.go:171","msg":"trace[452884495] 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:1190; }","duration":"611.607239ms","start":"2026-06-13T22:50:44.50306Z","end":"2026-06-13T22:50:45.114667Z","steps":["trace[452884495] 'agreement among raft nodes before linearized reading' (duration: 611.540798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.11471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.503049Z","time spent":"611.652651ms","remote":"127.0.0.1:51452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:45.114673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.690998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-13T22:50:45.114788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.940545ms","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-06-13T22:50:45.114794Z","caller":"traceutil/trace.go:171","msg":"trace[737497004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1190; }","duration":"613.872433ms","start":"2026-06-13T22:50:44.500898Z","end":"2026-06-13T22:50:45.11477Z","steps":["trace[737497004] 'agreement among raft nodes before linearized reading' (duration: 613.539425ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:45.114823Z","caller":"traceutil/trace.go:171","msg":"trace[2070464645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1190; }","duration":"613.996906ms","start":"2026-06-13T22:50:44.500817Z","end":"2026-06-13T22:50:45.114814Z","steps":["trace[2070464645] 'agreement among raft nodes before linearized reading' (duration: 613.850142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.114853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.500804Z","time spent":"614.043427ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:45.11485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.500869Z","time spent":"613.971475ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:45.114938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.591643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:45.114963Z","caller":"traceutil/trace.go:171","msg":"trace[1332347051] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1190; }","duration":"963.648244ms","start":"2026-06-13T22:50:44.151307Z","end":"2026-06-13T22:50:45.114955Z","steps":["trace[1332347051] 'agreement among raft nodes before linearized reading' (duration: 963.608323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.114965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.125241ms","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":"warn","ts":"2026-06-13T22:50:45.114989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.151289Z","time spent":"963.693376ms","remote":"127.0.0.1:47530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:50:45.115007Z","caller":"traceutil/trace.go:171","msg":"trace[880517359] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1190; }","duration":"839.205133ms","start":"2026-06-13T22:50:44.27579Z","end":"2026-06-13T22:50:45.114995Z","steps":["trace[880517359] 'agreement among raft nodes before linearized reading' (duration: 839.08668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.115045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.27577Z","time spent":"839.266594ms","remote":"127.0.0.1:47392","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-06-13T22:50:45.115053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.956375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-13T22:50:45.115094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.184041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-13T22:50:45.115108Z","caller":"traceutil/trace.go:171","msg":"trace[404414963] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1190; }","duration":"614.011626ms","start":"2026-06-13T22:50:44.501085Z","end":"2026-06-13T22:50:45.115096Z","steps":["trace[404414963] 'agreement among raft nodes before linearized reading' (duration: 613.893853ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:45.115131Z","caller":"traceutil/trace.go:171","msg":"trace[2072979173] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1190; }","duration":"617.254183ms","start":"2026-06-13T22:50:44.497866Z","end":"2026-06-13T22:50:45.11512Z","steps":["trace[2072979173] 'agreement among raft nodes before linearized reading' (duration: 617.12192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.11514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.501026Z","time spent":"614.107588ms","remote":"127.0.0.1:47392","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-06-13T22:50:45.115161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.497846Z","time spent":"617.308954ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T22:50:45.114578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:45.116489Z","caller":"traceutil/trace.go:171","msg":"trace[762954724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1190; }","duration":"470.560266ms","start":"2026-06-13T22:50:44.645909Z","end":"2026-06-13T22:50:45.116469Z","steps":["trace[762954724] 'agreement among raft nodes before linearized reading' (duration: 468.585789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.11654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:44.645888Z","time spent":"470.641528ms","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:50:45.603248Z","caller":"traceutil/trace.go:171","msg":"trace[494148471] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"482.900848ms","start":"2026-06-13T22:50:45.120288Z","end":"2026-06-13T22:50:45.603188Z","steps":["trace[494148471] 'process raft request' (duration: 478.811872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.60347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.120266Z","time spent":"483.084403ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:45.603481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.149334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b8c59f8af75606\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-06-13T22:50:45.60353Z","caller":"traceutil/trace.go:171","msg":"trace[940142456] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18b8c59f8af75606; range_end:; response_count:1; response_revision:1191; }","duration":"483.239416ms","start":"2026-06-13T22:50:45.120277Z","end":"2026-06-13T22:50:45.603516Z","steps":["trace[940142456] 'agreement among raft nodes before linearized reading' (duration: 483.077372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.603557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.120256Z","time spent":"483.294238ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18b8c59f8af75606\" "} {"level":"info","ts":"2026-06-13T22:50:45.603762Z","caller":"traceutil/trace.go:171","msg":"trace[897684175] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"482.291294ms","start":"2026-06-13T22:50:45.121442Z","end":"2026-06-13T22:50:45.603733Z","steps":["trace[897684175] 'process raft request' (duration: 482.242603ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:45.603861Z","caller":"traceutil/trace.go:171","msg":"trace[1543815150] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"483.417611ms","start":"2026-06-13T22:50:45.120433Z","end":"2026-06-13T22:50:45.603851Z","steps":["trace[1543815150] 'process raft request' (duration: 483.021871ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:45.603887Z","caller":"traceutil/trace.go:171","msg":"trace[1026198044] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"482.763135ms","start":"2026-06-13T22:50:45.121109Z","end":"2026-06-13T22:50:45.603872Z","steps":["trace[1026198044] 'process raft request' (duration: 482.492649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.60394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.1204Z","time spent":"483.480842ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:45.603949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.121429Z","time spent":"482.432207ms","remote":"127.0.0.1:47392","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-06-13T22:50:45.603959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.121098Z","time spent":"482.821286ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:45.603979Z","caller":"traceutil/trace.go:171","msg":"trace[522527182] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"482.54753ms","start":"2026-06-13T22:50:45.121407Z","end":"2026-06-13T22:50:45.603955Z","steps":["trace[522527182] 'process raft request' (duration: 482.243083ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:45.603138Z","caller":"traceutil/trace.go:171","msg":"trace[375323870] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"482.809206ms","start":"2026-06-13T22:50:45.120308Z","end":"2026-06-13T22:50:45.603118Z","steps":["trace[375323870] 'read index received' (duration: 478.803672ms)","trace[375323870] 'applied index is now lower than readState.Index' (duration: 4.004654ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:45.60415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.121384Z","time spent":"482.677353ms","remote":"127.0.0.1:47392","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-06-13T22:50:45.604314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.649055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:45.604397Z","caller":"traceutil/trace.go:171","msg":"trace[2076786461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"480.693616ms","start":"2026-06-13T22:50:45.123636Z","end":"2026-06-13T22:50:45.60433Z","steps":["trace[2076786461] 'agreement among raft nodes before linearized reading' (duration: 480.656145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.604417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.123625Z","time spent":"480.787099ms","remote":"127.0.0.1:47146","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-06-13T22:50:45.604402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.090881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:45.604461Z","caller":"traceutil/trace.go:171","msg":"trace[1467028823] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1195; }","duration":"449.181154ms","start":"2026-06-13T22:50:45.155263Z","end":"2026-06-13T22:50:45.604444Z","steps":["trace[1467028823] 'agreement among raft nodes before linearized reading' (duration: 449.078831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.60448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.091165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-13T22:50:45.604496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.155246Z","time spent":"449.241265ms","remote":"127.0.0.1:47824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:50:45.604524Z","caller":"traceutil/trace.go:171","msg":"trace[589481493] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:1195; }","duration":"304.168887ms","start":"2026-06-13T22:50:45.300342Z","end":"2026-06-13T22:50:45.604511Z","steps":["trace[589481493] 'agreement among raft nodes before linearized reading' (duration: 303.969592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:45.604558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:45.300318Z","time spent":"304.233248ms","remote":"127.0.0.1:47164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"info","ts":"2026-06-13T22:50:59.451041Z","caller":"traceutil/trace.go:171","msg":"trace[1642620748] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"252.448977ms","start":"2026-06-13T22:50:59.198561Z","end":"2026-06-13T22:50:59.45101Z","steps":["trace[1642620748] 'process raft request' (duration: 252.308023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:59.956366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.773949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:59.95648Z","caller":"traceutil/trace.go:171","msg":"trace[1286878390] linearizableReadLoop","detail":"{readStateIndex:1293; appliedIndex:1291; }","duration":"267.234776ms","start":"2026-06-13T22:50:59.689235Z","end":"2026-06-13T22:50:59.95647Z","steps":["trace[1286878390] 'read index received' (duration: 162.304174ms)","trace[1286878390] 'applied index is now lower than readState.Index' (duration: 104.930062ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:59.956546Z","caller":"traceutil/trace.go:171","msg":"trace[178994965] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"273.519335ms","start":"2026-06-13T22:50:59.683019Z","end":"2026-06-13T22:50:59.956538Z","steps":["trace[178994965] 'process raft request' (duration: 168.519841ms)","trace[178994965] 'compare' (duration: 104.695177ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:59.956615Z","caller":"traceutil/trace.go:171","msg":"trace[363627397] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"272.4461ms","start":"2026-06-13T22:50:59.684165Z","end":"2026-06-13T22:50:59.956611Z","steps":["trace[363627397] 'process raft request' (duration: 272.275876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:59.956702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.464212ms","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-06-13T22:50:59.956715Z","caller":"traceutil/trace.go:171","msg":"trace[400746466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"267.490712ms","start":"2026-06-13T22:50:59.68922Z","end":"2026-06-13T22:50:59.95671Z","steps":["trace[400746466] 'agreement among raft nodes before linearized reading' (duration: 267.426691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:59.95682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.492772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T22:50:59.956904Z","caller":"traceutil/trace.go:171","msg":"trace[1112861439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"267.599335ms","start":"2026-06-13T22:50:59.689273Z","end":"2026-06-13T22:50:59.956872Z","steps":["trace[1112861439] 'agreement among raft nodes before linearized reading' (duration: 267.421571ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:02.079844Z","caller":"traceutil/trace.go:171","msg":"trace[156592084] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"112.853649ms","start":"2026-06-13T22:51:01.966969Z","end":"2026-06-13T22:51:02.079822Z","steps":["trace[156592084] 'process raft request' (duration: 112.618483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:02.204214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.28325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:02.204415Z","caller":"traceutil/trace.go:171","msg":"trace[990457315] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"119.436964ms","start":"2026-06-13T22:51:02.084959Z","end":"2026-06-13T22:51:02.204396Z","steps":["trace[990457315] 'process raft request' (duration: 119.376403ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:02.204523Z","caller":"traceutil/trace.go:171","msg":"trace[1010254895] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"119.704391ms","start":"2026-06-13T22:51:02.084788Z","end":"2026-06-13T22:51:02.204493Z","steps":["trace[1010254895] 'process raft request' (duration: 17.055402ms)","trace[1010254895] 'compare' (duration: 102.129516ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:03.52874Z","caller":"traceutil/trace.go:171","msg":"trace[1818902057] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1317; }","duration":"127.116225ms","start":"2026-06-13T22:51:03.401597Z","end":"2026-06-13T22:51:03.528713Z","steps":["trace[1818902057] 'read index received' (duration: 126.938801ms)","trace[1818902057] 'applied index is now lower than readState.Index' (duration: 176.324µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:03.528799Z","caller":"traceutil/trace.go:171","msg":"trace[521514685] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"155.957195ms","start":"2026-06-13T22:51:03.372808Z","end":"2026-06-13T22:51:03.528765Z","steps":["trace[521514685] 'process raft request' (duration: 155.74956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:03.529009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.383512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:03.529116Z","caller":"traceutil/trace.go:171","msg":"trace[2039604168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1265; }","duration":"127.503395ms","start":"2026-06-13T22:51:03.401584Z","end":"2026-06-13T22:51:03.529088Z","steps":["trace[2039604168] 'agreement among raft nodes before linearized reading' (duration: 127.231458ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:03.894117Z","caller":"traceutil/trace.go:171","msg":"trace[1294105037] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"104.252187ms","start":"2026-06-13T22:51:03.789788Z","end":"2026-06-13T22:51:03.89404Z","steps":["trace[1294105037] 'process raft request' (duration: 104.110053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:06.217897Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829314537283077,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T22:51:06.640479Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.337943804s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-13T22:51:06.640907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:05.302423Z","time spent":"1.338480077s","remote":"127.0.0.1:47164","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-13T22:51:06.978756Z","caller":"traceutil/trace.go:171","msg":"trace[2082632180] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1329; }","duration":"1.261119323s","start":"2026-06-13T22:51:05.717614Z","end":"2026-06-13T22:51:06.978733Z","steps":["trace[2082632180] 'read index received' (duration: 923.226782ms)","trace[2082632180] 'applied index is now lower than readState.Index' (duration: 337.891471ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:06.97883Z","caller":"traceutil/trace.go:171","msg":"trace[2040563197] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"1.44304406s","start":"2026-06-13T22:51:05.535756Z","end":"2026-06-13T22:51:06.9788Z","steps":["trace[2040563197] 'process raft request' (duration: 1.442586899s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:06.978939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261313069s","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-06-13T22:51:06.97898Z","caller":"traceutil/trace.go:171","msg":"trace[1242028612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1277; }","duration":"1.261409551s","start":"2026-06-13T22:51:05.717561Z","end":"2026-06-13T22:51:06.978971Z","steps":["trace[1242028612] 'agreement among raft nodes before linearized reading' (duration: 1.261260367s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:06.978979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:05.535734Z","time spent":"1.443172184s","remote":"127.0.0.1:47392","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-06-13T22:51:06.979006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:05.717541Z","time spent":"1.261459012s","remote":"127.0.0.1:47392","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-06-13T22:51:07.177857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.614533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:07.178054Z","caller":"traceutil/trace.go:171","msg":"trace[503021950] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"195.476066ms","start":"2026-06-13T22:51:06.982561Z","end":"2026-06-13T22:51:07.178037Z","steps":["trace[503021950] 'process raft request' (duration: 195.403244ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:07.178324Z","caller":"traceutil/trace.go:171","msg":"trace[492348918] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"534.424812ms","start":"2026-06-13T22:51:06.643888Z","end":"2026-06-13T22:51:07.178313Z","steps":["trace[492348918] 'process raft request' (duration: 407.262706ms)","trace[492348918] 'compare' (duration: 126.358527ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:07.178389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.643868Z","time spent":"534.488814ms","remote":"127.0.0.1:47164","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-06-13T22:51:07.178643Z","caller":"traceutil/trace.go:171","msg":"trace[457971103] linearizableReadLoop","detail":"{readStateIndex:1332; appliedIndex:1331; }","duration":"199.780528ms","start":"2026-06-13T22:51:06.978818Z","end":"2026-06-13T22:51:07.178598Z","steps":["trace[457971103] 'read index received' (duration: 72.272123ms)","trace[457971103] 'applied index is now lower than readState.Index' (duration: 127.507375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:07.178772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393567144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:07.178809Z","caller":"traceutil/trace.go:171","msg":"trace[1531006771] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1279; }","duration":"1.393636435s","start":"2026-06-13T22:51:05.785163Z","end":"2026-06-13T22:51:07.178799Z","steps":["trace[1531006771] 'agreement among raft nodes before linearized reading' (duration: 1.393520363s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.178846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:05.785145Z","time spent":"1.393692347s","remote":"127.0.0.1:51416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:51:07.179162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.772837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:07.179201Z","caller":"traceutil/trace.go:171","msg":"trace[1820909493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1279; }","duration":"533.830018ms","start":"2026-06-13T22:51:06.645362Z","end":"2026-06-13T22:51:07.179192Z","steps":["trace[1820909493] 'agreement among raft nodes before linearized reading' (duration: 533.777486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.179232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.645354Z","time spent":"533.872419ms","remote":"127.0.0.1:47146","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-06-13T22:51:07.179435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.492816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-13T22:51:07.17947Z","caller":"traceutil/trace.go:171","msg":"trace[1677260317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1279; }","duration":"914.544078ms","start":"2026-06-13T22:51:06.264918Z","end":"2026-06-13T22:51:07.179462Z","steps":["trace[1677260317] 'agreement among raft nodes before linearized reading' (duration: 914.439816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.179501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.26491Z","time spent":"914.585249ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:51:07.179665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.664811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-13T22:51:07.179699Z","caller":"traceutil/trace.go:171","msg":"trace[24013106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1279; }","duration":"928.722261ms","start":"2026-06-13T22:51:06.250969Z","end":"2026-06-13T22:51:07.179691Z","steps":["trace[24013106] 'agreement among raft nodes before linearized reading' (duration: 928.637519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.179728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.250958Z","time spent":"928.764622ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:51:07.17988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.080298453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-13T22:51:07.179916Z","caller":"traceutil/trace.go:171","msg":"trace[72262118] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1279; }","duration":"1.080366815s","start":"2026-06-13T22:51:06.099541Z","end":"2026-06-13T22:51:07.179908Z","steps":["trace[72262118] 'agreement among raft nodes before linearized reading' (duration: 1.080286113s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.179949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.099524Z","time spent":"1.080417816s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T22:51:07.180107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138787391s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-13T22:51:07.180141Z","caller":"traceutil/trace.go:171","msg":"trace[808500891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1279; }","duration":"1.138856393s","start":"2026-06-13T22:51:06.041277Z","end":"2026-06-13T22:51:07.180133Z","steps":["trace[808500891] 'agreement among raft nodes before linearized reading' (duration: 1.138773481s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:07.18017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:06.041258Z","time spent":"1.138907194s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-13T22:51:07.709131Z","caller":"traceutil/trace.go:171","msg":"trace[638099307] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"251.755092ms","start":"2026-06-13T22:51:07.457353Z","end":"2026-06-13T22:51:07.709108Z","steps":["trace[638099307] 'process raft request' (duration: 251.629709ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:09.246929Z","caller":"traceutil/trace.go:171","msg":"trace[1463177834] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"482.494368ms","start":"2026-06-13T22:51:08.7644Z","end":"2026-06-13T22:51:09.246894Z","steps":["trace[1463177834] 'process raft request' (duration: 482.345935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:09.247104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:08.764375Z","time spent":"482.647222ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:51:10.5728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.811165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:10.572899Z","caller":"traceutil/trace.go:171","msg":"trace[1061080349] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1338; }","duration":"1.385159326s","start":"2026-06-13T22:51:09.187724Z","end":"2026-06-13T22:51:10.572884Z","steps":["trace[1061080349] 'read index received' (duration: 59.141283ms)","trace[1061080349] 'applied index is now lower than readState.Index' (duration: 1.326016933s)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:10.572964Z","caller":"traceutil/trace.go:171","msg":"trace[1856167221] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"1.58946628s","start":"2026-06-13T22:51:08.983466Z","end":"2026-06-13T22:51:10.572932Z","steps":["trace[1856167221] 'process raft request' (duration: 901.44466ms)","trace[1856167221] 'compare' (duration: 687.244212ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:10.573084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.385364301s","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-06-13T22:51:10.573124Z","caller":"traceutil/trace.go:171","msg":"trace[308131681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1286; }","duration":"1.385442463s","start":"2026-06-13T22:51:09.187672Z","end":"2026-06-13T22:51:10.573114Z","steps":["trace[308131681] 'agreement among raft nodes before linearized reading' (duration: 1.385277349s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:10.573145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:08.983448Z","time spent":"1.589601023s","remote":"127.0.0.1:47392","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-06-13T22:51:10.573161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:09.187653Z","time spent":"1.385501004s","remote":"127.0.0.1:47392","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-06-13T22:51:11.225685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.942328ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T22:51:11.225939Z","caller":"traceutil/trace.go:171","msg":"trace[2117158735] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"647.341793ms","start":"2026-06-13T22:51:10.578578Z","end":"2026-06-13T22:51:11.22592Z","steps":["trace[2117158735] 'process raft request' (duration: 647.20907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.226049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:10.578551Z","time spent":"647.431335ms","remote":"127.0.0.1:47392","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-06-13T22:51:11.226119Z","caller":"traceutil/trace.go:171","msg":"trace[499529236] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"653.17111ms","start":"2026-06-13T22:51:10.572924Z","end":"2026-06-13T22:51:11.226095Z","steps":["trace[499529236] 'read index received' (duration: 234.776292ms)","trace[499529236] 'applied index is now lower than readState.Index' (duration: 418.392308ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:11.226284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.040828704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:11.226324Z","caller":"traceutil/trace.go:171","msg":"trace[1064445463] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1287; }","duration":"1.040958128s","start":"2026-06-13T22:51:10.185355Z","end":"2026-06-13T22:51:11.226313Z","steps":["trace[1064445463] 'agreement among raft nodes before linearized reading' (duration: 1.040850635s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.226358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:10.185337Z","time spent":"1.041011608s","remote":"127.0.0.1:34862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:51:11.226647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997991216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-13T22:51:11.226685Z","caller":"traceutil/trace.go:171","msg":"trace[1271918690] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1287; }","duration":"1.998051847s","start":"2026-06-13T22:51:09.228624Z","end":"2026-06-13T22:51:11.226676Z","steps":["trace[1271918690] 'agreement among raft nodes before linearized reading' (duration: 1.997900334s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.226712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:09.228611Z","time spent":"1.998094939s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T22:51:11.226725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.998120299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-13T22:51:11.22677Z","caller":"traceutil/trace.go:171","msg":"trace[849650470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1287; }","duration":"1.99818061s","start":"2026-06-13T22:51:09.228578Z","end":"2026-06-13T22:51:11.226758Z","steps":["trace[849650470] 'agreement among raft nodes before linearized reading' (duration: 1.998092898s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.226808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:09.228567Z","time spent":"1.998233862s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T22:51:11.226647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99860915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-13T22:51:11.226847Z","caller":"traceutil/trace.go:171","msg":"trace[91939664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1287; }","duration":"1.998845836s","start":"2026-06-13T22:51:09.227992Z","end":"2026-06-13T22:51:11.226838Z","steps":["trace[91939664] 'agreement among raft nodes before linearized reading' (duration: 1.998560179s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.226888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:09.227975Z","time spent":"1.998904238s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:51:11.227073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.012685472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-13T22:51:11.227153Z","caller":"traceutil/trace.go:171","msg":"trace[218346848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1287; }","duration":"2.012809705s","start":"2026-06-13T22:51:09.214318Z","end":"2026-06-13T22:51:11.227128Z","steps":["trace[218346848] 'agreement among raft nodes before linearized reading' (duration: 2.012294193s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.227418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:09.214296Z","time spent":"2.013102082s","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-13T22:51:11.469093Z","caller":"traceutil/trace.go:171","msg":"trace[3466767] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1342; }","duration":"242.884683ms","start":"2026-06-13T22:51:11.226183Z","end":"2026-06-13T22:51:11.469068Z","steps":["trace[3466767] 'read index received' (duration: 200.899244ms)","trace[3466767] 'applied index is now lower than readState.Index' (duration: 41.984309ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:11.469228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.238054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:51:11.469383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.993039ms","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":"info","ts":"2026-06-13T22:51:11.469323Z","caller":"traceutil/trace.go:171","msg":"trace[1733662947] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"371.997525ms","start":"2026-06-13T22:51:11.09731Z","end":"2026-06-13T22:51:11.469308Z","steps":["trace[1733662947] 'process raft request' (duration: 329.760879ms)","trace[1733662947] 'compare' (duration: 41.837496ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:11.469435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.756465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:11.469478Z","caller":"traceutil/trace.go:171","msg":"trace[907272516] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1288; }","duration":"272.142802ms","start":"2026-06-13T22:51:11.197316Z","end":"2026-06-13T22:51:11.469458Z","steps":["trace[907272516] 'agreement among raft nodes before linearized reading' (duration: 271.957568ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:11.469515Z","caller":"traceutil/trace.go:171","msg":"trace[1710679503] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1288; }","duration":"423.905448ms","start":"2026-06-13T22:51:11.045591Z","end":"2026-06-13T22:51:11.469497Z","steps":["trace[1710679503] 'agreement among raft nodes before linearized reading' (duration: 423.754595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.469576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:11.045567Z","time spent":"423.99615ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:51:11.469787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:11.097284Z","time spent":"372.18916ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T22:51:11.469943Z","caller":"traceutil/trace.go:171","msg":"trace[1922350732] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1288; }","duration":"825.324257ms","start":"2026-06-13T22:51:10.643932Z","end":"2026-06-13T22:51:11.469256Z","steps":["trace[1922350732] 'agreement among raft nodes before linearized reading' (duration: 825.228294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:11.470015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:10.643919Z","time spent":"826.081724ms","remote":"127.0.0.1:47146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:51:11.492761Z","caller":"traceutil/trace.go:171","msg":"trace[1733315925] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"260.821536ms","start":"2026-06-13T22:51:11.231912Z","end":"2026-06-13T22:51:11.492734Z","steps":["trace[1733315925] 'process raft request' (duration: 260.683483ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:11.492795Z","caller":"traceutil/trace.go:171","msg":"trace[534183688] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"260.760614ms","start":"2026-06-13T22:51:11.232023Z","end":"2026-06-13T22:51:11.492783Z","steps":["trace[534183688] 'process raft request' (duration: 260.59466ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:11.493043Z","caller":"traceutil/trace.go:171","msg":"trace[1952162849] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"261.147883ms","start":"2026-06-13T22:51:11.23189Z","end":"2026-06-13T22:51:11.493038Z","steps":["trace[1952162849] 'process raft request' (duration: 260.681082ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:11.493056Z","caller":"traceutil/trace.go:171","msg":"trace[956194437] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"262.386182ms","start":"2026-06-13T22:51:11.230656Z","end":"2026-06-13T22:51:11.493043Z","steps":["trace[956194437] 'process raft request' (duration: 261.797528ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:11.695924Z","caller":"traceutil/trace.go:171","msg":"trace[1228458985] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"203.253628ms","start":"2026-06-13T22:51:11.492642Z","end":"2026-06-13T22:51:11.695896Z","steps":["trace[1228458985] 'read index received' (duration: 136.130327ms)","trace[1228458985] 'applied index is now lower than readState.Index' (duration: 67.121991ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:11.695944Z","caller":"traceutil/trace.go:171","msg":"trace[1121580455] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"207.922879ms","start":"2026-06-13T22:51:11.487993Z","end":"2026-06-13T22:51:11.695916Z","steps":["trace[1121580455] 'process raft request' (duration: 140.821628ms)","trace[1121580455] 'compare' (duration: 66.920647ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:11.696528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.41009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:11.696724Z","caller":"traceutil/trace.go:171","msg":"trace[660702629] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1293; }","duration":"219.670856ms","start":"2026-06-13T22:51:11.476888Z","end":"2026-06-13T22:51:11.696559Z","steps":["trace[660702629] 'agreement among raft nodes before linearized reading' (duration: 219.180375ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:12.139999Z","caller":"traceutil/trace.go:171","msg":"trace[1542650014] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"440.156601ms","start":"2026-06-13T22:51:11.699819Z","end":"2026-06-13T22:51:12.139975Z","steps":["trace[1542650014] 'process raft request' (duration: 440.019118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:12.140128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:11.699798Z","time spent":"440.270223ms","remote":"127.0.0.1:47214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T22:51:12.507922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.016481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:12.508036Z","caller":"traceutil/trace.go:171","msg":"trace[1364712819] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1348; }","duration":"794.463449ms","start":"2026-06-13T22:51:11.713557Z","end":"2026-06-13T22:51:12.50802Z","steps":["trace[1364712819] 'read index received' (duration: 426.197612ms)","trace[1364712819] 'applied index is now lower than readState.Index' (duration: 368.264347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:12.508189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.627083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:12.508219Z","caller":"traceutil/trace.go:171","msg":"trace[33613675] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1295; }","duration":"794.695075ms","start":"2026-06-13T22:51:11.713515Z","end":"2026-06-13T22:51:12.50821Z","steps":["trace[33613675] 'agreement among raft nodes before linearized reading' (duration: 794.577702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:12.508253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:11.713502Z","time spent":"794.740535ms","remote":"127.0.0.1:47952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:51:12.508475Z","caller":"traceutil/trace.go:171","msg":"trace[624814803] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"808.51443ms","start":"2026-06-13T22:51:11.699943Z","end":"2026-06-13T22:51:12.508458Z","steps":["trace[624814803] 'process raft request' (duration: 599.899795ms)","trace[624814803] 'compare' (duration: 207.770826ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:12.508563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:11.69993Z","time spent":"808.583162ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T22:51:12.808386Z","caller":"traceutil/trace.go:171","msg":"trace[1339064404] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"294.596762ms","start":"2026-06-13T22:51:12.513766Z","end":"2026-06-13T22:51:12.808363Z","steps":["trace[1339064404] 'read index received' (duration: 292.876311ms)","trace[1339064404] 'applied index is now lower than readState.Index' (duration: 1.719311ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:12.808636Z","caller":"traceutil/trace.go:171","msg":"trace[1280742726] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"355.593639ms","start":"2026-06-13T22:51:12.453029Z","end":"2026-06-13T22:51:12.808622Z","steps":["trace[1280742726] 'process raft request' (duration: 353.625842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:12.808742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:12.453005Z","time spent":"355.66217ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:51:12.808988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.003481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:12.809058Z","caller":"traceutil/trace.go:171","msg":"trace[2094451951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1298; }","duration":"163.123414ms","start":"2026-06-13T22:51:12.645917Z","end":"2026-06-13T22:51:12.80904Z","steps":["trace[2094451951] 'agreement among raft nodes before linearized reading' (duration: 162.94834ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:12.80914Z","caller":"traceutil/trace.go:171","msg":"trace[1420503282] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"293.818543ms","start":"2026-06-13T22:51:12.515309Z","end":"2026-06-13T22:51:12.809128Z","steps":["trace[1420503282] 'process raft request' (duration: 293.348122ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:12.809346Z","caller":"traceutil/trace.go:171","msg":"trace[535341764] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"230.88413ms","start":"2026-06-13T22:51:12.578449Z","end":"2026-06-13T22:51:12.809333Z","steps":["trace[535341764] 'process raft request' (duration: 230.334627ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:12.808848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.079533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-13T22:51:12.81112Z","caller":"traceutil/trace.go:171","msg":"trace[1754746855] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1296; }","duration":"297.303036ms","start":"2026-06-13T22:51:12.513729Z","end":"2026-06-13T22:51:12.811032Z","steps":["trace[1754746855] 'agreement among raft nodes before linearized reading' (duration: 294.983391ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:13.581334Z","caller":"traceutil/trace.go:171","msg":"trace[908444805] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"349.496444ms","start":"2026-06-13T22:51:13.231813Z","end":"2026-06-13T22:51:13.581309Z","steps":["trace[908444805] 'read index received' (duration: 349.294119ms)","trace[908444805] 'applied index is now lower than readState.Index' (duration: 201.005µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:13.58167Z","caller":"traceutil/trace.go:171","msg":"trace[456115220] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"762.833423ms","start":"2026-06-13T22:51:12.818816Z","end":"2026-06-13T22:51:13.581649Z","steps":["trace[456115220] 'process raft request' (duration: 762.356022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:13.581785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:12.818791Z","time spent":"762.932156ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:51:13.581885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.057807ms","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-06-13T22:51:13.581944Z","caller":"traceutil/trace.go:171","msg":"trace[1511065202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"350.16825ms","start":"2026-06-13T22:51:13.231764Z","end":"2026-06-13T22:51:13.581932Z","steps":["trace[1511065202] 'agreement among raft nodes before linearized reading' (duration: 349.935114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:13.582009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:13.231714Z","time spent":"350.280582ms","remote":"127.0.0.1:47392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-13T22:51:13.793148Z","caller":"traceutil/trace.go:171","msg":"trace[1986821041] linearizableReadLoop","detail":"{readStateIndex:1359; appliedIndex:1354; }","duration":"179.918159ms","start":"2026-06-13T22:51:13.613209Z","end":"2026-06-13T22:51:13.793127Z","steps":["trace[1986821041] 'read index received' (duration: 2.937849ms)","trace[1986821041] 'applied index is now lower than readState.Index' (duration: 176.97939ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:13.793209Z","caller":"traceutil/trace.go:171","msg":"trace[1956889747] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"206.456115ms","start":"2026-06-13T22:51:13.58672Z","end":"2026-06-13T22:51:13.793176Z","steps":["trace[1956889747] 'process raft request' (duration: 206.190959ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:13.793269Z","caller":"traceutil/trace.go:171","msg":"trace[958843322] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"206.498576ms","start":"2026-06-13T22:51:13.58676Z","end":"2026-06-13T22:51:13.793258Z","steps":["trace[958843322] 'process raft request' (duration: 206.290391ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:13.793456Z","caller":"traceutil/trace.go:171","msg":"trace[491393080] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"207.12125ms","start":"2026-06-13T22:51:13.586306Z","end":"2026-06-13T22:51:13.793427Z","steps":["trace[491393080] 'process raft request' (duration: 160.494351ms)","trace[491393080] 'compare' (duration: 45.82854ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:13.793497Z","caller":"traceutil/trace.go:171","msg":"trace[1090008370] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"206.293461ms","start":"2026-06-13T22:51:13.587194Z","end":"2026-06-13T22:51:13.793487Z","steps":["trace[1090008370] 'process raft request' (duration: 205.898581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:13.79367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.773437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-13T22:51:13.793729Z","caller":"traceutil/trace.go:171","msg":"trace[1238600467] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1304; }","duration":"171.87957ms","start":"2026-06-13T22:51:13.621832Z","end":"2026-06-13T22:51:13.793712Z","steps":["trace[1238600467] 'agreement among raft nodes before linearized reading' (duration: 171.765317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:13.793719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.486262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:122795"} {"level":"info","ts":"2026-06-13T22:51:13.793781Z","caller":"traceutil/trace.go:171","msg":"trace[1021139008] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1304; }","duration":"180.598965ms","start":"2026-06-13T22:51:13.613167Z","end":"2026-06-13T22:51:13.793766Z","steps":["trace[1021139008] 'agreement among raft nodes before linearized reading' (duration: 180.36016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:14.805134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.892348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:51:14.805204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.837517ms","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-06-13T22:51:14.805275Z","caller":"traceutil/trace.go:171","msg":"trace[1925119832] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1304; }","duration":"662.914549ms","start":"2026-06-13T22:51:14.142354Z","end":"2026-06-13T22:51:14.805269Z","steps":["trace[1925119832] 'range keys from in-memory index tree' (duration: 662.828597ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:14.805245Z","caller":"traceutil/trace.go:171","msg":"trace[609580218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1304; }","duration":"160.006789ms","start":"2026-06-13T22:51:14.645181Z","end":"2026-06-13T22:51:14.805188Z","steps":["trace[609580218] 'range keys from in-memory index tree' (duration: 159.764114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:16.615004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.023079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:16.615192Z","caller":"traceutil/trace.go:171","msg":"trace[1002199593] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1313; }","duration":"227.255535ms","start":"2026-06-13T22:51:16.38791Z","end":"2026-06-13T22:51:16.615165Z","steps":["trace[1002199593] 'range keys from in-memory index tree' (duration: 226.889345ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:19.499401Z","caller":"traceutil/trace.go:171","msg":"trace[1875629853] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"115.44468ms","start":"2026-06-13T22:51:19.383931Z","end":"2026-06-13T22:51:19.499376Z","steps":["trace[1875629853] 'process raft request' (duration: 115.400109ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:19.499459Z","caller":"traceutil/trace.go:171","msg":"trace[903230924] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"136.824464ms","start":"2026-06-13T22:51:19.362596Z","end":"2026-06-13T22:51:19.49942Z","steps":["trace[903230924] 'process raft request' (duration: 95.478739ms)","trace[903230924] 'compare' (duration: 40.425253ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:19.499723Z","caller":"traceutil/trace.go:171","msg":"trace[955959417] linearizableReadLoop","detail":"{readStateIndex:1395; appliedIndex:1394; }","duration":"117.306874ms","start":"2026-06-13T22:51:19.382402Z","end":"2026-06-13T22:51:19.499708Z","steps":["trace[955959417] 'read index received' (duration: 75.758424ms)","trace[955959417] 'applied index is now lower than readState.Index' (duration: 41.54735ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:19.499976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.55996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-13T22:51:19.500021Z","caller":"traceutil/trace.go:171","msg":"trace[1066973224] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1340; }","duration":"117.647172ms","start":"2026-06-13T22:51:19.38236Z","end":"2026-06-13T22:51:19.500007Z","steps":["trace[1066973224] 'agreement among raft nodes before linearized reading' (duration: 117.455897ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:34.017842Z","caller":"traceutil/trace.go:171","msg":"trace[1659115749] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"100.673552ms","start":"2026-06-13T22:51:33.917065Z","end":"2026-06-13T22:51:34.017739Z","steps":["trace[1659115749] 'process raft request' (duration: 66.358014ms)","trace[1659115749] 'compare' (duration: 33.868577ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:34.018022Z","caller":"traceutil/trace.go:171","msg":"trace[210419632] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"100.798065ms","start":"2026-06-13T22:51:33.917197Z","end":"2026-06-13T22:51:34.017995Z","steps":["trace[210419632] 'process raft request' (duration: 100.287193ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:52.156826Z","caller":"traceutil/trace.go:171","msg":"trace[1545552802] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"198.093265ms","start":"2026-06-13T22:51:51.958691Z","end":"2026-06-13T22:51:52.156785Z","steps":["trace[1545552802] 'process raft request' (duration: 197.824679ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:14.706448Z","caller":"traceutil/trace.go:171","msg":"trace[1517891269] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"104.242971ms","start":"2026-06-13T22:53:14.602183Z","end":"2026-06-13T22:53:14.706426Z","steps":["trace[1517891269] 'process raft request' (duration: 104.089777ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:19.941177Z","caller":"traceutil/trace.go:171","msg":"trace[2000496780] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"134.053976ms","start":"2026-06-13T22:53:19.807094Z","end":"2026-06-13T22:53:19.941147Z","steps":["trace[2000496780] 'process raft request' (duration: 133.889902ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:28.908197Z","caller":"traceutil/trace.go:171","msg":"trace[2147224098] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"122.223532ms","start":"2026-06-13T22:53:28.785937Z","end":"2026-06-13T22:53:28.90816Z","steps":["trace[2147224098] 'process raft request' (duration: 122.009027ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:29.056773Z","caller":"traceutil/trace.go:171","msg":"trace[1891849181] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"143.604255ms","start":"2026-06-13T22:53:28.913145Z","end":"2026-06-13T22:53:29.056749Z","steps":["trace[1891849181] 'process raft request' (duration: 143.539213ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:29.056843Z","caller":"traceutil/trace.go:171","msg":"trace[576787224] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"143.677697ms","start":"2026-06-13T22:53:28.913119Z","end":"2026-06-13T22:53:29.056797Z","steps":["trace[576787224] 'process raft request' (duration: 65.292507ms)","trace[576787224] 'compare' (duration: 78.124634ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:53:29.057048Z","caller":"traceutil/trace.go:171","msg":"trace[1741267321] linearizableReadLoop","detail":"{readStateIndex:2031; appliedIndex:2027; }","duration":"128.183075ms","start":"2026-06-13T22:53:28.928849Z","end":"2026-06-13T22:53:29.057032Z","steps":["trace[1741267321] 'read index received' (duration: 49.575759ms)","trace[1741267321] 'applied index is now lower than readState.Index' (duration: 78.606366ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:53:29.057108Z","caller":"traceutil/trace.go:171","msg":"trace[106738151] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"141.976346ms","start":"2026-06-13T22:53:28.915122Z","end":"2026-06-13T22:53:29.057098Z","steps":["trace[106738151] 'process raft request' (duration: 141.805892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:53:29.057434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.556634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-06-13T22:53:29.057512Z","caller":"traceutil/trace.go:171","msg":"trace[1300981921] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1949; }","duration":"128.651767ms","start":"2026-06-13T22:53:28.928841Z","end":"2026-06-13T22:53:29.057493Z","steps":["trace[1300981921] 'agreement among raft nodes before linearized reading' (duration: 128.36717ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:29.057674Z","caller":"traceutil/trace.go:171","msg":"trace[1621410879] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"144.082706ms","start":"2026-06-13T22:53:28.913568Z","end":"2026-06-13T22:53:29.057651Z","steps":["trace[1621410879] 'process raft request' (duration: 143.154834ms)"],"step_count":1}