{"level":"warn","ts":"2026-05-09T16:53:48.614725Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T16:53:48.614841Z","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-05-09T16:53:48.61492Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T16:53:48.614929Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-09T16:53:48.614947Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T16:53:48.615581Z","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-05-09T16:53:48.615654Z","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-05-09T16:53:48.621791Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.929694ms"} {"level":"info","ts":"2026-05-09T16:53:48.632219Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-05-09T16:53:48.632298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T16:53:48.632319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-05-09T16:53:48.632336Z","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-05-09T16:53:48.632347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-05-09T16:53:48.632383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-05-09T16:53:48.641217Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T16:53:48.642669Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T16:53:48.646025Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-09T16:53:48.648783Z","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-05-09T16:53:48.649098Z","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-05-09T16:53:48.649564Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T16:53:48.649707Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T16:53:48.649934Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T16:53:48.650216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-05-09T16:53:48.650366Z","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-05-09T16:53:48.653071Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T16:53:48.653172Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-09T16:53:48.653254Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-09T16:53:48.653308Z","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-05-09T16:53:48.653365Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T16:53:48.93277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T16:53:48.932847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T16:53:48.932871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-05-09T16:53:48.932892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-05-09T16:53:48.932903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-09T16:53:48.932919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-05-09T16:53:48.932934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-09T16:53:48.933627Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:53:48.938691Z","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-05-09T16:53:48.938716Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:53:48.938873Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:53:48.939182Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T16:53:48.93924Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T16:53:48.939912Z","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-05-09T16:53:48.939994Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:53:48.940014Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:53:48.946615Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-05-09T16:53:48.947039Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-09T16:53:51.623409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.324089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-09T16:53:51.623706Z","caller":"traceutil/trace.go:171","msg":"trace[666717019] linearizableReadLoop","detail":"{readStateIndex:80; appliedIndex:79; }","duration":"105.447199ms","start":"2026-05-09T16:53:51.518231Z","end":"2026-05-09T16:53:51.623678Z","steps":["trace[666717019] 'read index received' (duration: 36.411µs)","trace[666717019] 'applied index is now lower than readState.Index' (duration: 105.408958ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:53:51.623889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.645924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:53:51.62397Z","caller":"traceutil/trace.go:171","msg":"trace[218103315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:76; }","duration":"105.771778ms","start":"2026-05-09T16:53:51.518184Z","end":"2026-05-09T16:53:51.623956Z","steps":["trace[218103315] 'agreement among raft nodes before linearized reading' (duration: 105.612933ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:53:51.624102Z","caller":"traceutil/trace.go:171","msg":"trace[1230205207] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"159.919903ms","start":"2026-05-09T16:53:51.463984Z","end":"2026-05-09T16:53:51.623904Z","steps":["trace[1230205207] 'process raft request' (duration: 31.317884ms)","trace[1230205207] 'compare' (duration: 127.169404ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:53:52.304415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.971477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-09T16:53:52.304552Z","caller":"traceutil/trace.go:171","msg":"trace[1813896681] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"674.589423ms","start":"2026-05-09T16:53:51.629941Z","end":"2026-05-09T16:53:52.304531Z","steps":["trace[1813896681] 'process raft request' (duration: 419.394479ms)","trace[1813896681] 'compare' (duration: 254.74512ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:53:52.304605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:51.629923Z","time spent":"674.665656ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":665,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:53:52.939052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.352796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-09T16:53:52.939171Z","caller":"traceutil/trace.go:171","msg":"trace[692445028] linearizableReadLoop","detail":"{readStateIndex:82; appliedIndex:81; }","duration":"420.608377ms","start":"2026-05-09T16:53:52.518544Z","end":"2026-05-09T16:53:52.939152Z","steps":["trace[692445028] 'read index received' (duration: 48.014893ms)","trace[692445028] 'applied index is now lower than readState.Index' (duration: 372.592034ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:53:52.939197Z","caller":"traceutil/trace.go:171","msg":"trace[270126863] transaction","detail":"{read_only:false; response_revision:78; number_of_response:1; }","duration":"629.288215ms","start":"2026-05-09T16:53:52.309886Z","end":"2026-05-09T16:53:52.939174Z","steps":["trace[270126863] 'process raft request' (duration: 256.742642ms)","trace[270126863] 'compare' (duration: 372.181171ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:53:52.939292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:52.309857Z","time spent":"629.396138ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":600,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:53:52.939299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.749791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:53:52.939402Z","caller":"traceutil/trace.go:171","msg":"trace[963354780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:78; }","duration":"420.851204ms","start":"2026-05-09T16:53:52.518478Z","end":"2026-05-09T16:53:52.939329Z","steps":["trace[963354780] 'agreement among raft nodes before linearized reading' (duration: 420.726611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:53:52.939507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:52.518416Z","time spent":"421.079102ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:53:53.440669Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828534949894381,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T16:53:53.565619Z","caller":"traceutil/trace.go:171","msg":"trace[866770992] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"798.852397ms","start":"2026-05-09T16:53:52.766458Z","end":"2026-05-09T16:53:53.565311Z","steps":["trace[866770992] 'process raft request' (duration: 798.609569ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:53:53.565652Z","caller":"traceutil/trace.go:171","msg":"trace[77191610] linearizableReadLoop","detail":"{readStateIndex:83; appliedIndex:83; }","duration":"624.993473ms","start":"2026-05-09T16:53:52.940623Z","end":"2026-05-09T16:53:53.565616Z","steps":["trace[77191610] 'read index received' (duration: 624.979972ms)","trace[77191610] 'applied index is now lower than readState.Index' (duration: 11.03µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:53:53.565782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.154607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:53:53.566151Z","caller":"traceutil/trace.go:171","msg":"trace[1904913984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:79; }","duration":"625.535758ms","start":"2026-05-09T16:53:52.94056Z","end":"2026-05-09T16:53:53.566096Z","steps":["trace[1904913984] 'agreement among raft nodes before linearized reading' (duration: 625.150807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:53:53.566188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:52.766435Z","time spent":"799.434194ms","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:53:53.566287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:52.940537Z","time spent":"625.698514ms","remote":"127.0.0.1:38610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-09T16:53:53.626216Z","caller":"traceutil/trace.go:171","msg":"trace[38366864] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"110.270539ms","start":"2026-05-09T16:53:53.515857Z","end":"2026-05-09T16:53:53.626127Z","steps":["trace[38366864] 'process raft request' (duration: 109.609238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:53:53.626309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.233505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:53:53.626496Z","caller":"traceutil/trace.go:171","msg":"trace[929130086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:80; }","duration":"300.448792ms","start":"2026-05-09T16:53:53.325997Z","end":"2026-05-09T16:53:53.626445Z","steps":["trace[929130086] 'agreement among raft nodes before linearized reading' (duration: 300.145302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:53:53.626577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:53.325976Z","time spent":"300.589125ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T16:53:53.626736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.166592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:53:53.626856Z","caller":"traceutil/trace.go:171","msg":"trace[179140145] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:80; }","duration":"684.327837ms","start":"2026-05-09T16:53:52.942505Z","end":"2026-05-09T16:53:53.626833Z","steps":["trace[179140145] 'agreement among raft nodes before linearized reading' (duration: 684.09819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:53:53.62691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:53:52.942489Z","time spent":"684.40971ms","remote":"127.0.0.1:38976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"info","ts":"2026-05-09T16:54:18.927473Z","caller":"traceutil/trace.go:171","msg":"trace[786012533] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"350.863162ms","start":"2026-05-09T16:54:18.576587Z","end":"2026-05-09T16:54:18.92745Z","steps":["trace[786012533] 'process raft request' (duration: 350.694677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.927616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.576566Z","time spent":"350.987016ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.934339Z","caller":"traceutil/trace.go:171","msg":"trace[998147366] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"353.581658ms","start":"2026-05-09T16:54:18.580734Z","end":"2026-05-09T16:54:18.934316Z","steps":["trace[998147366] 'process raft request' (duration: 353.467845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.934459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.580706Z","time spent":"353.703352ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.934511Z","caller":"traceutil/trace.go:171","msg":"trace[2127486997] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"345.219975ms","start":"2026-05-09T16:54:18.589253Z","end":"2026-05-09T16:54:18.934473Z","steps":["trace[2127486997] 'process raft request' (duration: 345.028019ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:18.934619Z","caller":"traceutil/trace.go:171","msg":"trace[601572929] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"341.428265ms","start":"2026-05-09T16:54:18.593145Z","end":"2026-05-09T16:54:18.934573Z","steps":["trace[601572929] 'process raft request' (duration: 341.217209ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:18.93455Z","caller":"traceutil/trace.go:171","msg":"trace[806967898] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"345.299508ms","start":"2026-05-09T16:54:18.589226Z","end":"2026-05-09T16:54:18.934526Z","steps":["trace[806967898] 'process raft request' (duration: 345.087631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.934648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.589249Z","time spent":"345.342019ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:54:18.93468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.593138Z","time spent":"341.516709ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:54:18.934724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.589208Z","time spent":"345.457912ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.934836Z","caller":"traceutil/trace.go:171","msg":"trace[1693659528] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"345.228386ms","start":"2026-05-09T16:54:18.589353Z","end":"2026-05-09T16:54:18.934581Z","steps":["trace[1693659528] 'process raft request' (duration: 344.984708ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:18.93485Z","caller":"traceutil/trace.go:171","msg":"trace[768925616] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"339.917308ms","start":"2026-05-09T16:54:18.594903Z","end":"2026-05-09T16:54:18.934821Z","steps":["trace[768925616] 'process raft request' (duration: 339.623499ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:18.934921Z","caller":"traceutil/trace.go:171","msg":"trace[1789323161] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"338.997239ms","start":"2026-05-09T16:54:18.595914Z","end":"2026-05-09T16:54:18.934911Z","steps":["trace[1789323161] 'process raft request' (duration: 338.751911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.934984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.595907Z","time spent":"339.03935ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:54:18.935048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.594887Z","time spent":"340.042023ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.935091Z","caller":"traceutil/trace.go:171","msg":"trace[2115657935] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"332.392921ms","start":"2026-05-09T16:54:18.602685Z","end":"2026-05-09T16:54:18.935078Z","steps":["trace[2115657935] 'process raft request' (duration: 332.134903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.935083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.589304Z","time spent":"345.627418ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.935163Z","caller":"traceutil/trace.go:171","msg":"trace[1763702636] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"314.105426ms","start":"2026-05-09T16:54:18.62105Z","end":"2026-05-09T16:54:18.935155Z","steps":["trace[1763702636] 'process raft request' (duration: 313.839897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:18.935159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.602674Z","time spent":"332.456534ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:54:18.935201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:18.621031Z","time spent":"314.156368ms","remote":"127.0.0.1:38630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:54:18.935368Z","caller":"traceutil/trace.go:171","msg":"trace[22931136] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"260.055745ms","start":"2026-05-09T16:54:18.675295Z","end":"2026-05-09T16:54:18.935351Z","steps":["trace[22931136] 'process raft request' (duration: 259.768806ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:18.935374Z","caller":"traceutil/trace.go:171","msg":"trace[577500274] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"151.24923ms","start":"2026-05-09T16:54:18.784108Z","end":"2026-05-09T16:54:18.935357Z","steps":["trace[577500274] 'process raft request' (duration: 151.148817ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:19.607819Z","caller":"traceutil/trace.go:171","msg":"trace[1385043624] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"234.900243ms","start":"2026-05-09T16:54:19.372902Z","end":"2026-05-09T16:54:19.607802Z","steps":["trace[1385043624] 'read index received' (duration: 234.288593ms)","trace[1385043624] 'applied index is now lower than readState.Index' (duration: 610.95µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:19.607942Z","caller":"traceutil/trace.go:171","msg":"trace[514159583] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"246.946292ms","start":"2026-05-09T16:54:19.360931Z","end":"2026-05-09T16:54:19.607877Z","steps":["trace[514159583] 'process raft request' (duration: 246.201998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:19.60942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.020046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:19.609547Z","caller":"traceutil/trace.go:171","msg":"trace[1007776286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"236.604017ms","start":"2026-05-09T16:54:19.372895Z","end":"2026-05-09T16:54:19.6095Z","steps":["trace[1007776286] 'agreement among raft nodes before linearized reading' (duration: 234.998216ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:19.614296Z","caller":"traceutil/trace.go:171","msg":"trace[1528585475] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"237.294208ms","start":"2026-05-09T16:54:19.376968Z","end":"2026-05-09T16:54:19.614262Z","steps":["trace[1528585475] 'process raft request' (duration: 235.983077ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:21.17476Z","caller":"traceutil/trace.go:171","msg":"trace[869260339] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"210.133904ms","start":"2026-05-09T16:54:20.964601Z","end":"2026-05-09T16:54:21.174735Z","steps":["trace[869260339] 'process raft request' (duration: 209.978589ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:21.637362Z","caller":"traceutil/trace.go:171","msg":"trace[1323022944] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"249.597565ms","start":"2026-05-09T16:54:21.387731Z","end":"2026-05-09T16:54:21.637328Z","steps":["trace[1323022944] 'read index received' (duration: 213.950683ms)","trace[1323022944] 'applied index is now lower than readState.Index' (duration: 35.645742ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:21.63753Z","caller":"traceutil/trace.go:171","msg":"trace[2109318586] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"547.888032ms","start":"2026-05-09T16:54:21.089546Z","end":"2026-05-09T16:54:21.637434Z","steps":["trace[2109318586] 'process raft request' (duration: 512.206919ms)","trace[2109318586] 'compare' (duration: 34.976821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:54:21.637611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.866103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:21.637659Z","caller":"traceutil/trace.go:171","msg":"trace[897377332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"249.958976ms","start":"2026-05-09T16:54:21.387688Z","end":"2026-05-09T16:54:21.637647Z","steps":["trace[897377332] 'agreement among raft nodes before linearized reading' (duration: 249.759219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:21.638166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:21.089519Z","time spent":"548.14471ms","remote":"127.0.0.1:38890","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-05-09T16:54:25.349433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.074877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T16:54:25.349527Z","caller":"traceutil/trace.go:171","msg":"trace[1835904828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:570; }","duration":"159.227631ms","start":"2026-05-09T16:54:25.190281Z","end":"2026-05-09T16:54:25.349509Z","steps":["trace[1835904828] 'range keys from in-memory index tree' (duration: 158.885921ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:25.428403Z","caller":"traceutil/trace.go:171","msg":"trace[915474222] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"199.311083ms","start":"2026-05-09T16:54:25.229061Z","end":"2026-05-09T16:54:25.428372Z","steps":["trace[915474222] 'process raft request' (duration: 198.499408ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:26.01812Z","caller":"traceutil/trace.go:171","msg":"trace[1605147384] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"644.36309ms","start":"2026-05-09T16:54:25.37369Z","end":"2026-05-09T16:54:26.018053Z","steps":["trace[1605147384] 'read index received' (duration: 53.552116ms)","trace[1605147384] 'applied index is now lower than readState.Index' (duration: 590.809914ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:26.018183Z","caller":"traceutil/trace.go:171","msg":"trace[1989476674] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"663.185882ms","start":"2026-05-09T16:54:25.354956Z","end":"2026-05-09T16:54:26.018142Z","steps":["trace[1989476674] 'process raft request' (duration: 662.881352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:26.018274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.573206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:26.018317Z","caller":"traceutil/trace.go:171","msg":"trace[373326520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"644.67708ms","start":"2026-05-09T16:54:25.373628Z","end":"2026-05-09T16:54:26.018305Z","steps":["trace[373326520] 'agreement among raft nodes before linearized reading' (duration: 644.595068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:26.018352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:25.373605Z","time spent":"644.738661ms","remote":"127.0.0.1:38602","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-05-09T16:54:26.018479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:25.354921Z","time spent":"663.351037ms","remote":"127.0.0.1:38890","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-05-09T16:54:26.108011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.293544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-09T16:54:26.10802Z","caller":"traceutil/trace.go:171","msg":"trace[1717840560] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"621.265863ms","start":"2026-05-09T16:54:25.486717Z","end":"2026-05-09T16:54:26.107983Z","steps":["trace[1717840560] 'process raft request' (duration: 542.195435ms)","trace[1717840560] 'compare' (duration: 78.637765ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:26.108107Z","caller":"traceutil/trace.go:171","msg":"trace[1830312769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"370.440538ms","start":"2026-05-09T16:54:25.737641Z","end":"2026-05-09T16:54:26.108082Z","steps":["trace[1830312769] 'agreement among raft nodes before linearized reading' (duration: 370.141939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:26.108147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:25.737613Z","time spent":"370.523401ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T16:54:26.108163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:25.486685Z","time spent":"621.411278ms","remote":"127.0.0.1:39130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:54:26.108197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.852144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-09T16:54:26.108271Z","caller":"traceutil/trace.go:171","msg":"trace[593704489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"311.988919ms","start":"2026-05-09T16:54:25.796258Z","end":"2026-05-09T16:54:26.108247Z","steps":["trace[593704489] 'agreement among raft nodes before linearized reading' (duration: 311.777382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:26.108317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:25.796221Z","time spent":"312.083821ms","remote":"127.0.0.1:38890","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-05-09T16:54:26.620084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828534949895375,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:54:27.025426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.293872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:54:27.025519Z","caller":"traceutil/trace.go:171","msg":"trace[1856867796] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"913.832561ms","start":"2026-05-09T16:54:26.111671Z","end":"2026-05-09T16:54:27.025504Z","steps":["trace[1856867796] 'process raft request' (duration: 701.375325ms)","trace[1856867796] 'compare' (duration: 212.212708ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:54:27.025562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.111651Z","time spent":"913.891732ms","remote":"127.0.0.1:38890","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-05-09T16:54:27.673421Z","caller":"traceutil/trace.go:171","msg":"trace[127167094] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.560803013s","start":"2026-05-09T16:54:26.112556Z","end":"2026-05-09T16:54:27.673359Z","steps":["trace[127167094] 'process raft request' (duration: 1.479668769s)","trace[127167094] 'compare' (duration: 80.870935ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:54:27.673599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.112546Z","time spent":"1.560954347s","remote":"127.0.0.1:38890","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-05-09T16:54:27.673738Z","caller":"traceutil/trace.go:171","msg":"trace[1942272312] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.547663089s","start":"2026-05-09T16:54:26.126053Z","end":"2026-05-09T16:54:27.673716Z","steps":["trace[1942272312] 'process raft request' (duration: 1.547237306s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:27.67387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.126036Z","time spent":"1.547765833s","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:54:27.674894Z","caller":"traceutil/trace.go:171","msg":"trace[1349791710] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.236284789s","start":"2026-05-09T16:54:26.438586Z","end":"2026-05-09T16:54:27.674871Z","steps":["trace[1349791710] 'process raft request' (duration: 1.234958358s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:27.674983Z","caller":"traceutil/trace.go:171","msg":"trace[1685039801] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"774.999211ms","start":"2026-05-09T16:54:26.899959Z","end":"2026-05-09T16:54:27.674958Z","steps":["trace[1685039801] 'process raft request' (duration: 774.889818ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:27.675234Z","caller":"traceutil/trace.go:171","msg":"trace[1716584077] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:599; }","duration":"1.555615519s","start":"2026-05-09T16:54:26.119567Z","end":"2026-05-09T16:54:27.675183Z","steps":["trace[1716584077] 'read index received' (duration: 693.487586ms)","trace[1716584077] 'applied index is now lower than readState.Index' (duration: 862.122253ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:54:27.675405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.301240523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:27.675433Z","caller":"traceutil/trace.go:171","msg":"trace[1394231766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"1.301328066s","start":"2026-05-09T16:54:26.374097Z","end":"2026-05-09T16:54:27.675425Z","steps":["trace[1394231766] 'agreement among raft nodes before linearized reading' (duration: 1.301251803s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:27.67546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.374076Z","time spent":"1.301378428s","remote":"127.0.0.1:38602","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-05-09T16:54:27.675481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.555873938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T16:54:27.675496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261363599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-09T16:54:27.675414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.899938Z","time spent":"775.289151ms","remote":"127.0.0.1:38890","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-05-09T16:54:27.675622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.438566Z","time spent":"1.236447774s","remote":"127.0.0.1:38786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:54:27.675551Z","caller":"traceutil/trace.go:171","msg":"trace[2056718668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"1.26144273s","start":"2026-05-09T16:54:26.414096Z","end":"2026-05-09T16:54:27.675538Z","steps":["trace[2056718668] 'agreement among raft nodes before linearized reading' (duration: 1.261275245s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:27.675696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.414085Z","time spent":"1.261603176s","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-09T16:54:27.675556Z","caller":"traceutil/trace.go:171","msg":"trace[746797724] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:578; }","duration":"1.556015662s","start":"2026-05-09T16:54:26.119517Z","end":"2026-05-09T16:54:27.675533Z","steps":["trace[746797724] 'agreement among raft nodes before linearized reading' (duration: 1.555807426s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:27.675793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:26.119432Z","time spent":"1.556356062s","remote":"127.0.0.1:38852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-09T16:54:29.466601Z","caller":"traceutil/trace.go:171","msg":"trace[1511860984] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"184.501437ms","start":"2026-05-09T16:54:29.28208Z","end":"2026-05-09T16:54:29.466581Z","steps":["trace[1511860984] 'read index received' (duration: 184.332761ms)","trace[1511860984] 'applied index is now lower than readState.Index' (duration: 167.776µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:29.466698Z","caller":"traceutil/trace.go:171","msg":"trace[1876332957] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"255.77446ms","start":"2026-05-09T16:54:29.210913Z","end":"2026-05-09T16:54:29.466688Z","steps":["trace[1876332957] 'process raft request' (duration: 255.490751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.467013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.91158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.467108Z","caller":"traceutil/trace.go:171","msg":"trace[1885128644] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"185.036634ms","start":"2026-05-09T16:54:29.282054Z","end":"2026-05-09T16:54:29.46709Z","steps":["trace[1885128644] 'agreement among raft nodes before linearized reading' (duration: 184.846358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.470721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.447341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.470777Z","caller":"traceutil/trace.go:171","msg":"trace[1144040417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"188.532033ms","start":"2026-05-09T16:54:29.282233Z","end":"2026-05-09T16:54:29.470765Z","steps":["trace[1144040417] 'agreement among raft nodes before linearized reading' (duration: 188.398389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.472326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.904121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.472425Z","caller":"traceutil/trace.go:171","msg":"trace[1640508368] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"152.027575ms","start":"2026-05-09T16:54:29.320377Z","end":"2026-05-09T16:54:29.472405Z","steps":["trace[1640508368] 'agreement among raft nodes before linearized reading' (duration: 151.888031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.472604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.284958ms","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-05-09T16:54:29.472637Z","caller":"traceutil/trace.go:171","msg":"trace[326287862] 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:612; }","duration":"128.324519ms","start":"2026-05-09T16:54:29.344301Z","end":"2026-05-09T16:54:29.472625Z","steps":["trace[326287862] 'agreement among raft nodes before linearized reading' (duration: 128.271497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.472891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.584437ms","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\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.472953Z","caller":"traceutil/trace.go:171","msg":"trace[1022745558] 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:612; }","duration":"128.66923ms","start":"2026-05-09T16:54:29.34427Z","end":"2026-05-09T16:54:29.472939Z","steps":["trace[1022745558] 'agreement among raft nodes before linearized reading' (duration: 128.490274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.473169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.148188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.473213Z","caller":"traceutil/trace.go:171","msg":"trace[39040412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"152.21071ms","start":"2026-05-09T16:54:29.320992Z","end":"2026-05-09T16:54:29.473202Z","steps":["trace[39040412] 'agreement among raft nodes before linearized reading' (duration: 152.122017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.47367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.402278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.473705Z","caller":"traceutil/trace.go:171","msg":"trace[2114005700] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"153.45451ms","start":"2026-05-09T16:54:29.320241Z","end":"2026-05-09T16:54:29.473696Z","steps":["trace[2114005700] 'agreement among raft nodes before linearized reading' (duration: 153.397198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:29.475759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.839508ms","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\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:29.47595Z","caller":"traceutil/trace.go:171","msg":"trace[1082074772] 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:612; }","duration":"131.153318ms","start":"2026-05-09T16:54:29.344767Z","end":"2026-05-09T16:54:29.47592Z","steps":["trace[1082074772] 'agreement among raft nodes before linearized reading' (duration: 126.337736ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:32.345401Z","caller":"traceutil/trace.go:171","msg":"trace[30442459] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"105.662754ms","start":"2026-05-09T16:54:32.239706Z","end":"2026-05-09T16:54:32.345368Z","steps":["trace[30442459] 'process raft request' (duration: 105.272182ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:42.049457Z","caller":"traceutil/trace.go:171","msg":"trace[235165196] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"285.402412ms","start":"2026-05-09T16:54:41.764036Z","end":"2026-05-09T16:54:42.049438Z","steps":["trace[235165196] 'process raft request' (duration: 285.276748ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:42.586989Z","caller":"traceutil/trace.go:171","msg":"trace[1389659423] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:764; }","duration":"444.371675ms","start":"2026-05-09T16:54:42.142588Z","end":"2026-05-09T16:54:42.586959Z","steps":["trace[1389659423] 'read index received' (duration: 444.006584ms)","trace[1389659423] 'applied index is now lower than readState.Index' (duration: 363.781µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:54:42.587134Z","caller":"traceutil/trace.go:171","msg":"trace[386500437] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"567.15053ms","start":"2026-05-09T16:54:42.019971Z","end":"2026-05-09T16:54:42.587121Z","steps":["trace[386500437] 'process raft request' (duration: 566.938343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:42.587296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.687945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fxbjx\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-09T16:54:42.587362Z","caller":"traceutil/trace.go:171","msg":"trace[872185103] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fxbjx; range_end:; response_count:1; response_revision:736; }","duration":"444.788199ms","start":"2026-05-09T16:54:42.142557Z","end":"2026-05-09T16:54:42.587345Z","steps":["trace[872185103] 'agreement among raft nodes before linearized reading' (duration: 444.607513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:42.587398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:42.142543Z","time spent":"444.846871ms","remote":"127.0.0.1:38798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-fxbjx\" "} {"level":"warn","ts":"2026-05-09T16:54:42.587376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.972561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-09T16:54:42.587422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:42.019952Z","time spent":"567.298775ms","remote":"127.0.0.1:38890","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-05-09T16:54:42.587441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.466458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:54:42.587452Z","caller":"traceutil/trace.go:171","msg":"trace[15356257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:736; }","duration":"415.089654ms","start":"2026-05-09T16:54:42.172343Z","end":"2026-05-09T16:54:42.587433Z","steps":["trace[15356257] 'agreement among raft nodes before linearized reading' (duration: 414.894168ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:54:42.587496Z","caller":"traceutil/trace.go:171","msg":"trace[1940301213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:736; }","duration":"213.580152ms","start":"2026-05-09T16:54:42.373902Z","end":"2026-05-09T16:54:42.587482Z","steps":["trace[1940301213] 'agreement among raft nodes before linearized reading' (duration: 213.50744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:42.587507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:42.172328Z","time spent":"415.166786ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-09T16:54:42.587004Z","caller":"traceutil/trace.go:171","msg":"trace[2133565902] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"821.773894ms","start":"2026-05-09T16:54:41.765201Z","end":"2026-05-09T16:54:42.586974Z","steps":["trace[2133565902] 'process raft request' (duration: 821.453394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:54:42.58774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:54:41.765181Z","time spent":"822.484726ms","remote":"127.0.0.1:38890","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-05-09T16:54:42.704308Z","caller":"traceutil/trace.go:171","msg":"trace[1905345482] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"108.869556ms","start":"2026-05-09T16:54:42.595413Z","end":"2026-05-09T16:54:42.704283Z","steps":["trace[1905345482] 'process raft request' (duration: 108.553826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:17.211715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.931456ms","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":"info","ts":"2026-05-09T16:55:17.211809Z","caller":"traceutil/trace.go:171","msg":"trace[243469425] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:954; }","duration":"283.115302ms","start":"2026-05-09T16:55:16.928676Z","end":"2026-05-09T16:55:17.211792Z","steps":["trace[243469425] 'count revisions from in-memory index tree' (duration: 282.784522ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:17.475564Z","caller":"traceutil/trace.go:171","msg":"trace[1601082725] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"217.96968ms","start":"2026-05-09T16:55:17.257575Z","end":"2026-05-09T16:55:17.475545Z","steps":["trace[1601082725] 'process raft request' (duration: 217.845666ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:17.909658Z","caller":"traceutil/trace.go:171","msg":"trace[1435133793] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"650.619445ms","start":"2026-05-09T16:55:17.259016Z","end":"2026-05-09T16:55:17.909636Z","steps":["trace[1435133793] 'process raft request' (duration: 650.43726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:17.909801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:17.258999Z","time spent":"650.722149ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:55:40.155713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.385686ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-09T16:55:40.155863Z","caller":"traceutil/trace.go:171","msg":"trace[1788167353] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"126.543056ms","start":"2026-05-09T16:55:40.029302Z","end":"2026-05-09T16:55:40.155845Z","steps":["trace[1788167353] 'read index received' (duration: 39.172µs)","trace[1788167353] 'applied index is now lower than readState.Index' (duration: 126.502544ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:55:40.156083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.767813ms","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-05-09T16:55:40.156122Z","caller":"traceutil/trace.go:171","msg":"trace[1257588130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"126.815565ms","start":"2026-05-09T16:55:40.029296Z","end":"2026-05-09T16:55:40.156111Z","steps":["trace[1257588130] 'agreement among raft nodes before linearized reading' (duration: 126.648249ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:41.025745Z","caller":"traceutil/trace.go:171","msg":"trace[1143805970] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"115.969421ms","start":"2026-05-09T16:55:40.909745Z","end":"2026-05-09T16:55:41.025714Z","steps":["trace[1143805970] 'process raft request' (duration: 115.738183ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:41.525858Z","caller":"traceutil/trace.go:171","msg":"trace[1803017028] linearizableReadLoop","detail":"{readStateIndex:1076; appliedIndex:1074; }","duration":"373.419661ms","start":"2026-05-09T16:55:41.152419Z","end":"2026-05-09T16:55:41.525839Z","steps":["trace[1803017028] 'read index received' (duration: 311.926695ms)","trace[1803017028] 'applied index is now lower than readState.Index' (duration: 61.492306ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:55:41.525917Z","caller":"traceutil/trace.go:171","msg":"trace[2088475740] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"495.811055ms","start":"2026-05-09T16:55:41.030066Z","end":"2026-05-09T16:55:41.525877Z","steps":["trace[2088475740] 'process raft request' (duration: 434.303638ms)","trace[2088475740] 'compare' (duration: 61.009962ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:55:41.525965Z","caller":"traceutil/trace.go:171","msg":"trace[1526361833] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"494.752221ms","start":"2026-05-09T16:55:41.031205Z","end":"2026-05-09T16:55:41.525957Z","steps":["trace[1526361833] 'process raft request' (duration: 494.593756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:41.526177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:41.031186Z","time spent":"494.799163ms","remote":"127.0.0.1:38890","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-05-09T16:55:41.526216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:41.030053Z","time spent":"495.98234ms","remote":"127.0.0.1:38890","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-05-09T16:55:41.526252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.738803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T16:55:41.52628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.844864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T16:55:41.526356Z","caller":"traceutil/trace.go:171","msg":"trace[533910539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1033; }","duration":"151.832736ms","start":"2026-05-09T16:55:41.374458Z","end":"2026-05-09T16:55:41.526291Z","steps":["trace[533910539] 'agreement among raft nodes before linearized reading' (duration: 151.746834ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:41.526356Z","caller":"traceutil/trace.go:171","msg":"trace[470069457] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1033; }","duration":"373.971538ms","start":"2026-05-09T16:55:41.152364Z","end":"2026-05-09T16:55:41.526336Z","steps":["trace[470069457] 'agreement among raft nodes before linearized reading' (duration: 373.847264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:41.526432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:41.152344Z","time spent":"374.078052ms","remote":"127.0.0.1:38898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"info","ts":"2026-05-09T16:55:42.788413Z","caller":"traceutil/trace.go:171","msg":"trace[531126103] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"479.246701ms","start":"2026-05-09T16:55:42.309142Z","end":"2026-05-09T16:55:42.788389Z","steps":["trace[531126103] 'process raft request' (duration: 479.043164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:42.788572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:42.30912Z","time spent":"479.365944ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:55:55.071589Z","caller":"traceutil/trace.go:171","msg":"trace[32248268] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1174; }","duration":"150.569956ms","start":"2026-05-09T16:55:54.921006Z","end":"2026-05-09T16:55:55.071576Z","steps":["trace[32248268] 'read index received' (duration: 150.452182ms)","trace[32248268] 'applied index is now lower than readState.Index' (duration: 117.254µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:55:55.071674Z","caller":"traceutil/trace.go:171","msg":"trace[602915267] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"228.954337ms","start":"2026-05-09T16:55:54.842713Z","end":"2026-05-09T16:55:55.071667Z","steps":["trace[602915267] 'process raft request' (duration: 228.766831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:55.071769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.760163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:55:55.071791Z","caller":"traceutil/trace.go:171","msg":"trace[710076681] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1127; }","duration":"150.836495ms","start":"2026-05-09T16:55:54.920949Z","end":"2026-05-09T16:55:55.071785Z","steps":["trace[710076681] 'agreement among raft nodes before linearized reading' (duration: 150.790733ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:55.578133Z","caller":"traceutil/trace.go:171","msg":"trace[915731085] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"424.27704ms","start":"2026-05-09T16:55:55.153832Z","end":"2026-05-09T16:55:55.578109Z","steps":["trace[915731085] 'read index received' (duration: 402.714998ms)","trace[915731085] 'applied index is now lower than readState.Index' (duration: 21.560682ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:55:55.57825Z","caller":"traceutil/trace.go:171","msg":"trace[19642393] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"425.8558ms","start":"2026-05-09T16:55:55.152379Z","end":"2026-05-09T16:55:55.578235Z","steps":["trace[19642393] 'process raft request' (duration: 404.241146ms)","trace[19642393] 'compare' (duration: 21.101388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:55:55.578354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:55.152364Z","time spent":"425.910972ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:55:55.57848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.618901ms","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":"warn","ts":"2026-05-09T16:55:55.57847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.233729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:55:55.578543Z","caller":"traceutil/trace.go:171","msg":"trace[1646081669] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1128; }","duration":"424.721255ms","start":"2026-05-09T16:55:55.153807Z","end":"2026-05-09T16:55:55.578528Z","steps":["trace[1646081669] 'agreement among raft nodes before linearized reading' (duration: 424.541929ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:55:55.578561Z","caller":"traceutil/trace.go:171","msg":"trace[12576299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1128; }","duration":"200.340992ms","start":"2026-05-09T16:55:55.378198Z","end":"2026-05-09T16:55:55.578539Z","steps":["trace[12576299] 'agreement among raft nodes before linearized reading' (duration: 200.147406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:55:55.578573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:55:55.153801Z","time spent":"424.765906ms","remote":"127.0.0.1:38874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-05-09T16:56:13.856402Z","caller":"traceutil/trace.go:171","msg":"trace[1523085470] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"122.183489ms","start":"2026-05-09T16:56:13.734191Z","end":"2026-05-09T16:56:13.856375Z","steps":["trace[1523085470] 'process raft request' (duration: 122.039044ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:14.065746Z","caller":"traceutil/trace.go:171","msg":"trace[82328992] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"205.20665ms","start":"2026-05-09T16:56:13.860512Z","end":"2026-05-09T16:56:14.065718Z","steps":["trace[82328992] 'process raft request' (duration: 205.098987ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:14.100922Z","caller":"traceutil/trace.go:171","msg":"trace[1456916746] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"240.018426ms","start":"2026-05-09T16:56:13.860871Z","end":"2026-05-09T16:56:14.10089Z","steps":["trace[1456916746] 'process raft request' (duration: 239.667205ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:14.100942Z","caller":"traceutil/trace.go:171","msg":"trace[68340678] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"239.994896ms","start":"2026-05-09T16:56:13.860906Z","end":"2026-05-09T16:56:14.100901Z","steps":["trace[68340678] 'process raft request' (duration: 239.759668ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:14.880604Z","caller":"traceutil/trace.go:171","msg":"trace[1463792142] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"129.468292ms","start":"2026-05-09T16:56:14.75112Z","end":"2026-05-09T16:56:14.880588Z","steps":["trace[1463792142] 'process raft request' (duration: 129.337177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:15.407343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.451737ms","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-05-09T16:56:15.407464Z","caller":"traceutil/trace.go:171","msg":"trace[2140910430] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1227; }","duration":"427.585222ms","start":"2026-05-09T16:56:14.979862Z","end":"2026-05-09T16:56:15.407447Z","steps":["trace[2140910430] 'range keys from in-memory index tree' (duration: 427.435456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:15.407476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.765253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:56:15.407559Z","caller":"traceutil/trace.go:171","msg":"trace[1384146485] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"489.613791ms","start":"2026-05-09T16:56:14.917935Z","end":"2026-05-09T16:56:15.407548Z","steps":["trace[1384146485] 'read index received' (duration: 155.536018ms)","trace[1384146485] 'applied index is now lower than readState.Index' (duration: 334.077173ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:56:15.407616Z","caller":"traceutil/trace.go:171","msg":"trace[17303937] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"635.696035ms","start":"2026-05-09T16:56:14.771913Z","end":"2026-05-09T16:56:15.407609Z","steps":["trace[17303937] 'process raft request' (duration: 301.748416ms)","trace[17303937] 'compare' (duration: 333.634269ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:56:15.407645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:14.771892Z","time spent":"635.741217ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:56:15.407814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.542733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-09T16:56:15.407831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.89796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:56:15.40785Z","caller":"traceutil/trace.go:171","msg":"trace[527240797] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1228; }","duration":"489.954432ms","start":"2026-05-09T16:56:14.917891Z","end":"2026-05-09T16:56:15.407845Z","steps":["trace[527240797] 'agreement among raft nodes before linearized reading' (duration: 489.91299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:15.40787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:14.917874Z","time spent":"489.992663ms","remote":"127.0.0.1:38890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-09T16:56:15.407867Z","caller":"traceutil/trace.go:171","msg":"trace[580895933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1228; }","duration":"254.624096ms","start":"2026-05-09T16:56:15.153217Z","end":"2026-05-09T16:56:15.407841Z","steps":["trace[580895933] 'agreement among raft nodes before linearized reading' (duration: 254.4533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:15.408084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.166688ms","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-05-09T16:56:15.408124Z","caller":"traceutil/trace.go:171","msg":"trace[1378590716] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1228; }","duration":"108.23368ms","start":"2026-05-09T16:56:15.29988Z","end":"2026-05-09T16:56:15.408114Z","steps":["trace[1378590716] 'agreement among raft nodes before linearized reading' (duration: 108.171728ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:15.526083Z","caller":"traceutil/trace.go:171","msg":"trace[423536319] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"112.803878ms","start":"2026-05-09T16:56:15.41326Z","end":"2026-05-09T16:56:15.526064Z","steps":["trace[423536319] 'process raft request' (duration: 112.711085ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:15.526155Z","caller":"traceutil/trace.go:171","msg":"trace[1455382004] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"113.594692ms","start":"2026-05-09T16:56:15.412519Z","end":"2026-05-09T16:56:15.526113Z","steps":["trace[1455382004] 'process raft request' (duration: 99.441188ms)","trace[1455382004] 'compare' (duration: 13.925427ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:56:16.694682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.852209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:56:16.6948Z","caller":"traceutil/trace.go:171","msg":"trace[2023863880] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"321.054046ms","start":"2026-05-09T16:56:16.373722Z","end":"2026-05-09T16:56:16.694776Z","steps":["trace[2023863880] 'range keys from in-memory index tree' (duration: 320.688834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:16.694845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:56:16.373699Z","time spent":"321.138048ms","remote":"127.0.0.1:38602","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-05-09T16:56:16.695687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.995903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-09T16:56:16.695779Z","caller":"traceutil/trace.go:171","msg":"trace[481413942] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1239; }","duration":"253.425097ms","start":"2026-05-09T16:56:16.442332Z","end":"2026-05-09T16:56:16.695757Z","steps":["trace[481413942] 'range keys from in-memory index tree' (duration: 251.896468ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:16.851691Z","caller":"traceutil/trace.go:171","msg":"trace[1917248369] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1291; }","duration":"137.681395ms","start":"2026-05-09T16:56:16.713978Z","end":"2026-05-09T16:56:16.85166Z","steps":["trace[1917248369] 'read index received' (duration: 137.490889ms)","trace[1917248369] 'applied index is now lower than readState.Index' (duration: 188.656µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:56:16.851799Z","caller":"traceutil/trace.go:171","msg":"trace[618812819] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"151.521489ms","start":"2026-05-09T16:56:16.700243Z","end":"2026-05-09T16:56:16.851764Z","steps":["trace[618812819] 'process raft request' (duration: 151.180108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:56:16.851839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.8315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:56:16.851875Z","caller":"traceutil/trace.go:171","msg":"trace[441262511] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1240; }","duration":"137.902712ms","start":"2026-05-09T16:56:16.713962Z","end":"2026-05-09T16:56:16.851865Z","steps":["trace[441262511] 'agreement among raft nodes before linearized reading' (duration: 137.803599ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:25.167622Z","caller":"traceutil/trace.go:171","msg":"trace[1881045153] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"279.326678ms","start":"2026-05-09T16:56:24.888274Z","end":"2026-05-09T16:56:25.1676Z","steps":["trace[1881045153] 'process raft request' (duration: 279.189383ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:56:25.684211Z","caller":"traceutil/trace.go:171","msg":"trace[2053794296] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"110.768982ms","start":"2026-05-09T16:56:25.573413Z","end":"2026-05-09T16:56:25.684182Z","steps":["trace[2053794296] 'process raft request' (duration: 110.575976ms)"],"step_count":1}