{"level":"warn","ts":"2026-06-09T09:42:09.298945Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T09:42:09.299051Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-09T09:42:09.299136Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T09:42:09.299153Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-06-09T09:42:09.299184Z","caller":"embed/etcd.go:528","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-09T09:42:09.299914Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-06-09T09:42:09.300190Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-09T09:42:09.306110Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.599947ms"} {"level":"info","ts":"2026-06-09T09:42:09.314455Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-06-09T09:42:09.314543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T09:42:09.314664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-06-09T09:42:09.314683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T09:42:09.314691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-06-09T09:42:09.314871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-06-09T09:42:09.326009Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T09:42:09.328986Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T09:42:09.329061Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-06-09T09:42:09.330802Z","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-09T09:42:09.332541Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.24","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T09:42:09.332775Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T09:42:09.332787Z","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-09T09:42:09.332942Z","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-09T09:42:09.333134Z","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-09T09:42:09.333454Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:42:09.333559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-06-09T09:42:09.333726Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-06-09T09:42:09.335532Z","caller":"embed/etcd.go:762","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-09T09:42:09.335691Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-09T09:42:09.335736Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-09T09:42:09.338359Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T09:42:09.338456Z","caller":"embed/etcd.go:908","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T09:42:10.215197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T09:42:10.215253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T09:42:10.215311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-06-09T09:42:10.215328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-06-09T09:42:10.215335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-09T09:42:10.215348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-06-09T09:42:10.215356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-09T09:42:10.216285Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T09:42:10.217268Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T09:42:10.217569Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:42:10.217757Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T09:42:10.218185Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:42:10.218330Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:42:10.218797Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-06-09T09:42:10.218959Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T09:42:10.219034Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T09:42:10.219088Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-06-09T09:42:10.219846Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T09:42:10.231149Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:42:10.231263Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T09:42:14.600314Z","caller":"traceutil/trace.go:171","msg":"trace[727553378] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"164.939473ms","start":"2026-06-09T09:42:14.435346Z","end":"2026-06-09T09:42:14.600285Z","steps":["trace[727553378] 'process raft request' (duration: 156.518566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:24.252696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.872341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:42:24.252903Z","caller":"traceutil/trace.go:171","msg":"trace[629250554] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"740.066601ms","start":"2026-06-09T09:42:23.512806Z","end":"2026-06-09T09:42:24.252873Z","steps":["trace[629250554] 'process raft request' (duration: 292.888509ms)","trace[629250554] 'compare' (duration: 445.669893ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:42:24.253022Z","caller":"traceutil/trace.go:171","msg":"trace[892703058] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"343.861838ms","start":"2026-06-09T09:42:23.909139Z","end":"2026-06-09T09:42:24.253001Z","steps":["trace[892703058] 'process raft request' (duration: 343.756464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:24.253088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:23.512780Z","time spent":"740.188805ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:42:24.253161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:23.909115Z","time spent":"343.972482ms","remote":"127.0.0.1:42974","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-09T09:42:24.253355Z","caller":"traceutil/trace.go:171","msg":"trace[1813135200] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"693.339345ms","start":"2026-06-09T09:42:23.560002Z","end":"2026-06-09T09:42:24.253342Z","steps":["trace[1813135200] 'read index received' (duration: 245.592572ms)","trace[1813135200] 'applied index is now lower than readState.Index' (duration: 447.745833ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:42:24.253507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.485521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.240\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T09:42:24.253531Z","caller":"traceutil/trace.go:171","msg":"trace[140052492] range","detail":"{range_begin:/registry/masterleases/199.204.45.240; range_end:; response_count:1; response_revision:373; }","duration":"693.534753ms","start":"2026-06-09T09:42:23.559990Z","end":"2026-06-09T09:42:24.253525Z","steps":["trace[140052492] 'agreement among raft nodes before linearized reading' (duration: 693.393298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:24.253553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:23.559973Z","time spent":"693.573285ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.240\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:42:24.612963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:24.254826Z","time spent":"358.132023ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-09T09:42:24.631042Z","caller":"traceutil/trace.go:171","msg":"trace[1862285828] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"233.394327ms","start":"2026-06-09T09:42:24.397625Z","end":"2026-06-09T09:42:24.631019Z","steps":["trace[1862285828] 'process raft request' (duration: 233.238532ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.650970Z","caller":"traceutil/trace.go:171","msg":"trace[580652396] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"337.116807ms","start":"2026-06-09T09:42:49.313827Z","end":"2026-06-09T09:42:49.650944Z","steps":["trace[580652396] 'process raft request' (duration: 336.979785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.651141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.313805Z","time spent":"337.264998ms","remote":"127.0.0.1:42724","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-06-09T09:42:49.658998Z","caller":"traceutil/trace.go:171","msg":"trace[95939135] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"343.853554ms","start":"2026-06-09T09:42:49.315119Z","end":"2026-06-09T09:42:49.658972Z","steps":["trace[95939135] 'process raft request' (duration: 343.683403ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.659101Z","caller":"traceutil/trace.go:171","msg":"trace[1464256063] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"333.803658ms","start":"2026-06-09T09:42:49.325224Z","end":"2026-06-09T09:42:49.659028Z","steps":["trace[1464256063] 'process raft request' (duration: 333.665967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.659174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.315095Z","time spent":"344.027625ms","remote":"127.0.0.1:42724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T09:42:49.659291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.325206Z","time spent":"334.000548ms","remote":"127.0.0.1:42724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T09:42:49.659305Z","caller":"traceutil/trace.go:171","msg":"trace[567218613] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"328.283848ms","start":"2026-06-09T09:42:49.331006Z","end":"2026-06-09T09:42:49.659290Z","steps":["trace[567218613] 'process raft request' (duration: 328.133607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.659384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.330984Z","time spent":"328.360729ms","remote":"127.0.0.1:42724","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-06-09T09:42:49.659417Z","caller":"traceutil/trace.go:171","msg":"trace[1771319837] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"328.071987ms","start":"2026-06-09T09:42:49.331297Z","end":"2026-06-09T09:42:49.659369Z","steps":["trace[1771319837] 'process raft request' (duration: 327.889645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.659541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.331289Z","time spent":"328.190038ms","remote":"127.0.0.1:42724","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-06-09T09:42:49.659603Z","caller":"traceutil/trace.go:171","msg":"trace[1023897204] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"325.242853ms","start":"2026-06-09T09:42:49.334338Z","end":"2026-06-09T09:42:49.659581Z","steps":["trace[1023897204] 'process raft request' (duration: 325.138242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.659656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.334315Z","time spent":"325.320193ms","remote":"127.0.0.1:42724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T09:42:49.659698Z","caller":"traceutil/trace.go:171","msg":"trace[180831975] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"309.514577ms","start":"2026-06-09T09:42:49.350172Z","end":"2026-06-09T09:42:49.659687Z","steps":["trace[180831975] 'process raft request' (duration: 309.354975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.659772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:49.350157Z","time spent":"309.572147ms","remote":"127.0.0.1:42724","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-06-09T09:42:49.659816Z","caller":"traceutil/trace.go:171","msg":"trace[574634779] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"299.247118ms","start":"2026-06-09T09:42:49.360558Z","end":"2026-06-09T09:42:49.659805Z","steps":["trace[574634779] 'process raft request' (duration: 298.996866ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.659875Z","caller":"traceutil/trace.go:171","msg":"trace[2081423132] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"294.992292ms","start":"2026-06-09T09:42:49.364874Z","end":"2026-06-09T09:42:49.659866Z","steps":["trace[2081423132] 'process raft request' (duration: 294.87428ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.659974Z","caller":"traceutil/trace.go:171","msg":"trace[2113321531] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"292.485949ms","start":"2026-06-09T09:42:49.367480Z","end":"2026-06-09T09:42:49.659966Z","steps":["trace[2113321531] 'process raft request' (duration: 292.304938ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.660006Z","caller":"traceutil/trace.go:171","msg":"trace[1180780841] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:520; }","duration":"228.468036ms","start":"2026-06-09T09:42:49.431527Z","end":"2026-06-09T09:42:49.659995Z","steps":["trace[1180780841] 'read index received' (duration: 219.835711ms)","trace[1180780841] 'applied index is now lower than readState.Index' (duration: 8.631635ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:42:49.660052Z","caller":"traceutil/trace.go:171","msg":"trace[2018909217] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"165.46501ms","start":"2026-06-09T09:42:49.494582Z","end":"2026-06-09T09:42:49.660047Z","steps":["trace[2018909217] 'process raft request' (duration: 165.341749ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:49.660092Z","caller":"traceutil/trace.go:171","msg":"trace[744131669] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"274.151011ms","start":"2026-06-09T09:42:49.385934Z","end":"2026-06-09T09:42:49.660085Z","steps":["trace[744131669] 'process raft request' (duration: 273.943439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:49.660132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.603267ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:42:49.660156Z","caller":"traceutil/trace.go:171","msg":"trace[1431323556] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:510; }","duration":"228.632037ms","start":"2026-06-09T09:42:49.431519Z","end":"2026-06-09T09:42:49.660151Z","steps":["trace[1431323556] 'agreement among raft nodes before linearized reading' (duration: 228.585147ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:50.424550Z","caller":"traceutil/trace.go:171","msg":"trace[1482155928] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"121.966104ms","start":"2026-06-09T09:42:50.302565Z","end":"2026-06-09T09:42:50.424531Z","steps":["trace[1482155928] 'process raft request' (duration: 94.141343ms)","trace[1482155928] 'compare' (duration: 27.720561ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:42:56.203428Z","caller":"traceutil/trace.go:171","msg":"trace[1358451942] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"534.85376ms","start":"2026-06-09T09:42:55.668545Z","end":"2026-06-09T09:42:56.203399Z","steps":["trace[1358451942] 'process raft request' (duration: 534.05299ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:56.203515Z","caller":"traceutil/trace.go:171","msg":"trace[1759147700] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"179.745127ms","start":"2026-06-09T09:42:56.023744Z","end":"2026-06-09T09:42:56.203489Z","steps":["trace[1759147700] 'process raft request' (duration: 179.612956ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:56.203449Z","caller":"traceutil/trace.go:171","msg":"trace[238159245] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"488.843435ms","start":"2026-06-09T09:42:55.714583Z","end":"2026-06-09T09:42:56.203426Z","steps":["trace[238159245] 'read index received' (duration: 487.755323ms)","trace[238159245] 'applied index is now lower than readState.Index' (duration: 1.086462ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:42:56.203608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:55.668519Z","time spent":"534.988361ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:42:56.203921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.237605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-09T09:42:56.203975Z","caller":"traceutil/trace.go:171","msg":"trace[1762993728] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:605; }","duration":"485.290376ms","start":"2026-06-09T09:42:55.718670Z","end":"2026-06-09T09:42:56.203961Z","steps":["trace[1762993728] 'agreement among raft nodes before linearized reading' (duration: 485.180885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:56.204013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:55.718645Z","time spent":"485.360507ms","remote":"127.0.0.1:42804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:42:56.204083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.495312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-09T09:42:56.204166Z","caller":"traceutil/trace.go:171","msg":"trace[811461628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"489.577773ms","start":"2026-06-09T09:42:55.714572Z","end":"2026-06-09T09:42:56.204149Z","steps":["trace[811461628] 'agreement among raft nodes before linearized reading' (duration: 489.35273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:56.204236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:55.714551Z","time spent":"489.672264ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:42:56.474815Z","caller":"traceutil/trace.go:171","msg":"trace[1192217165] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"116.753144ms","start":"2026-06-09T09:42:56.358031Z","end":"2026-06-09T09:42:56.474784Z","steps":["trace[1192217165] 'process raft request' (duration: 116.50733ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:56.647122Z","caller":"traceutil/trace.go:171","msg":"trace[1107686783] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"165.453156ms","start":"2026-06-09T09:42:56.481654Z","end":"2026-06-09T09:42:56.647108Z","steps":["trace[1107686783] 'process raft request' (duration: 121.012252ms)","trace[1107686783] 'compare' (duration: 44.17961ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:42:56.884666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.124708ms","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-09T09:42:56.884721Z","caller":"traceutil/trace.go:171","msg":"trace[1711520290] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"233.75077ms","start":"2026-06-09T09:42:56.650943Z","end":"2026-06-09T09:42:56.884694Z","steps":["trace[1711520290] 'process raft request' (duration: 215.824266ms)","trace[1711520290] 'compare' (duration: 17.840783ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:42:56.884754Z","caller":"traceutil/trace.go:171","msg":"trace[1168676595] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:610; }","duration":"125.233289ms","start":"2026-06-09T09:42:56.759502Z","end":"2026-06-09T09:42:56.884735Z","steps":["trace[1168676595] 'range keys from in-memory index tree' (duration: 125.080437ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:57.062901Z","caller":"traceutil/trace.go:171","msg":"trace[762812518] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"269.015981ms","start":"2026-06-09T09:42:56.793863Z","end":"2026-06-09T09:42:57.062879Z","steps":["trace[762812518] 'process raft request' (duration: 268.953671ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:57.062936Z","caller":"traceutil/trace.go:171","msg":"trace[137097840] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"295.550082ms","start":"2026-06-09T09:42:56.767346Z","end":"2026-06-09T09:42:57.062896Z","steps":["trace[137097840] 'process raft request' (duration: 248.180808ms)","trace[137097840] 'compare' (duration: 46.917558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:42:57.761372Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153699809139796024,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T09:42:58.191607Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.074220198s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-09T09:42:58.196155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.047815ms","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-09T09:42:58.196216Z","caller":"traceutil/trace.go:171","msg":"trace[391471631] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:613; }","duration":"765.113516ms","start":"2026-06-09T09:42:57.431081Z","end":"2026-06-09T09:42:58.196195Z","steps":["trace[391471631] 'range keys from in-memory index tree' (duration: 765.005414ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:42:58.196336Z","caller":"traceutil/trace.go:171","msg":"trace[661948955] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"935.158014ms","start":"2026-06-09T09:42:57.261141Z","end":"2026-06-09T09:42:58.196299Z","steps":["trace[661948955] 'read index received' (duration: 930.919693ms)","trace[661948955] 'applied index is now lower than readState.Index' (duration: 4.237461ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:42:58.196363Z","caller":"traceutil/trace.go:171","msg":"trace[2028228442] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.079066246s","start":"2026-06-09T09:42:57.117273Z","end":"2026-06-09T09:42:58.196339Z","steps":["trace[2028228442] 'process raft request' (duration: 1.074811466s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:58.196480Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:57.117249Z","time spent":"1.079175098s","remote":"127.0.0.1:42936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2676,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T09:42:58.196557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.398487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:42:58.196614Z","caller":"traceutil/trace.go:171","msg":"trace[1197825647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"935.472928ms","start":"2026-06-09T09:42:57.261127Z","end":"2026-06-09T09:42:58.196600Z","steps":["trace[1197825647] 'agreement among raft nodes before linearized reading' (duration: 935.299996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:42:58.196661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:42:57.261103Z","time spent":"935.547398ms","remote":"127.0.0.1:42678","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-09T09:42:59.766944Z","caller":"traceutil/trace.go:171","msg":"trace[128105810] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"143.683311ms","start":"2026-06-09T09:42:59.623240Z","end":"2026-06-09T09:42:59.766923Z","steps":["trace[128105810] 'process raft request' (duration: 143.563269ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:12.709998Z","caller":"traceutil/trace.go:171","msg":"trace[1342116836] linearizableReadLoop","detail":"{readStateIndex:808; appliedIndex:807; }","duration":"279.496731ms","start":"2026-06-09T09:43:12.430480Z","end":"2026-06-09T09:43:12.709976Z","steps":["trace[1342116836] 'read index received' (duration: 279.273618ms)","trace[1342116836] 'applied index is now lower than readState.Index' (duration: 221.913µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:43:12.710168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.669974ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:43:12.710159Z","caller":"traceutil/trace.go:171","msg":"trace[66975326] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"372.569584ms","start":"2026-06-09T09:43:12.337549Z","end":"2026-06-09T09:43:12.710119Z","steps":["trace[66975326] 'process raft request' (duration: 372.158797ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:12.710234Z","caller":"traceutil/trace.go:171","msg":"trace[1881537485] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:778; }","duration":"279.743096ms","start":"2026-06-09T09:43:12.430474Z","end":"2026-06-09T09:43:12.710217Z","steps":["trace[1881537485] 'agreement among raft nodes before linearized reading' (duration: 279.649394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:43:12.710423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:43:12.337520Z","time spent":"372.776266ms","remote":"127.0.0.1:42974","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-09T09:43:12.819189Z","caller":"traceutil/trace.go:171","msg":"trace[59028930] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"108.962673ms","start":"2026-06-09T09:43:12.710203Z","end":"2026-06-09T09:43:12.819165Z","steps":["trace[59028930] 'read index received' (duration: 104.074893ms)","trace[59028930] 'applied index is now lower than readState.Index' (duration: 4.88686ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:43:12.819351Z","caller":"traceutil/trace.go:171","msg":"trace[1941413078] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"116.028491ms","start":"2026-06-09T09:43:12.703276Z","end":"2026-06-09T09:43:12.819305Z","steps":["trace[1941413078] 'process raft request' (duration: 111.07884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:43:12.819487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.959091ms","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":"warn","ts":"2026-06-09T09:43:12.819482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.633685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4bzhk\" limit:1 ","response":"range_response_count:1 size:4263"} {"level":"info","ts":"2026-06-09T09:43:12.819525Z","caller":"traceutil/trace.go:171","msg":"trace[1146923013] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:779; }","duration":"104.027862ms","start":"2026-06-09T09:43:12.715487Z","end":"2026-06-09T09:43:12.819514Z","steps":["trace[1146923013] 'agreement among raft nodes before linearized reading' (duration: 103.933621ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:12.819564Z","caller":"traceutil/trace.go:171","msg":"trace[427861748] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4bzhk; range_end:; response_count:1; response_revision:779; }","duration":"383.723617ms","start":"2026-06-09T09:43:12.435822Z","end":"2026-06-09T09:43:12.819546Z","steps":["trace[427861748] 'agreement among raft nodes before linearized reading' (duration: 383.572334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:43:12.819606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:43:12.435808Z","time spent":"383.789647ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":4286,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4bzhk\" limit:1 "} {"level":"info","ts":"2026-06-09T09:43:16.253491Z","caller":"traceutil/trace.go:171","msg":"trace[425935116] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"101.360669ms","start":"2026-06-09T09:43:16.152112Z","end":"2026-06-09T09:43:16.253472Z","steps":["trace[425935116] 'process raft request' (duration: 100.184478ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:16.347647Z","caller":"traceutil/trace.go:171","msg":"trace[452502576] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"160.423206ms","start":"2026-06-09T09:43:16.187200Z","end":"2026-06-09T09:43:16.347623Z","steps":["trace[452502576] 'process raft request' (duration: 136.584117ms)","trace[452502576] 'compare' (duration: 23.623215ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:43:25.721218Z","caller":"traceutil/trace.go:171","msg":"trace[1022991815] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"144.389266ms","start":"2026-06-09T09:43:25.576808Z","end":"2026-06-09T09:43:25.721198Z","steps":["trace[1022991815] 'process raft request' (duration: 125.329559ms)","trace[1022991815] 'compare' (duration: 17.991885ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:43:30.047380Z","caller":"traceutil/trace.go:171","msg":"trace[254425316] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"123.636496ms","start":"2026-06-09T09:43:29.923716Z","end":"2026-06-09T09:43:30.047352Z","steps":["trace[254425316] 'process raft request' (duration: 81.117017ms)","trace[254425316] 'compare' (duration: 42.404566ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:43:30.047783Z","caller":"traceutil/trace.go:171","msg":"trace[1808875178] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"122.061993ms","start":"2026-06-09T09:43:29.925708Z","end":"2026-06-09T09:43:30.047770Z","steps":["trace[1808875178] 'process raft request' (duration: 121.868709ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:30.047925Z","caller":"traceutil/trace.go:171","msg":"trace[1755820045] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"121.865478ms","start":"2026-06-09T09:43:29.926051Z","end":"2026-06-09T09:43:30.047917Z","steps":["trace[1755820045] 'process raft request' (duration: 121.661524ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:30.047995Z","caller":"traceutil/trace.go:171","msg":"trace[1943690316] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"101.622169ms","start":"2026-06-09T09:43:29.946320Z","end":"2026-06-09T09:43:30.047942Z","steps":["trace[1943690316] 'process raft request' (duration: 101.443536ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:43:43.989945Z","caller":"traceutil/trace.go:171","msg":"trace[1322996703] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"133.92034ms","start":"2026-06-09T09:43:43.856005Z","end":"2026-06-09T09:43:43.989925Z","steps":["trace[1322996703] 'process raft request' (duration: 133.786907ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:02.823163Z","caller":"traceutil/trace.go:171","msg":"trace[2076588622] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"164.746749ms","start":"2026-06-09T09:44:02.658399Z","end":"2026-06-09T09:44:02.823146Z","steps":["trace[2076588622] 'read index received' (duration: 164.569354ms)","trace[2076588622] 'applied index is now lower than readState.Index' (duration: 176.965µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:44:02.823304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.892323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-blv6q\" limit:1 ","response":"range_response_count:1 size:4495"} {"level":"info","ts":"2026-06-09T09:44:02.823329Z","caller":"traceutil/trace.go:171","msg":"trace[521966834] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-blv6q; range_end:; response_count:1; response_revision:1339; }","duration":"164.935314ms","start":"2026-06-09T09:44:02.658386Z","end":"2026-06-09T09:44:02.823321Z","steps":["trace[521966834] 'agreement among raft nodes before linearized reading' (duration: 164.844142ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:02.823633Z","caller":"traceutil/trace.go:171","msg":"trace[1403539024] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"166.548626ms","start":"2026-06-09T09:44:02.657073Z","end":"2026-06-09T09:44:02.823622Z","steps":["trace[1403539024] 'process raft request' (duration: 165.94457ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:09.326338Z","caller":"traceutil/trace.go:171","msg":"trace[1159493613] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"484.100715ms","start":"2026-06-09T09:44:08.841933Z","end":"2026-06-09T09:44:09.326034Z","steps":["trace[1159493613] 'process raft request' (duration: 483.868249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:09.326640Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:08.841885Z","time spent":"484.529067ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:44:09.340539Z","caller":"traceutil/trace.go:171","msg":"trace[1896857432] linearizableReadLoop","detail":"{readStateIndex:1510; appliedIndex:1508; }","duration":"320.398943ms","start":"2026-06-09T09:44:09.020117Z","end":"2026-06-09T09:44:09.340516Z","steps":["trace[1896857432] 'read index received' (duration: 305.807677ms)","trace[1896857432] 'applied index is now lower than readState.Index' (duration: 14.590036ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:44:09.340597Z","caller":"traceutil/trace.go:171","msg":"trace[481931178] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"298.294355ms","start":"2026-06-09T09:44:09.042283Z","end":"2026-06-09T09:44:09.340577Z","steps":["trace[481931178] 'process raft request' (duration: 298.133371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:09.340798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.597198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T09:44:09.341188Z","caller":"traceutil/trace.go:171","msg":"trace[1048567408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1461; }","duration":"321.069092ms","start":"2026-06-09T09:44:09.020103Z","end":"2026-06-09T09:44:09.341172Z","steps":["trace[1048567408] 'agreement among raft nodes before linearized reading' (duration: 320.557318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:09.341242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:09.020084Z","time spent":"321.142864ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:44:34.105032Z","caller":"traceutil/trace.go:171","msg":"trace[2083111121] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"180.332664ms","start":"2026-06-09T09:44:33.924658Z","end":"2026-06-09T09:44:34.104991Z","steps":["trace[2083111121] 'process raft request' (duration: 145.322013ms)","trace[2083111121] 'compare' (duration: 34.856686ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:44:34.720477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.739632ms","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-09T09:44:34.720556Z","caller":"traceutil/trace.go:171","msg":"trace[917489462] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1881; }","duration":"289.829654ms","start":"2026-06-09T09:44:34.430709Z","end":"2026-06-09T09:44:34.720539Z","steps":["trace[917489462] 'range keys from in-memory index tree' (duration: 289.566625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.720996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.260675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:44:34.721249Z","caller":"traceutil/trace.go:171","msg":"trace[1638192700] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"787.698986ms","start":"2026-06-09T09:44:33.933534Z","end":"2026-06-09T09:44:34.721233Z","steps":["trace[1638192700] 'process raft request' (duration: 787.614554ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:34.721288Z","caller":"traceutil/trace.go:171","msg":"trace[1376604058] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"795.244528ms","start":"2026-06-09T09:44:33.926013Z","end":"2026-06-09T09:44:34.721258Z","steps":["trace[1376604058] 'process raft request' (duration: 303.666355ms)","trace[1376604058] 'compare' (duration: 490.967976ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:44:34.721247Z","caller":"traceutil/trace.go:171","msg":"trace[385889946] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"789.327584ms","start":"2026-06-09T09:44:33.931897Z","end":"2026-06-09T09:44:34.721225Z","steps":["trace[385889946] 'process raft request' (duration: 789.192861ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:34.721494Z","caller":"traceutil/trace.go:171","msg":"trace[103755585] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1957; }","duration":"716.66399ms","start":"2026-06-09T09:44:34.004809Z","end":"2026-06-09T09:44:34.721473Z","steps":["trace[103755585] 'read index received' (duration: 65.194699ms)","trace[103755585] 'applied index is now lower than readState.Index' (duration: 651.467551ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:44:34.721524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:33.925991Z","time spent":"795.425773ms","remote":"127.0.0.1:42848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:44:34.721593Z","caller":"traceutil/trace.go:171","msg":"trace[1646842404] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"785.7979ms","start":"2026-06-09T09:44:33.935782Z","end":"2026-06-09T09:44:34.721580Z","steps":["trace[1646842404] 'process raft request' (duration: 785.40268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.721693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:33.935769Z","time spent":"785.865993ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4089,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:44:34.721731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:33.931876Z","time spent":"789.661025ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1430,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:44:34.721741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.903607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T09:44:34.721836Z","caller":"traceutil/trace.go:171","msg":"trace[143220551] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1885; }","duration":"717.01239ms","start":"2026-06-09T09:44:34.004803Z","end":"2026-06-09T09:44:34.721816Z","steps":["trace[143220551] 'agreement among raft nodes before linearized reading' (duration: 716.820565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.721445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:33.933520Z","time spent":"787.772089ms","remote":"127.0.0.1:42978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:44:34.721939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:34.004783Z","time spent":"717.142434ms","remote":"127.0.0.1:38222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:44:34.730593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.211015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:44:34.730647Z","caller":"traceutil/trace.go:171","msg":"trace[1487931616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1886; }","duration":"470.269416ms","start":"2026-06-09T09:44:34.260365Z","end":"2026-06-09T09:44:34.730634Z","steps":["trace[1487931616] 'agreement among raft nodes before linearized reading' (duration: 470.177823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.730675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:34.260346Z","time spent":"470.324919ms","remote":"127.0.0.1:42678","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-09T09:44:34.730868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.993242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" limit:1 ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-09T09:44:34.730901Z","caller":"traceutil/trace.go:171","msg":"trace[1246035868] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1886; }","duration":"317.027124ms","start":"2026-06-09T09:44:34.413865Z","end":"2026-06-09T09:44:34.730893Z","steps":["trace[1246035868] 'agreement among raft nodes before linearized reading' (duration: 316.964052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.730925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:34.413842Z","time spent":"317.078616ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:44:34.731036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.560888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T09:44:34.731081Z","caller":"traceutil/trace.go:171","msg":"trace[657148106] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1886; }","duration":"429.608189ms","start":"2026-06-09T09:44:34.301463Z","end":"2026-06-09T09:44:34.731071Z","steps":["trace[657148106] 'agreement among raft nodes before linearized reading' (duration: 429.538717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:34.731194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:34.301443Z","time spent":"429.742262ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-06-09T09:44:35.530195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.327291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808ccd03-78eb-4f4b-ae38-d9ee5a20a238\" limit:1 ","response":"range_response_count:1 size:4104"} {"level":"info","ts":"2026-06-09T09:44:35.530283Z","caller":"traceutil/trace.go:171","msg":"trace[1556152848] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-808ccd03-78eb-4f4b-ae38-d9ee5a20a238; range_end:; response_count:1; response_revision:1888; }","duration":"606.431714ms","start":"2026-06-09T09:44:34.923831Z","end":"2026-06-09T09:44:35.530262Z","steps":["trace[1556152848] 'range keys from in-memory index tree' (duration: 606.217737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:35.530327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:34.923810Z","time spent":"606.508237ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":4127,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-808ccd03-78eb-4f4b-ae38-d9ee5a20a238\" limit:1 "} {"level":"info","ts":"2026-06-09T09:44:35.534479Z","caller":"traceutil/trace.go:171","msg":"trace[271502486] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"445.450048ms","start":"2026-06-09T09:44:35.089011Z","end":"2026-06-09T09:44:35.534461Z","steps":["trace[271502486] 'process raft request' (duration: 445.324354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:35.534598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:35.088988Z","time spent":"445.552921ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:44:35.543450Z","caller":"traceutil/trace.go:171","msg":"trace[1059862202] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"147.083711ms","start":"2026-06-09T09:44:35.396346Z","end":"2026-06-09T09:44:35.543430Z","steps":["trace[1059862202] 'process raft request' (duration: 146.919686ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:35.543595Z","caller":"traceutil/trace.go:171","msg":"trace[745523650] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"126.04974ms","start":"2026-06-09T09:44:35.417537Z","end":"2026-06-09T09:44:35.543586Z","steps":["trace[745523650] 'process raft request' (duration: 125.858925ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:35.543800Z","caller":"traceutil/trace.go:171","msg":"trace[1870544403] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"122.592318ms","start":"2026-06-09T09:44:35.421202Z","end":"2026-06-09T09:44:35.543794Z","steps":["trace[1870544403] 'process raft request' (duration: 122.351011ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:35.544119Z","caller":"traceutil/trace.go:171","msg":"trace[2144272015] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"233.384389ms","start":"2026-06-09T09:44:35.310325Z","end":"2026-06-09T09:44:35.543709Z","steps":["trace[2144272015] 'process raft request' (duration: 232.863523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:41.947076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.366127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:44:41.947255Z","caller":"traceutil/trace.go:171","msg":"trace[339552955] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2034; }","duration":"170.403984ms","start":"2026-06-09T09:44:41.776835Z","end":"2026-06-09T09:44:41.947239Z","steps":["trace[339552955] 'read index received' (duration: 56.251µs)","trace[339552955] 'applied index is now lower than readState.Index' (duration: 170.346973ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:44:41.947460Z","caller":"traceutil/trace.go:171","msg":"trace[612717411] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"333.848701ms","start":"2026-06-09T09:44:41.613576Z","end":"2026-06-09T09:44:41.947425Z","steps":["trace[612717411] 'process raft request' (duration: 15.03ms)","trace[612717411] 'compare' (duration: 318.204612ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:44:41.947628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:41.613277Z","time spent":"334.259333ms","remote":"127.0.0.1:42974","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-09T09:44:41.947686Z","caller":"traceutil/trace.go:171","msg":"trace[4013428] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"333.678206ms","start":"2026-06-09T09:44:41.613977Z","end":"2026-06-09T09:44:41.947655Z","steps":["trace[4013428] 'process raft request' (duration: 333.212822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:41.947783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.952921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T09:44:41.947823Z","caller":"traceutil/trace.go:171","msg":"trace[738346129] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1957; }","duration":"170.992021ms","start":"2026-06-09T09:44:41.776818Z","end":"2026-06-09T09:44:41.947810Z","steps":["trace[738346129] 'agreement among raft nodes before linearized reading' (duration: 170.467956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:41.947818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:41.613953Z","time spent":"333.796039ms","remote":"127.0.0.1:42974","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-09T09:44:45.671543Z","caller":"traceutil/trace.go:171","msg":"trace[454339020] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"103.385384ms","start":"2026-06-09T09:44:45.568126Z","end":"2026-06-09T09:44:45.671512Z","steps":["trace[454339020] 'process raft request' (duration: 103.218249ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:45.681149Z","caller":"traceutil/trace.go:171","msg":"trace[1567008191] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"103.586391ms","start":"2026-06-09T09:44:45.577530Z","end":"2026-06-09T09:44:45.681117Z","steps":["trace[1567008191] 'process raft request' (duration: 103.126847ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:47.177454Z","caller":"traceutil/trace.go:171","msg":"trace[1958063191] linearizableReadLoop","detail":"{readStateIndex:2065; appliedIndex:2064; }","duration":"198.817463ms","start":"2026-06-09T09:44:46.978613Z","end":"2026-06-09T09:44:47.177431Z","steps":["trace[1958063191] 'read index received' (duration: 198.559044ms)","trace[1958063191] 'applied index is now lower than readState.Index' (duration: 257.629µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:44:47.177596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.969417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T09:44:47.177575Z","caller":"traceutil/trace.go:171","msg":"trace[1740723946] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"359.16078ms","start":"2026-06-09T09:44:46.818380Z","end":"2026-06-09T09:44:47.177541Z","steps":["trace[1740723946] 'process raft request' (duration: 358.916763ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:44:47.177629Z","caller":"traceutil/trace.go:171","msg":"trace[1950159972] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1985; }","duration":"199.017578ms","start":"2026-06-09T09:44:46.978601Z","end":"2026-06-09T09:44:47.177618Z","steps":["trace[1950159972] 'agreement among raft nodes before linearized reading' (duration: 198.929666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:44:47.177824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:44:46.818364Z","time spent":"359.287654ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:45:02.629071Z","caller":"traceutil/trace.go:171","msg":"trace[525592059] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"110.951651ms","start":"2026-06-09T09:45:02.518092Z","end":"2026-06-09T09:45:02.629044Z","steps":["trace[525592059] 'process raft request' (duration: 110.812357ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:08.297590Z","caller":"traceutil/trace.go:171","msg":"trace[473045713] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"192.762258ms","start":"2026-06-09T09:45:08.104801Z","end":"2026-06-09T09:45:08.297564Z","steps":["trace[473045713] 'process raft request' (duration: 192.620344ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:08.467482Z","caller":"traceutil/trace.go:171","msg":"trace[1048550225] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2204; }","duration":"209.798546ms","start":"2026-06-09T09:45:08.257657Z","end":"2026-06-09T09:45:08.467455Z","steps":["trace[1048550225] 'read index received' (duration: 39.842525ms)","trace[1048550225] 'applied index is now lower than readState.Index' (duration: 169.955121ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:45:08.467812Z","caller":"traceutil/trace.go:171","msg":"trace[264262644] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"362.586255ms","start":"2026-06-09T09:45:08.105211Z","end":"2026-06-09T09:45:08.467797Z","steps":["trace[264262644] 'process raft request' (duration: 343.972399ms)","trace[264262644] 'compare' (duration: 18.150441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:45:08.467911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:08.105200Z","time spent":"362.648986ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:45:08.467987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.18781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T09:45:08.468060Z","caller":"traceutil/trace.go:171","msg":"trace[1717293426] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2122; }","duration":"144.270302ms","start":"2026-06-09T09:45:08.323772Z","end":"2026-06-09T09:45:08.468043Z","steps":["trace[1717293426] 'agreement among raft nodes before linearized reading' (duration: 144.123288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:08.468008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.346532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:45:08.468165Z","caller":"traceutil/trace.go:171","msg":"trace[1332430130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2122; }","duration":"210.465417ms","start":"2026-06-09T09:45:08.257643Z","end":"2026-06-09T09:45:08.468109Z","steps":["trace[1332430130] 'agreement among raft nodes before linearized reading' (duration: 210.307811ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.084755Z","caller":"traceutil/trace.go:171","msg":"trace[254625049] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"134.692724ms","start":"2026-06-09T09:45:08.950021Z","end":"2026-06-09T09:45:09.084713Z","steps":["trace[254625049] 'process raft request' (duration: 134.459557ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.390199Z","caller":"traceutil/trace.go:171","msg":"trace[1684856339] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"115.165311ms","start":"2026-06-09T09:45:09.274997Z","end":"2026-06-09T09:45:09.390162Z","steps":["trace[1684856339] 'process raft request' (duration: 115.015886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:09.740625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.597013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" limit:1 ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T09:45:09.740739Z","caller":"traceutil/trace.go:171","msg":"trace[453190156] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2124; }","duration":"265.741157ms","start":"2026-06-09T09:45:09.474973Z","end":"2026-06-09T09:45:09.740715Z","steps":["trace[453190156] 'range keys from in-memory index tree' (duration: 265.451359ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.897220Z","caller":"traceutil/trace.go:171","msg":"trace[942452330] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"121.747118ms","start":"2026-06-09T09:45:09.775445Z","end":"2026-06-09T09:45:09.897192Z","steps":["trace[942452330] 'process raft request' (duration: 115.562473ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.897510Z","caller":"traceutil/trace.go:171","msg":"trace[1549274792] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"120.647143ms","start":"2026-06-09T09:45:09.776751Z","end":"2026-06-09T09:45:09.897398Z","steps":["trace[1549274792] 'process raft request' (duration: 120.373275ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.897683Z","caller":"traceutil/trace.go:171","msg":"trace[1714077102] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"120.791948ms","start":"2026-06-09T09:45:09.776873Z","end":"2026-06-09T09:45:09.897665Z","steps":["trace[1714077102] 'process raft request' (duration: 120.446316ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.897769Z","caller":"traceutil/trace.go:171","msg":"trace[1435016392] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"119.825348ms","start":"2026-06-09T09:45:09.777871Z","end":"2026-06-09T09:45:09.897696Z","steps":["trace[1435016392] 'process raft request' (duration: 119.745895ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:09.897843Z","caller":"traceutil/trace.go:171","msg":"trace[1446846984] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"120.19894ms","start":"2026-06-09T09:45:09.777622Z","end":"2026-06-09T09:45:09.897821Z","steps":["trace[1446846984] 'process raft request' (duration: 119.952112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.795844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.104017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:45:10.795920Z","caller":"traceutil/trace.go:171","msg":"trace[2037067069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2130; }","duration":"537.18299ms","start":"2026-06-09T09:45:10.258720Z","end":"2026-06-09T09:45:10.795903Z","steps":["trace[2037067069] 'range keys from in-memory index tree' (duration: 537.027874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.795958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.258702Z","time spent":"537.248702ms","remote":"127.0.0.1:42672","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-09T09:45:10.796117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.339161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:45:10.796151Z","caller":"traceutil/trace.go:171","msg":"trace[1686268959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2130; }","duration":"522.369451ms","start":"2026-06-09T09:45:10.273772Z","end":"2026-06-09T09:45:10.796142Z","steps":["trace[1686268959] 'range keys from in-memory index tree' (duration: 522.30611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.796176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.273764Z","time spent":"522.406843ms","remote":"127.0.0.1:42678","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-09T09:45:10.796355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.763703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T09:45:10.797797Z","caller":"traceutil/trace.go:171","msg":"trace[166833346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2130; }","duration":"326.22753ms","start":"2026-06-09T09:45:10.471546Z","end":"2026-06-09T09:45:10.797773Z","steps":["trace[166833346] 'range keys from in-memory index tree' (duration: 324.617108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.796418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.268752ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:45:10.796428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.618905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T09:45:10.798120Z","caller":"traceutil/trace.go:171","msg":"trace[60886017] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2130; }","duration":"366.960456ms","start":"2026-06-09T09:45:10.431138Z","end":"2026-06-09T09:45:10.798099Z","steps":["trace[60886017] 'range keys from in-memory index tree' (duration: 365.21849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.798184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.471519Z","time spent":"326.55229ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:45:10.798266Z","caller":"traceutil/trace.go:171","msg":"trace[268527497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2130; }","duration":"495.37957ms","start":"2026-06-09T09:45:10.302770Z","end":"2026-06-09T09:45:10.798150Z","steps":["trace[268527497] 'range keys from in-memory index tree' (duration: 493.51092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:10.798443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.302752Z","time spent":"495.673539ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:45:11.070359Z","caller":"traceutil/trace.go:171","msg":"trace[1841074838] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"268.468818ms","start":"2026-06-09T09:45:10.801857Z","end":"2026-06-09T09:45:11.070326Z","steps":["trace[1841074838] 'process raft request' (duration: 268.275063ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:11.362574Z","caller":"traceutil/trace.go:171","msg":"trace[334791549] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2215; }","duration":"478.823523ms","start":"2026-06-09T09:45:10.883715Z","end":"2026-06-09T09:45:11.362539Z","steps":["trace[334791549] 'read index received' (duration: 186.432189ms)","trace[334791549] 'applied index is now lower than readState.Index' (duration: 292.390034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:45:11.362786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.091324ms","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-09T09:45:11.362839Z","caller":"traceutil/trace.go:171","msg":"trace[1770390322] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2132; }","duration":"124.159705ms","start":"2026-06-09T09:45:11.238664Z","end":"2026-06-09T09:45:11.362824Z","steps":["trace[1770390322] 'agreement among raft nodes before linearized reading' (duration: 124.059702ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:45:11.362818Z","caller":"traceutil/trace.go:171","msg":"trace[1048266530] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"559.883653ms","start":"2026-06-09T09:45:10.802907Z","end":"2026-06-09T09:45:11.362791Z","steps":["trace[1048266530] 'process raft request' (duration: 559.419038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:11.362898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.149844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:45:11.363010Z","caller":"traceutil/trace.go:171","msg":"trace[638413331] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2132; }","duration":"479.285758ms","start":"2026-06-09T09:45:10.883701Z","end":"2026-06-09T09:45:11.362987Z","steps":["trace[638413331] 'agreement among raft nodes before linearized reading' (duration: 479.016999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:11.363072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.883681Z","time spent":"479.375221ms","remote":"127.0.0.1:43740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":17,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-09T09:45:11.363163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:45:10.802845Z","time spent":"560.036527ms","remote":"127.0.0.1:42974","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-09T09:45:11.363433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.675628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:45:11.363492Z","caller":"traceutil/trace.go:171","msg":"trace[2006340561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2132; }","duration":"103.729459ms","start":"2026-06-09T09:45:11.259746Z","end":"2026-06-09T09:45:11.363476Z","steps":["trace[2006340561] 'agreement among raft nodes before linearized reading' (duration: 103.646467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:11.598129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.527045ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:45:11.598223Z","caller":"traceutil/trace.go:171","msg":"trace[1091476012] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2132; }","duration":"166.637238ms","start":"2026-06-09T09:45:11.431565Z","end":"2026-06-09T09:45:11.598202Z","steps":["trace[1091476012] 'range keys from in-memory index tree' (duration: 166.39978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:45:11.598150Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.819754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-09T09:45:11.598419Z","caller":"traceutil/trace.go:171","msg":"trace[1777514981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2132; }","duration":"204.456885ms","start":"2026-06-09T09:45:11.393936Z","end":"2026-06-09T09:45:11.598392Z","steps":["trace[1777514981] 'range keys from in-memory index tree' (duration: 203.731321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:08.356239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.206404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-5d7dc9997d-gmsdg\" limit:1 ","response":"range_response_count:1 size:8282"} {"level":"info","ts":"2026-06-09T09:46:08.356308Z","caller":"traceutil/trace.go:171","msg":"trace[1958988978] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-5d7dc9997d-gmsdg; range_end:; response_count:1; response_revision:2494; }","duration":"110.294286ms","start":"2026-06-09T09:46:08.246001Z","end":"2026-06-09T09:46:08.356295Z","steps":["trace[1958988978] 'range keys from in-memory index tree' (duration: 110.11047ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:16.606652Z","caller":"traceutil/trace.go:171","msg":"trace[350194910] linearizableReadLoop","detail":"{readStateIndex:2693; appliedIndex:2692; }","duration":"175.917121ms","start":"2026-06-09T09:46:16.430699Z","end":"2026-06-09T09:46:16.606616Z","steps":["trace[350194910] 'read index received' (duration: 175.553229ms)","trace[350194910] 'applied index is now lower than readState.Index' (duration: 362.501µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:46:16.606788Z","caller":"traceutil/trace.go:171","msg":"trace[626122829] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"203.603954ms","start":"2026-06-09T09:46:16.403135Z","end":"2026-06-09T09:46:16.606739Z","steps":["trace[626122829] 'process raft request' (duration: 203.222922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:16.607022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.292703ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:16.607118Z","caller":"traceutil/trace.go:171","msg":"trace[693273091] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2593; }","duration":"176.422127ms","start":"2026-06-09T09:46:16.430683Z","end":"2026-06-09T09:46:16.607105Z","steps":["trace[693273091] 'agreement among raft nodes before linearized reading' (duration: 176.19024ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:17.694469Z","caller":"traceutil/trace.go:171","msg":"trace[1858066557] linearizableReadLoop","detail":"{readStateIndex:2694; appliedIndex:2693; }","duration":"263.055353ms","start":"2026-06-09T09:46:17.431391Z","end":"2026-06-09T09:46:17.694446Z","steps":["trace[1858066557] 'read index received' (duration: 262.913969ms)","trace[1858066557] 'applied index is now lower than readState.Index' (duration: 140.464µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:46:17.694549Z","caller":"traceutil/trace.go:171","msg":"trace[1162356036] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"323.7338ms","start":"2026-06-09T09:46:17.370794Z","end":"2026-06-09T09:46:17.694528Z","steps":["trace[1162356036] 'process raft request' (duration: 323.534143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:17.694618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.240261ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:17.694654Z","caller":"traceutil/trace.go:171","msg":"trace[359757265] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2594; }","duration":"263.290242ms","start":"2026-06-09T09:46:17.431354Z","end":"2026-06-09T09:46:17.694644Z","steps":["trace[359757265] 'agreement among raft nodes before linearized reading' (duration: 263.205459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:17.694678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:17.370776Z","time spent":"323.825043ms","remote":"127.0.0.1:42974","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-09T09:46:44.211504Z","caller":"traceutil/trace.go:171","msg":"trace[1854443868] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"130.296934ms","start":"2026-06-09T09:46:44.081179Z","end":"2026-06-09T09:46:44.211476Z","steps":["trace[1854443868] 'process raft request' (duration: 130.150979ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:44.247866Z","caller":"traceutil/trace.go:171","msg":"trace[1676290628] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"110.415234ms","start":"2026-06-09T09:46:44.137421Z","end":"2026-06-09T09:46:44.247836Z","steps":["trace[1676290628] 'process raft request' (duration: 108.282041ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.134128Z","caller":"traceutil/trace.go:171","msg":"trace[2075316306] linearizableReadLoop","detail":"{readStateIndex:2879; appliedIndex:2878; }","duration":"236.641005ms","start":"2026-06-09T09:46:49.897468Z","end":"2026-06-09T09:46:50.134109Z","steps":["trace[2075316306] 'read index received' (duration: 236.508431ms)","trace[2075316306] 'applied index is now lower than readState.Index' (duration: 131.744µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:46:50.134300Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.823759ms","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-09T09:46:50.134354Z","caller":"traceutil/trace.go:171","msg":"trace[1443335605] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2771; }","duration":"236.886121ms","start":"2026-06-09T09:46:49.897456Z","end":"2026-06-09T09:46:50.134342Z","steps":["trace[1443335605] 'agreement among raft nodes before linearized reading' (duration: 236.801418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.134342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.158634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-09T09:46:50.134552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.952715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:50.134574Z","caller":"traceutil/trace.go:171","msg":"trace[1976002247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2771; }","duration":"225.3963ms","start":"2026-06-09T09:46:49.909169Z","end":"2026-06-09T09:46:50.134565Z","steps":["trace[1976002247] 'agreement among raft nodes before linearized reading' (duration: 225.131994ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.134588Z","caller":"traceutil/trace.go:171","msg":"trace[70704550] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2771; }","duration":"121.987845ms","start":"2026-06-09T09:46:50.012588Z","end":"2026-06-09T09:46:50.134576Z","steps":["trace[70704550] 'agreement among raft nodes before linearized reading' (duration: 121.938255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.134754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.334668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T09:46:50.134792Z","caller":"traceutil/trace.go:171","msg":"trace[97183208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2771; }","duration":"220.371559ms","start":"2026-06-09T09:46:49.914411Z","end":"2026-06-09T09:46:50.134783Z","steps":["trace[97183208] 'agreement among raft nodes before linearized reading' (duration: 220.314788ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.134986Z","caller":"traceutil/trace.go:171","msg":"trace[2077688874] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"276.112067ms","start":"2026-06-09T09:46:49.858781Z","end":"2026-06-09T09:46:50.134893Z","steps":["trace[2077688874] 'process raft request' (duration: 275.188913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.741210Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.081745ms","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-09T09:46:50.741301Z","caller":"traceutil/trace.go:171","msg":"trace[873968987] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2771; }","duration":"310.179827ms","start":"2026-06-09T09:46:50.431108Z","end":"2026-06-09T09:46:50.741288Z","steps":["trace[873968987] 'range keys from in-memory index tree' (duration: 310.025054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.741803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.525318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:46:50.741974Z","caller":"traceutil/trace.go:171","msg":"trace[1448058297] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"605.121456ms","start":"2026-06-09T09:46:50.136827Z","end":"2026-06-09T09:46:50.741948Z","steps":["trace[1448058297] 'process raft request' (duration: 384.361572ms)","trace[1448058297] 'compare' (duration: 220.1743ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:46:50.742076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.136811Z","time spent":"605.215489ms","remote":"127.0.0.1:42754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:46:50.928286Z","caller":"traceutil/trace.go:171","msg":"trace[1109747643] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"788.539242ms","start":"2026-06-09T09:46:50.139692Z","end":"2026-06-09T09:46:50.928231Z","steps":["trace[1109747643] 'process raft request' (duration: 775.536851ms)","trace[1109747643] 'compare' (duration: 12.62179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:46:50.928543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.139680Z","time spent":"788.721627ms","remote":"127.0.0.1:42974","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-09T09:46:50.928613Z","caller":"traceutil/trace.go:171","msg":"trace[659157744] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"788.154722ms","start":"2026-06-09T09:46:50.140450Z","end":"2026-06-09T09:46:50.928605Z","steps":["trace[659157744] 'process raft request' (duration: 787.67706ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.928705Z","caller":"traceutil/trace.go:171","msg":"trace[1476952812] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"659.101241ms","start":"2026-06-09T09:46:50.269584Z","end":"2026-06-09T09:46:50.928651Z","steps":["trace[1476952812] 'process raft request' (duration: 658.597677ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.928773Z","caller":"traceutil/trace.go:171","msg":"trace[1426413872] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"622.43227ms","start":"2026-06-09T09:46:50.306333Z","end":"2026-06-09T09:46:50.928766Z","steps":["trace[1426413872] 'process raft request' (duration: 621.947297ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.928548Z","caller":"traceutil/trace.go:171","msg":"trace[794003724] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"654.690216ms","start":"2026-06-09T09:46:50.273830Z","end":"2026-06-09T09:46:50.928521Z","steps":["trace[794003724] 'process raft request' (duration: 654.383398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.928819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.306321Z","time spent":"622.4721ms","remote":"127.0.0.1:42974","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-06-09T09:46:50.928824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.269573Z","time spent":"659.208913ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:46:50.928870Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.273822Z","time spent":"655.002083ms","remote":"127.0.0.1:42974","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-09T09:46:50.928714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.140434Z","time spent":"788.214764ms","remote":"127.0.0.1:42974","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-09T09:46:50.929133Z","caller":"traceutil/trace.go:171","msg":"trace[909297473] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"655.258239ms","start":"2026-06-09T09:46:50.273863Z","end":"2026-06-09T09:46:50.929121Z","steps":["trace[909297473] 'process raft request' (duration: 654.386536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.929200Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.273852Z","time spent":"655.317471ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:46:50.929295Z","caller":"traceutil/trace.go:171","msg":"trace[1806600195] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"617.512031ms","start":"2026-06-09T09:46:50.311770Z","end":"2026-06-09T09:46:50.929282Z","steps":["trace[1806600195] 'process raft request' (duration: 616.540365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.929421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.311750Z","time spent":"617.609172ms","remote":"127.0.0.1:42974","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-09T09:46:50.929548Z","caller":"traceutil/trace.go:171","msg":"trace[744254327] transaction","detail":"{read_only:false; response_revision:2780; number_of_response:1; }","duration":"617.005117ms","start":"2026-06-09T09:46:50.312519Z","end":"2026-06-09T09:46:50.929524Z","steps":["trace[744254327] 'process raft request' (duration: 615.818126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.929653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.312511Z","time spent":"617.093599ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:46:50.930518Z","caller":"traceutil/trace.go:171","msg":"trace[1226697754] linearizableReadLoop","detail":"{readStateIndex:2882; appliedIndex:2879; }","duration":"696.695115ms","start":"2026-06-09T09:46:50.233806Z","end":"2026-06-09T09:46:50.930501Z","steps":["trace[1226697754] 'read index received' (duration: 287.471742ms)","trace[1226697754] 'applied index is now lower than readState.Index' (duration: 409.222543ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:46:50.930850Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.036084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T09:46:50.930909Z","caller":"traceutil/trace.go:171","msg":"trace[1375839728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2781; }","duration":"697.094846ms","start":"2026-06-09T09:46:50.233801Z","end":"2026-06-09T09:46:50.930895Z","steps":["trace[1375839728] 'agreement among raft nodes before linearized reading' (duration: 696.973142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.930958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.233786Z","time spent":"697.161628ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:46:50.931178Z","caller":"traceutil/trace.go:171","msg":"trace[1878073949] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"495.331218ms","start":"2026-06-09T09:46:50.435831Z","end":"2026-06-09T09:46:50.931162Z","steps":["trace[1878073949] 'process raft request' (duration: 494.556428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.931260Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.435811Z","time spent":"495.410342ms","remote":"127.0.0.1:42858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T09:46:50.931492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.815071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:50.931576Z","caller":"traceutil/trace.go:171","msg":"trace[500791403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2781; }","duration":"672.902903ms","start":"2026-06-09T09:46:50.258651Z","end":"2026-06-09T09:46:50.931554Z","steps":["trace[500791403] 'agreement among raft nodes before linearized reading' (duration: 672.769659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.931619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.258639Z","time spent":"672.973184ms","remote":"127.0.0.1:42672","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-09T09:46:50.931914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.886832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" limit:1 ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-09T09:46:50.931954Z","caller":"traceutil/trace.go:171","msg":"trace[1424088098] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2781; }","duration":"148.927633ms","start":"2026-06-09T09:46:50.783016Z","end":"2026-06-09T09:46:50.931944Z","steps":["trace[1424088098] 'agreement among raft nodes before linearized reading' (duration: 148.850421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.931998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.641676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:50.932058Z","caller":"traceutil/trace.go:171","msg":"trace[738421114] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2781; }","duration":"577.702147ms","start":"2026-06-09T09:46:50.354341Z","end":"2026-06-09T09:46:50.932043Z","steps":["trace[738421114] 'agreement among raft nodes before linearized reading' (duration: 577.618255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.932109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.354331Z","time spent":"577.765509ms","remote":"127.0.0.1:42768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-06-09T09:46:50.932141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.327039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:46:50.932170Z","caller":"traceutil/trace.go:171","msg":"trace[1194890366] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2781; }","duration":"582.357619ms","start":"2026-06-09T09:46:50.349804Z","end":"2026-06-09T09:46:50.932162Z","steps":["trace[1194890366] 'agreement among raft nodes before linearized reading' (duration: 582.298788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.932221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.349791Z","time spent":"582.418051ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-09T09:46:50.932318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.967805ms","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-09T09:46:50.932371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.276092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:46:50.932372Z","caller":"traceutil/trace.go:171","msg":"trace[1052219198] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2781; }","duration":"191.021646ms","start":"2026-06-09T09:46:50.741338Z","end":"2026-06-09T09:46:50.932360Z","steps":["trace[1052219198] 'agreement among raft nodes before linearized reading' (duration: 190.951395ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:46:50.932398Z","caller":"traceutil/trace.go:171","msg":"trace[346440304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2781; }","duration":"657.300192ms","start":"2026-06-09T09:46:50.275089Z","end":"2026-06-09T09:46:50.932389Z","steps":["trace[346440304] 'agreement among raft nodes before linearized reading' (duration: 657.261782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.932431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.275083Z","time spent":"657.342934ms","remote":"127.0.0.1:42678","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-09T09:46:50.932770Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.783213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:46:50.932834Z","caller":"traceutil/trace.go:171","msg":"trace[1751974355] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2781; }","duration":"447.866144ms","start":"2026-06-09T09:46:50.484948Z","end":"2026-06-09T09:46:50.932814Z","steps":["trace[1751974355] 'agreement among raft nodes before linearized reading' (duration: 447.748751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:46:50.932895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:46:50.484928Z","time spent":"447.950448ms","remote":"127.0.0.1:43188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-09T09:49:43.896622Z","caller":"traceutil/trace.go:171","msg":"trace[295695419] linearizableReadLoop","detail":"{readStateIndex:4001; appliedIndex:4000; }","duration":"102.421953ms","start":"2026-06-09T09:49:43.794177Z","end":"2026-06-09T09:49:43.896599Z","steps":["trace[295695419] 'read index received' (duration: 102.00381ms)","trace[295695419] 'applied index is now lower than readState.Index' (duration: 417.433µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:49:43.897185Z","caller":"traceutil/trace.go:171","msg":"trace[1074820300] transaction","detail":"{read_only:false; response_revision:3849; number_of_response:1; }","duration":"111.665655ms","start":"2026-06-09T09:49:43.785501Z","end":"2026-06-09T09:49:43.897167Z","steps":["trace[1074820300] 'process raft request' (duration: 110.823878ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.897565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.496797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-09T09:49:43.897610Z","caller":"traceutil/trace.go:171","msg":"trace[1022848027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3849; }","duration":"103.553828ms","start":"2026-06-09T09:49:43.794044Z","end":"2026-06-09T09:49:43.897598Z","steps":["trace[1022848027] 'agreement among raft nodes before linearized reading' (duration: 103.459545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.897872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.730835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-09T09:49:43.897947Z","caller":"traceutil/trace.go:171","msg":"trace[9926449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3849; }","duration":"103.808087ms","start":"2026-06-09T09:49:43.794129Z","end":"2026-06-09T09:49:43.897937Z","steps":["trace[9926449] 'agreement among raft nodes before linearized reading' (duration: 103.701154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:49:43.898219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.118327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T09:49:43.898258Z","caller":"traceutil/trace.go:171","msg":"trace[2144326960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3849; }","duration":"104.160718ms","start":"2026-06-09T09:49:43.794088Z","end":"2026-06-09T09:49:43.898249Z","steps":["trace[2144326960] 'agreement among raft nodes before linearized reading' (duration: 104.090415ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:26.723865Z","caller":"traceutil/trace.go:171","msg":"trace[1737563258] linearizableReadLoop","detail":"{readStateIndex:4616; appliedIndex:4615; }","duration":"136.44618ms","start":"2026-06-09T09:50:26.587396Z","end":"2026-06-09T09:50:26.723842Z","steps":["trace[1737563258] 'read index received' (duration: 136.271515ms)","trace[1737563258] 'applied index is now lower than readState.Index' (duration: 173.735µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:26.723988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.580854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-tls\" limit:1 ","response":"range_response_count:1 size:3009"} {"level":"info","ts":"2026-06-09T09:50:26.723968Z","caller":"traceutil/trace.go:171","msg":"trace[1677565713] transaction","detail":"{read_only:false; response_revision:4437; number_of_response:1; }","duration":"182.319013ms","start":"2026-06-09T09:50:26.541608Z","end":"2026-06-09T09:50:26.723927Z","steps":["trace[1677565713] 'process raft request' (duration: 182.057055ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:26.724044Z","caller":"traceutil/trace.go:171","msg":"trace[1518239044] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:4437; }","duration":"136.646946ms","start":"2026-06-09T09:50:26.587386Z","end":"2026-06-09T09:50:26.724033Z","steps":["trace[1518239044] 'agreement among raft nodes before linearized reading' (duration: 136.556013ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:26.778211Z","caller":"traceutil/trace.go:171","msg":"trace[40660235] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4437; }","duration":"138.472586ms","start":"2026-06-09T09:50:26.639712Z","end":"2026-06-09T09:50:26.778184Z","steps":["trace[40660235] 'process raft request' (duration: 138.371902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:27.546172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.1996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:50:27.546420Z","caller":"traceutil/trace.go:171","msg":"trace[1287433960] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4448; }","duration":"139.452979ms","start":"2026-06-09T09:50:27.406945Z","end":"2026-06-09T09:50:27.546398Z","steps":["trace[1287433960] 'count revisions from in-memory index tree' (duration: 139.113927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:27.546381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.293732ms","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-09T09:50:27.546926Z","caller":"traceutil/trace.go:171","msg":"trace[150097986] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4448; }","duration":"115.874741ms","start":"2026-06-09T09:50:27.431010Z","end":"2026-06-09T09:50:27.546885Z","steps":["trace[150097986] 'range keys from in-memory index tree' (duration: 115.24012ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:35.975612Z","caller":"traceutil/trace.go:171","msg":"trace[1893785975] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"236.388499ms","start":"2026-06-09T09:50:35.739201Z","end":"2026-06-09T09:50:35.975590Z","steps":["trace[1893785975] 'process raft request' (duration: 236.247785ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.104684Z","caller":"traceutil/trace.go:171","msg":"trace[84573118] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"100.73733ms","start":"2026-06-09T09:50:42.003915Z","end":"2026-06-09T09:50:42.104652Z","steps":["trace[84573118] 'process raft request' (duration: 100.546963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:42.390394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.8759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1c0d716f-5c38-4536-be56-c7328365e1eb\" limit:1 ","response":"range_response_count:1 size:4123"} {"level":"info","ts":"2026-06-09T09:50:42.390467Z","caller":"traceutil/trace.go:171","msg":"trace[347315898] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1c0d716f-5c38-4536-be56-c7328365e1eb; range_end:; response_count:1; response_revision:4771; }","duration":"213.960282ms","start":"2026-06-09T09:50:42.176491Z","end":"2026-06-09T09:50:42.390452Z","steps":["trace[347315898] 'range keys from in-memory index tree' (duration: 213.772026ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.571209Z","caller":"traceutil/trace.go:171","msg":"trace[1545639156] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4959; }","duration":"140.296016ms","start":"2026-06-09T09:50:42.430890Z","end":"2026-06-09T09:50:42.571186Z","steps":["trace[1545639156] 'read index received' (duration: 8.162794ms)","trace[1545639156] 'applied index is now lower than readState.Index' (duration: 132.132432ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:50:42.571209Z","caller":"traceutil/trace.go:171","msg":"trace[241450394] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"175.966636ms","start":"2026-06-09T09:50:42.395220Z","end":"2026-06-09T09:50:42.571187Z","steps":["trace[241450394] 'process raft request' (duration: 175.761209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:42.571335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.43144ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:50:42.571558Z","caller":"traceutil/trace.go:171","msg":"trace[1813613708] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4774; }","duration":"140.660957ms","start":"2026-06-09T09:50:42.430882Z","end":"2026-06-09T09:50:42.571543Z","steps":["trace[1813613708] 'agreement among raft nodes before linearized reading' (duration: 140.397669ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.571375Z","caller":"traceutil/trace.go:171","msg":"trace[148501026] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"175.212942ms","start":"2026-06-09T09:50:42.396151Z","end":"2026-06-09T09:50:42.571364Z","steps":["trace[148501026] 'process raft request' (duration: 174.990465ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.614953Z","caller":"traceutil/trace.go:171","msg":"trace[888722038] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"109.296845ms","start":"2026-06-09T09:50:42.505637Z","end":"2026-06-09T09:50:42.614934Z","steps":["trace[888722038] 'process raft request' (duration: 109.192151ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.956340Z","caller":"traceutil/trace.go:171","msg":"trace[433871106] linearizableReadLoop","detail":"{readStateIndex:4964; appliedIndex:4963; }","duration":"130.293633ms","start":"2026-06-09T09:50:42.826026Z","end":"2026-06-09T09:50:42.956320Z","steps":["trace[433871106] 'read index received' (duration: 130.081946ms)","trace[433871106] 'applied index is now lower than readState.Index' (duration: 211.047µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:42.956573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.53473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" limit:1 ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-09T09:50:42.956690Z","caller":"traceutil/trace.go:171","msg":"trace[2025921173] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4776; }","duration":"130.634063ms","start":"2026-06-09T09:50:42.826007Z","end":"2026-06-09T09:50:42.956641Z","steps":["trace[2025921173] 'agreement among raft nodes before linearized reading' (duration: 130.444437ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:42.956562Z","caller":"traceutil/trace.go:171","msg":"trace[640887006] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"154.291697ms","start":"2026-06-09T09:50:42.802077Z","end":"2026-06-09T09:50:42.956369Z","steps":["trace[640887006] 'process raft request' (duration: 154.08116ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:46.049019Z","caller":"traceutil/trace.go:171","msg":"trace[809283383] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"202.974265ms","start":"2026-06-09T09:50:45.846018Z","end":"2026-06-09T09:50:46.048993Z","steps":["trace[809283383] 'process raft request' (duration: 202.796179ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:46.054922Z","caller":"traceutil/trace.go:171","msg":"trace[844984164] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"107.392888ms","start":"2026-06-09T09:50:45.947492Z","end":"2026-06-09T09:50:46.054884Z","steps":["trace[844984164] 'process raft request' (duration: 102.120548ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:50:56.751499Z","caller":"traceutil/trace.go:171","msg":"trace[2081906423] linearizableReadLoop","detail":"{readStateIndex:5156; appliedIndex:5155; }","duration":"117.831137ms","start":"2026-06-09T09:50:56.633651Z","end":"2026-06-09T09:50:56.751482Z","steps":["trace[2081906423] 'read index received' (duration: 117.747914ms)","trace[2081906423] 'applied index is now lower than readState.Index' (duration: 82.293µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:50:56.751530Z","caller":"traceutil/trace.go:171","msg":"trace[430550144] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"255.986489ms","start":"2026-06-09T09:50:56.495516Z","end":"2026-06-09T09:50:56.751503Z","steps":["trace[430550144] 'process raft request' (duration: 255.864076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:56.751631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.967681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-09T09:50:56.751658Z","caller":"traceutil/trace.go:171","msg":"trace[48699965] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4962; }","duration":"118.007822ms","start":"2026-06-09T09:50:56.633644Z","end":"2026-06-09T09:50:56.751652Z","steps":["trace[48699965] 'agreement among raft nodes before linearized reading' (duration: 117.94438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:56.751698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.805363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-09T09:50:56.751783Z","caller":"traceutil/trace.go:171","msg":"trace[1396603648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4962; }","duration":"116.926346ms","start":"2026-06-09T09:50:56.634842Z","end":"2026-06-09T09:50:56.751768Z","steps":["trace[1396603648] 'agreement among raft nodes before linearized reading' (duration: 116.769962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:57.248535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.217413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:50:57.248666Z","caller":"traceutil/trace.go:171","msg":"trace[494879162] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"487.249028ms","start":"2026-06-09T09:50:56.761392Z","end":"2026-06-09T09:50:57.248641Z","steps":["trace[494879162] 'process raft request' (duration: 119.801788ms)","trace[494879162] 'compare' (duration: 366.965264ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:57.248775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:56.761372Z","time spent":"487.343793ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:50:57.276375Z","caller":"traceutil/trace.go:171","msg":"trace[1627306212] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"514.811482ms","start":"2026-06-09T09:50:56.761547Z","end":"2026-06-09T09:50:57.276359Z","steps":["trace[1627306212] 'process raft request' (duration: 514.628436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:57.276497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:56.761523Z","time spent":"514.912624ms","remote":"127.0.0.1:42974","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-09T09:50:57.276329Z","caller":"traceutil/trace.go:171","msg":"trace[1515653014] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5157; }","duration":"315.918883ms","start":"2026-06-09T09:50:56.960392Z","end":"2026-06-09T09:50:57.276311Z","steps":["trace[1515653014] 'read index received' (duration: 315.787699ms)","trace[1515653014] 'applied index is now lower than readState.Index' (duration: 130.584µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:57.276698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.059015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" limit:1 ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-09T09:50:57.276728Z","caller":"traceutil/trace.go:171","msg":"trace[1090516495] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4964; }","duration":"228.088127ms","start":"2026-06-09T09:50:57.048631Z","end":"2026-06-09T09:50:57.276719Z","steps":["trace[1090516495] 'agreement among raft nodes before linearized reading' (duration: 228.034165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:57.276726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.299234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" limit:1 ","response":"range_response_count:1 size:18139"} {"level":"info","ts":"2026-06-09T09:50:57.276795Z","caller":"traceutil/trace.go:171","msg":"trace[476113501] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4964; }","duration":"316.391767ms","start":"2026-06-09T09:50:56.960385Z","end":"2026-06-09T09:50:57.276776Z","steps":["trace[476113501] 'agreement among raft nodes before linearized reading' (duration: 316.241293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:50:57.276844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:50:56.960362Z","time spent":"316.47051ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":18162,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" limit:1 "} {"level":"info","ts":"2026-06-09T09:50:57.444701Z","caller":"traceutil/trace.go:171","msg":"trace[2064442357] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"154.812703ms","start":"2026-06-09T09:50:57.289853Z","end":"2026-06-09T09:50:57.444665Z","steps":["trace[2064442357] 'process raft request' (duration: 125.07971ms)","trace[2064442357] 'compare' (duration: 29.486315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:50:58.383811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.234114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:50:58.383991Z","caller":"traceutil/trace.go:171","msg":"trace[1425465215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4972; }","duration":"124.41793ms","start":"2026-06-09T09:50:58.259545Z","end":"2026-06-09T09:50:58.383963Z","steps":["trace[1425465215] 'range keys from in-memory index tree' (duration: 124.141242ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:38.398373Z","caller":"traceutil/trace.go:171","msg":"trace[268199554] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"221.199658ms","start":"2026-06-09T09:51:38.177140Z","end":"2026-06-09T09:51:38.398339Z","steps":["trace[268199554] 'process raft request' (duration: 220.95903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.398482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.076584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:38.398530Z","caller":"traceutil/trace.go:171","msg":"trace[1786986676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5308; }","duration":"139.145907ms","start":"2026-06-09T09:51:38.259374Z","end":"2026-06-09T09:51:38.398520Z","steps":["trace[1786986676] 'agreement among raft nodes before linearized reading' (duration: 139.048363ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:38.398304Z","caller":"traceutil/trace.go:171","msg":"trace[1931192101] linearizableReadLoop","detail":"{readStateIndex:5511; appliedIndex:5510; }","duration":"138.890668ms","start":"2026-06-09T09:51:38.259387Z","end":"2026-06-09T09:51:38.398278Z","steps":["trace[1931192101] 'read index received' (duration: 138.769454ms)","trace[1931192101] 'applied index is now lower than readState.Index' (duration: 120.314µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:38.867789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.553522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:38.867893Z","caller":"traceutil/trace.go:171","msg":"trace[1293501236] linearizableReadLoop","detail":"{readStateIndex:5512; appliedIndex:5511; }","duration":"468.077424ms","start":"2026-06-09T09:51:38.399800Z","end":"2026-06-09T09:51:38.867877Z","steps":["trace[1293501236] 'read index received' (duration: 129.437409ms)","trace[1293501236] 'applied index is now lower than readState.Index' (duration: 338.638965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:38.868204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.367484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:38.868307Z","caller":"traceutil/trace.go:171","msg":"trace[920583084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5309; }","duration":"468.486138ms","start":"2026-06-09T09:51:38.399794Z","end":"2026-06-09T09:51:38.868281Z","steps":["trace[920583084] 'agreement among raft nodes before linearized reading' (duration: 468.299281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.868359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.399782Z","time spent":"468.566541ms","remote":"127.0.0.1:42672","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-09T09:51:38.868325Z","caller":"traceutil/trace.go:171","msg":"trace[256443214] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"479.345543ms","start":"2026-06-09T09:51:38.388702Z","end":"2026-06-09T09:51:38.868047Z","steps":["trace[256443214] 'process raft request' (duration: 140.445179ms)","trace[256443214] 'compare' (duration: 338.203671ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:38.868523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.388677Z","time spent":"479.751815ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:38.923517Z","caller":"traceutil/trace.go:171","msg":"trace[281889470] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"502.404747ms","start":"2026-06-09T09:51:38.421083Z","end":"2026-06-09T09:51:38.923488Z","steps":["trace[281889470] 'process raft request' (duration: 502.21083ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:38.923655Z","caller":"traceutil/trace.go:171","msg":"trace[1907129006] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"499.574754ms","start":"2026-06-09T09:51:38.424073Z","end":"2026-06-09T09:51:38.923648Z","steps":["trace[1907129006] 'process raft request' (duration: 499.367137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.923751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.424066Z","time spent":"499.610364ms","remote":"127.0.0.1:42974","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-09T09:51:38.923730Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.421067Z","time spent":"502.534351ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:38.923905Z","caller":"traceutil/trace.go:171","msg":"trace[165985301] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"481.841514ms","start":"2026-06-09T09:51:38.442052Z","end":"2026-06-09T09:51:38.923893Z","steps":["trace[165985301] 'process raft request' (duration: 481.795273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.923917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.970329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-09T09:51:38.923917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.147304ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:38.923943Z","caller":"traceutil/trace.go:171","msg":"trace[905352051] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5314; }","duration":"276.99657ms","start":"2026-06-09T09:51:38.646939Z","end":"2026-06-09T09:51:38.923936Z","steps":["trace[905352051] 'agreement among raft nodes before linearized reading' (duration: 276.949798ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:38.923954Z","caller":"traceutil/trace.go:171","msg":"trace[3762277] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5314; }","duration":"493.184725ms","start":"2026-06-09T09:51:38.430758Z","end":"2026-06-09T09:51:38.923943Z","steps":["trace[3762277] 'agreement among raft nodes before linearized reading' (duration: 493.123583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.923958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.442033Z","time spent":"481.895376ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:38.923976Z","caller":"traceutil/trace.go:171","msg":"trace[1697518284] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"498.331092ms","start":"2026-06-09T09:51:38.425610Z","end":"2026-06-09T09:51:38.923941Z","steps":["trace[1697518284] 'process raft request' (duration: 497.982911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.924419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.425604Z","time spent":"498.445868ms","remote":"127.0.0.1:42974","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-09T09:51:38.924774Z","caller":"traceutil/trace.go:171","msg":"trace[1442042354] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"497.784345ms","start":"2026-06-09T09:51:38.426972Z","end":"2026-06-09T09:51:38.924757Z","steps":["trace[1442042354] 'process raft request' (duration: 496.826224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:38.924969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.426964Z","time spent":"497.848578ms","remote":"127.0.0.1:42974","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-06-09T09:51:39.319280Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.351386ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:39.319425Z","caller":"traceutil/trace.go:171","msg":"trace[2136472053] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"355.197687ms","start":"2026-06-09T09:51:38.964211Z","end":"2026-06-09T09:51:39.319409Z","steps":["trace[2136472053] 'read index received' (duration: 17.537182ms)","trace[2136472053] 'applied index is now lower than readState.Index' (duration: 337.659235ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:39.319539Z","caller":"traceutil/trace.go:171","msg":"trace[1938865562] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"361.223115ms","start":"2026-06-09T09:51:38.958305Z","end":"2026-06-09T09:51:39.319528Z","steps":["trace[1938865562] 'process raft request' (duration: 23.530629ms)","trace[1938865562] 'compare' (duration: 337.095296ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:39.319601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.958261Z","time spent":"361.313248ms","remote":"127.0.0.1:42974","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-09T09:51:39.319836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.609712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:51:39.319978Z","caller":"traceutil/trace.go:171","msg":"trace[232871205] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5315; }","duration":"355.755596ms","start":"2026-06-09T09:51:38.964200Z","end":"2026-06-09T09:51:39.319955Z","steps":["trace[232871205] 'agreement among raft nodes before linearized reading' (duration: 355.306181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:39.320193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:38.964186Z","time spent":"355.991764ms","remote":"127.0.0.1:43144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-09T09:51:39.452453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.047378ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-09T09:51:39.452654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.816828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" limit:1 ","response":"range_response_count:1 size:13063"} {"level":"info","ts":"2026-06-09T09:51:39.452748Z","caller":"traceutil/trace.go:171","msg":"trace[1575795350] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5315; }","duration":"172.915632ms","start":"2026-06-09T09:51:39.279818Z","end":"2026-06-09T09:51:39.452734Z","steps":["trace[1575795350] 'agreement among raft nodes before linearized reading' (duration: 172.768776ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:39.452921Z","caller":"traceutil/trace.go:171","msg":"trace[1584300830] linearizableReadLoop","detail":"{readStateIndex:5519; appliedIndex:5518; }","duration":"133.130661ms","start":"2026-06-09T09:51:39.319452Z","end":"2026-06-09T09:51:39.452582Z","steps":["trace[1584300830] 'read index received' (duration: 55.592µs)","trace[1584300830] 'applied index is now lower than readState.Index' (duration: 133.073719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:39.453011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.357968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T09:51:39.453111Z","caller":"traceutil/trace.go:171","msg":"trace[1296329499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5315; }","duration":"193.461792ms","start":"2026-06-09T09:51:39.259630Z","end":"2026-06-09T09:51:39.453091Z","steps":["trace[1296329499] 'agreement among raft nodes before linearized reading' (duration: 193.296997ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.136134Z","caller":"traceutil/trace.go:171","msg":"trace[987267434] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"213.575573ms","start":"2026-06-09T09:51:50.922530Z","end":"2026-06-09T09:51:51.136105Z","steps":["trace[987267434] 'process raft request' (duration: 213.385967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.458199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.797487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:51.458594Z","caller":"traceutil/trace.go:171","msg":"trace[706230785] linearizableReadLoop","detail":"{readStateIndex:5610; appliedIndex:5605; }","duration":"199.599477ms","start":"2026-06-09T09:51:51.258977Z","end":"2026-06-09T09:51:51.458577Z","steps":["trace[706230785] 'read index received' (duration: 37.821µs)","trace[706230785] 'applied index is now lower than readState.Index' (duration: 199.560846ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:51.458693Z","caller":"traceutil/trace.go:171","msg":"trace[1225077612] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"478.618184ms","start":"2026-06-09T09:51:50.980064Z","end":"2026-06-09T09:51:51.458682Z","steps":["trace[1225077612] 'process raft request' (duration: 226.241369ms)","trace[1225077612] 'compare' (duration: 251.657842ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:51.458762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:50.980041Z","time spent":"478.683666ms","remote":"127.0.0.1:42974","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-09T09:51:51.458800Z","caller":"traceutil/trace.go:171","msg":"trace[855321164] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"476.911028ms","start":"2026-06-09T09:51:50.981858Z","end":"2026-06-09T09:51:51.458769Z","steps":["trace[855321164] 'process raft request' (duration: 476.523246ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.458843Z","caller":"traceutil/trace.go:171","msg":"trace[1842001709] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"460.043606ms","start":"2026-06-09T09:51:50.998776Z","end":"2026-06-09T09:51:51.458819Z","steps":["trace[1842001709] 'process raft request' (duration: 459.760217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.458923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.948719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:51:51.458934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:50.998749Z","time spent":"460.140818ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:51.458904Z","caller":"traceutil/trace.go:171","msg":"trace[871828481] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"477.092744ms","start":"2026-06-09T09:51:50.981767Z","end":"2026-06-09T09:51:51.458860Z","steps":["trace[871828481] 'process raft request' (duration: 476.543087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.458945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:50.981838Z","time spent":"477.030262ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:51.458968Z","caller":"traceutil/trace.go:171","msg":"trace[665038335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5403; }","duration":"199.99149ms","start":"2026-06-09T09:51:51.258968Z","end":"2026-06-09T09:51:51.458960Z","steps":["trace[665038335] 'agreement among raft nodes before linearized reading' (duration: 199.928167ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.459043Z","caller":"traceutil/trace.go:171","msg":"trace[893442131] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"460.373076ms","start":"2026-06-09T09:51:50.998660Z","end":"2026-06-09T09:51:51.459033Z","steps":["trace[893442131] 'process raft request' (duration: 459.769436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.459085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:50.981739Z","time spent":"477.252919ms","remote":"127.0.0.1:42974","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-06-09T09:51:51.459115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:50.998637Z","time spent":"460.446859ms","remote":"127.0.0.1:42974","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-09T09:51:51.894165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.826477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T09:51:51.894387Z","caller":"traceutil/trace.go:171","msg":"trace[1280474613] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"242.031516ms","start":"2026-06-09T09:51:51.652335Z","end":"2026-06-09T09:51:51.894366Z","steps":["trace[1280474613] 'process raft request' (duration: 241.950373ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.894683Z","caller":"traceutil/trace.go:171","msg":"trace[413765621] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"600.164275ms","start":"2026-06-09T09:51:51.294498Z","end":"2026-06-09T09:51:51.894663Z","steps":["trace[413765621] 'process raft request' (duration: 369.544652ms)","trace[413765621] 'compare' (duration: 229.684442ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:51.894782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.294471Z","time spent":"600.265088ms","remote":"127.0.0.1:42936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T09:51:51.894934Z","caller":"traceutil/trace.go:171","msg":"trace[1391595692] linearizableReadLoop","detail":"{readStateIndex:5611; appliedIndex:5610; }","duration":"436.249437ms","start":"2026-06-09T09:51:51.458643Z","end":"2026-06-09T09:51:51.894893Z","steps":["trace[1391595692] 'read index received' (duration: 205.422578ms)","trace[1391595692] 'applied index is now lower than readState.Index' (duration: 230.796058ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:51:51.894967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.196377ms","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-09T09:51:51.895020Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.254637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T09:51:51.895103Z","caller":"traceutil/trace.go:171","msg":"trace[2064842024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5405; }","duration":"505.360931ms","start":"2026-06-09T09:51:51.389725Z","end":"2026-06-09T09:51:51.895086Z","steps":["trace[2064842024] 'agreement among raft nodes before linearized reading' (duration: 505.183555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.895156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.389706Z","time spent":"505.440943ms","remote":"127.0.0.1:42974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-06-09T09:51:51.895048Z","caller":"traceutil/trace.go:171","msg":"trace[401510364] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5405; }","duration":"437.28689ms","start":"2026-06-09T09:51:51.457741Z","end":"2026-06-09T09:51:51.895028Z","steps":["trace[401510364] 'agreement among raft nodes before linearized reading' (duration: 437.164947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.895192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.95296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:51:51.895361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.026757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T09:51:51.895456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.007853ms","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":"warn","ts":"2026-06-09T09:51:51.895468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.821526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-09T09:51:51.895488Z","caller":"traceutil/trace.go:171","msg":"trace[630557184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5405; }","duration":"435.165281ms","start":"2026-06-09T09:51:51.460309Z","end":"2026-06-09T09:51:51.895474Z","steps":["trace[630557184] 'agreement among raft nodes before linearized reading' (duration: 434.985666ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.895506Z","caller":"traceutil/trace.go:171","msg":"trace[1402538802] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:5405; }","duration":"230.057314ms","start":"2026-06-09T09:51:51.665433Z","end":"2026-06-09T09:51:51.895490Z","steps":["trace[1402538802] 'agreement among raft nodes before linearized reading' (duration: 229.962642ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.895512Z","caller":"traceutil/trace.go:171","msg":"trace[1906881107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5405; }","duration":"247.866337ms","start":"2026-06-09T09:51:51.647634Z","end":"2026-06-09T09:51:51.895500Z","steps":["trace[1906881107] 'agreement among raft nodes before linearized reading' (duration: 247.791186ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:51.895582Z","caller":"traceutil/trace.go:171","msg":"trace[405412448] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5405; }","duration":"568.191708ms","start":"2026-06-09T09:51:51.327181Z","end":"2026-06-09T09:51:51.895372Z","steps":["trace[405412448] 'agreement among raft nodes before linearized reading' (duration: 567.847417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.895586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.512794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-09T09:51:51.895626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.460293Z","time spent":"435.319927ms","remote":"127.0.0.1:42672","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-09T09:51:51.895645Z","caller":"traceutil/trace.go:171","msg":"trace[1838065386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5405; }","duration":"119.573676ms","start":"2026-06-09T09:51:51.776058Z","end":"2026-06-09T09:51:51.895632Z","steps":["trace[1838065386] 'agreement among raft nodes before linearized reading' (duration: 119.328908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T09:51:51.895767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T09:51:51.327154Z","time spent":"568.482668ms","remote":"127.0.0.1:43024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T09:51:52.024696Z","caller":"traceutil/trace.go:171","msg":"trace[126049229] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"123.872537ms","start":"2026-06-09T09:51:51.900790Z","end":"2026-06-09T09:51:52.024662Z","steps":["trace[126049229] 'process raft request' (duration: 97.613877ms)","trace[126049229] 'compare' (duration: 26.003381ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:51:52.024746Z","caller":"traceutil/trace.go:171","msg":"trace[1383083070] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"123.293497ms","start":"2026-06-09T09:51:51.901425Z","end":"2026-06-09T09:51:52.024718Z","steps":["trace[1383083070] 'process raft request' (duration: 123.162323ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:51:54.465490Z","caller":"traceutil/trace.go:171","msg":"trace[1880910551] transaction","detail":"{read_only:false; response_revision:5421; number_of_response:1; }","duration":"161.934026ms","start":"2026-06-09T09:51:54.303520Z","end":"2026-06-09T09:51:54.465454Z","steps":["trace[1880910551] 'process raft request' (duration: 161.73592ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:52:10.237650Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879} {"level":"info","ts":"2026-06-09T09:52:10.343200Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":2879,"took":"104.206922ms","hash":97279635,"current-db-size-bytes":54239232,"current-db-size":"54 MB","current-db-size-in-use-bytes":29249536,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-09T09:52:10.343267Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":97279635,"revision":2879,"compact-revision":-1} {"level":"info","ts":"2026-06-09T09:53:25.970079Z","caller":"traceutil/trace.go:171","msg":"trace[2084479093] transaction","detail":"{read_only:false; response_revision:5989; number_of_response:1; }","duration":"123.478578ms","start":"2026-06-09T09:53:25.846563Z","end":"2026-06-09T09:53:25.970042Z","steps":["trace[2084479093] 'process raft request' (duration: 78.600942ms)","trace[2084479093] 'compare' (duration: 44.648718ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T09:53:25.970173Z","caller":"traceutil/trace.go:171","msg":"trace[212090096] transaction","detail":"{read_only:false; response_revision:5990; number_of_response:1; }","duration":"121.856393ms","start":"2026-06-09T09:53:25.848276Z","end":"2026-06-09T09:53:25.970132Z","steps":["trace[212090096] 'process raft request' (duration: 121.674708ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:53:25.971723Z","caller":"traceutil/trace.go:171","msg":"trace[1189550197] linearizableReadLoop","detail":"{readStateIndex:6218; appliedIndex:6214; }","duration":"120.341974ms","start":"2026-06-09T09:53:25.851339Z","end":"2026-06-09T09:53:25.971681Z","steps":["trace[1189550197] 'read index received' (duration: 682.073µs)","trace[1189550197] 'applied index is now lower than readState.Index' (duration: 119.658741ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:53:25.971936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.579362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" limit:1 ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-06-09T09:53:25.971981Z","caller":"traceutil/trace.go:171","msg":"trace[1141372278] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5991; }","duration":"120.635463ms","start":"2026-06-09T09:53:25.851334Z","end":"2026-06-09T09:53:25.971970Z","steps":["trace[1141372278] 'agreement among raft nodes before linearized reading' (duration: 120.459808ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:53:25.972070Z","caller":"traceutil/trace.go:171","msg":"trace[1072880829] transaction","detail":"{read_only:false; response_revision:5991; number_of_response:1; }","duration":"121.912555ms","start":"2026-06-09T09:53:25.850147Z","end":"2026-06-09T09:53:25.972060Z","steps":["trace[1072880829] 'process raft request' (duration: 119.92531ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:54:01.221874Z","caller":"traceutil/trace.go:171","msg":"trace[1018933698] linearizableReadLoop","detail":"{readStateIndex:6442; appliedIndex:6441; }","duration":"111.19444ms","start":"2026-06-09T09:54:01.110656Z","end":"2026-06-09T09:54:01.221851Z","steps":["trace[1018933698] 'read index received' (duration: 111.021515ms)","trace[1018933698] 'applied index is now lower than readState.Index' (duration: 172.025µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T09:54:01.222140Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.467069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T09:54:01.222179Z","caller":"traceutil/trace.go:171","msg":"trace[843509469] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:6207; }","duration":"111.51702ms","start":"2026-06-09T09:54:01.110652Z","end":"2026-06-09T09:54:01.222169Z","steps":["trace[843509469] 'agreement among raft nodes before linearized reading' (duration: 111.373016ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:54:01.222519Z","caller":"traceutil/trace.go:171","msg":"trace[1574829316] transaction","detail":"{read_only:false; response_revision:6207; number_of_response:1; }","duration":"139.733176ms","start":"2026-06-09T09:54:01.082774Z","end":"2026-06-09T09:54:01.222507Z","steps":["trace[1574829316] 'process raft request' (duration: 138.960441ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:55:02.798293Z","caller":"traceutil/trace.go:171","msg":"trace[1842825502] transaction","detail":"{read_only:false; response_revision:6738; number_of_response:1; }","duration":"296.512498ms","start":"2026-06-09T09:55:02.501764Z","end":"2026-06-09T09:55:02.798276Z","steps":["trace[1842825502] 'process raft request' (duration: 296.483797ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:55:02.798581Z","caller":"traceutil/trace.go:171","msg":"trace[1195289978] transaction","detail":"{read_only:false; response_revision:6737; number_of_response:1; }","duration":"297.892763ms","start":"2026-06-09T09:55:02.500679Z","end":"2026-06-09T09:55:02.798572Z","steps":["trace[1195289978] 'process raft request' (duration: 297.485461ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T09:57:10.245421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5558} {"level":"info","ts":"2026-06-09T09:57:10.320332Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":5558,"took":"73.193734ms","hash":2079897180,"current-db-size-bytes":54239232,"current-db-size":"54 MB","current-db-size-in-use-bytes":18411520,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T09:57:10.320382Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":2079897180,"revision":5558,"compact-revision":2879}