{"level":"warn","ts":"2026-06-18T14:59:36.101158Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T14:59:36.10124Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.75:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.75:2380","--initial-cluster=instance=https://199.19.213.75:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.75:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.75: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-18T14:59:36.101299Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T14:59:36.101308Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.75:2380"]} {"level":"info","ts":"2026-06-18T14:59:36.101374Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-18T14:59:36.102214Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.75:2379"]} {"level":"info","ts":"2026-06-18T14:59:36.102372Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.75:2380"],"listen-peer-urls":["https://199.19.213.75:2380"],"advertise-client-urls":["https://199.19.213.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.75: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-18T14:59:36.106814Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.138059ms"} {"level":"info","ts":"2026-06-18T14:59:36.11259Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"42c325ad8bcf8012","cluster-id":"1e2ab336c559df5e"} {"level":"info","ts":"2026-06-18T14:59:36.11288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 switched to configuration voters=()"} {"level":"info","ts":"2026-06-18T14:59:36.112922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 became follower at term 0"} {"level":"info","ts":"2026-06-18T14:59:36.113015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 42c325ad8bcf8012 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-18T14:59:36.113028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 became follower at term 1"} {"level":"info","ts":"2026-06-18T14:59:36.113162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 switched to configuration voters=(4810730254267023378)"} {"level":"warn","ts":"2026-06-18T14:59:36.119349Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-18T14:59:36.121207Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-18T14:59:36.122573Z","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-18T14:59:36.124406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"42c325ad8bcf8012","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-18T14:59:36.12659Z","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-18T14:59:36.127164Z","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-18T14:59:36.127177Z","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-18T14:59:36.127279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 switched to configuration voters=(4810730254267023378)"} {"level":"info","ts":"2026-06-18T14:59:36.127471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1e2ab336c559df5e","local-member-id":"42c325ad8bcf8012","added-peer-id":"42c325ad8bcf8012","added-peer-peer-urls":["https://199.19.213.75:2380"]} {"level":"info","ts":"2026-06-18T14:59:36.126011Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"42c325ad8bcf8012","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-18T14:59:36.140213Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-18T14:59:36.140397Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.75:2380"} {"level":"info","ts":"2026-06-18T14:59:36.14046Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.75:2380"} {"level":"info","ts":"2026-06-18T14:59:36.147271Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"42c325ad8bcf8012","initial-advertise-peer-urls":["https://199.19.213.75:2380"],"listen-peer-urls":["https://199.19.213.75:2380"],"advertise-client-urls":["https://199.19.213.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-18T14:59:36.147343Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-18T14:59:36.51385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 is starting a new election at term 1"} {"level":"info","ts":"2026-06-18T14:59:36.513921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-18T14:59:36.513944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 received MsgPreVoteResp from 42c325ad8bcf8012 at term 1"} {"level":"info","ts":"2026-06-18T14:59:36.513964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 became candidate at term 2"} {"level":"info","ts":"2026-06-18T14:59:36.513976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 received MsgVoteResp from 42c325ad8bcf8012 at term 2"} {"level":"info","ts":"2026-06-18T14:59:36.513993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"42c325ad8bcf8012 became leader at term 2"} {"level":"info","ts":"2026-06-18T14:59:36.514008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 42c325ad8bcf8012 elected leader 42c325ad8bcf8012 at term 2"} {"level":"info","ts":"2026-06-18T14:59:36.642639Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T14:59:36.643177Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T14:59:36.643522Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-18T14:59:36.643561Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-18T14:59:36.643829Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T14:59:36.643154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"42c325ad8bcf8012","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.75:2379]}","request-path":"/0/members/42c325ad8bcf8012/attributes","cluster-id":"1e2ab336c559df5e","publish-timeout":"7s"} {"level":"info","ts":"2026-06-18T14:59:36.645543Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-18T14:59:36.645585Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.75:2379"} {"level":"info","ts":"2026-06-18T14:59:36.776551Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1e2ab336c559df5e","local-member-id":"42c325ad8bcf8012","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T14:59:36.776682Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T14:59:36.776735Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-18T14:59:36.933104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.59183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-18T14:59:36.933525Z","caller":"traceutil/trace.go:171","msg":"trace[636004871] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"101.959304ms","start":"2026-06-18T14:59:36.83128Z","end":"2026-06-18T14:59:36.933239Z","steps":["trace[636004871] 'count revisions from in-memory index tree' (duration: 101.497639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T14:59:36.934273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.794138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-18T14:59:36.934317Z","caller":"traceutil/trace.go:171","msg":"trace[1742111868] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"115.859438ms","start":"2026-06-18T14:59:36.818446Z","end":"2026-06-18T14:59:36.934305Z","steps":["trace[1742111868] 'count revisions from in-memory index tree' (duration: 115.747877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T14:59:36.934338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.054745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-18T14:59:36.934412Z","caller":"traceutil/trace.go:171","msg":"trace[2116047849] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"103.177916ms","start":"2026-06-18T14:59:36.831218Z","end":"2026-06-18T14:59:36.934396Z","steps":["trace[2116047849] 'range keys from in-memory index tree' (duration: 102.996524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T14:59:36.93455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.890129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-18T14:59:36.934588Z","caller":"traceutil/trace.go:171","msg":"trace[1898994417] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"115.930259ms","start":"2026-06-18T14:59:36.818646Z","end":"2026-06-18T14:59:36.934577Z","steps":["trace[1898994417] 'range keys from in-memory index tree' (duration: 115.796478ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:00:13.632064Z","caller":"traceutil/trace.go:171","msg":"trace[1448902376] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"112.961928ms","start":"2026-06-18T15:00:13.519083Z","end":"2026-06-18T15:00:13.632045Z","steps":["trace[1448902376] 'process raft request' (duration: 108.05053ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:00:13.632325Z","caller":"traceutil/trace.go:171","msg":"trace[1106937799] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"113.041217ms","start":"2026-06-18T15:00:13.519254Z","end":"2026-06-18T15:00:13.632295Z","steps":["trace[1106937799] 'process raft request' (duration: 112.15355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:00:14.583128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.91554ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:00:14.583341Z","caller":"traceutil/trace.go:171","msg":"trace[1662720105] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"302.436904ms","start":"2026-06-18T15:00:14.280873Z","end":"2026-06-18T15:00:14.58331Z","steps":["trace[1662720105] 'process raft request' (duration: 150.92577ms)","trace[1662720105] 'compare' (duration: 150.792589ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:00:14.583453Z","caller":"traceutil/trace.go:171","msg":"trace[36136841] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"292.64786ms","start":"2026-06-18T15:00:14.290786Z","end":"2026-06-18T15:00:14.583434Z","steps":["trace[36136841] 'process raft request' (duration: 292.435369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:00:14.583481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:00:14.280847Z","time spent":"302.561475ms","remote":"127.0.0.1:48334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:00:14.583953Z","caller":"traceutil/trace.go:171","msg":"trace[802141575] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:567; }","duration":"290.704126ms","start":"2026-06-18T15:00:14.293241Z","end":"2026-06-18T15:00:14.583945Z","steps":["trace[802141575] 'read index received' (duration: 138.578596ms)","trace[802141575] 'applied index is now lower than readState.Index' (duration: 152.1248ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:00:14.584133Z","caller":"traceutil/trace.go:171","msg":"trace[722279710] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"178.74837ms","start":"2026-06-18T15:00:14.405374Z","end":"2026-06-18T15:00:14.584122Z","steps":["trace[722279710] 'process raft request' (duration: 178.409427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:00:14.584134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.880437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-18T15:00:14.584202Z","caller":"traceutil/trace.go:171","msg":"trace[1291677626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"290.972508ms","start":"2026-06-18T15:00:14.293211Z","end":"2026-06-18T15:00:14.584184Z","steps":["trace[1291677626] 'agreement among raft nodes before linearized reading' (duration: 290.841437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:00:14.584221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.734488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-18T15:00:14.584248Z","caller":"traceutil/trace.go:171","msg":"trace[1705433759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"285.772708ms","start":"2026-06-18T15:00:14.298468Z","end":"2026-06-18T15:00:14.58424Z","steps":["trace[1705433759] 'agreement among raft nodes before linearized reading' (duration: 285.718208ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:00:20.277384Z","caller":"traceutil/trace.go:171","msg":"trace[1433681571] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"156.951605ms","start":"2026-06-18T15:00:20.12038Z","end":"2026-06-18T15:00:20.277332Z","steps":["trace[1433681571] 'process raft request' (duration: 156.409318ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:00:20.870159Z","caller":"traceutil/trace.go:171","msg":"trace[388528353] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"212.176117ms","start":"2026-06-18T15:00:20.657932Z","end":"2026-06-18T15:00:20.870108Z","steps":["trace[388528353] 'process raft request' (duration: 193.511355ms)","trace[388528353] 'compare' (duration: 18.29704ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:00:20.870404Z","caller":"traceutil/trace.go:171","msg":"trace[617201752] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"167.004548ms","start":"2026-06-18T15:00:20.703388Z","end":"2026-06-18T15:00:20.870393Z","steps":["trace[617201752] 'read index received' (duration: 148.100979ms)","trace[617201752] 'applied index is now lower than readState.Index' (duration: 18.902109ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:00:20.87054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.147003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9x5x2\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-18T15:00:20.870568Z","caller":"traceutil/trace.go:171","msg":"trace[1403209593] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9x5x2; range_end:; response_count:1; response_revision:597; }","duration":"167.232136ms","start":"2026-06-18T15:00:20.703327Z","end":"2026-06-18T15:00:20.870559Z","steps":["trace[1403209593] 'agreement among raft nodes before linearized reading' (duration: 167.140753ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:00:20.872876Z","caller":"traceutil/trace.go:171","msg":"trace[71607579] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"111.418784ms","start":"2026-06-18T15:00:20.761271Z","end":"2026-06-18T15:00:20.872689Z","steps":["trace[71607579] 'process raft request' (duration: 109.730462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:00:20.873109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.746738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-18T15:00:20.873204Z","caller":"traceutil/trace.go:171","msg":"trace[1168972442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"121.871522ms","start":"2026-06-18T15:00:20.751297Z","end":"2026-06-18T15:00:20.873169Z","steps":["trace[1168972442] 'agreement among raft nodes before linearized reading' (duration: 121.150639ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.319153Z","caller":"traceutil/trace.go:171","msg":"trace[1140365371] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1917; }","duration":"131.897622ms","start":"2026-06-18T15:01:55.187235Z","end":"2026-06-18T15:01:55.319132Z","steps":["trace[1140365371] 'read index received' (duration: 131.7265ms)","trace[1140365371] 'applied index is now lower than readState.Index' (duration: 169.912µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:01:55.319191Z","caller":"traceutil/trace.go:171","msg":"trace[210131399] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"206.192074ms","start":"2026-06-18T15:01:55.112976Z","end":"2026-06-18T15:01:55.319168Z","steps":["trace[210131399] 'process raft request' (duration: 206.001161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:01:55.319374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.113085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0592f5d0-a820-477d-a6a9-d34022746bfe\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-18T15:01:55.31942Z","caller":"traceutil/trace.go:171","msg":"trace[1799400911] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0592f5d0-a820-477d-a6a9-d34022746bfe; range_end:; response_count:1; response_revision:1850; }","duration":"132.203326ms","start":"2026-06-18T15:01:55.187204Z","end":"2026-06-18T15:01:55.319407Z","steps":["trace[1799400911] 'agreement among raft nodes before linearized reading' (duration: 132.032883ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.4088Z","caller":"traceutil/trace.go:171","msg":"trace[1818174856] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"160.251191ms","start":"2026-06-18T15:01:55.248513Z","end":"2026-06-18T15:01:55.408764Z","steps":["trace[1818174856] 'process raft request' (duration: 160.063278ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.409012Z","caller":"traceutil/trace.go:171","msg":"trace[1625653681] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"121.172507ms","start":"2026-06-18T15:01:55.28783Z","end":"2026-06-18T15:01:55.409002Z","steps":["trace[1625653681] 'process raft request' (duration: 120.893223ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.663584Z","caller":"traceutil/trace.go:171","msg":"trace[216043443] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1920; }","duration":"239.635996ms","start":"2026-06-18T15:01:55.423925Z","end":"2026-06-18T15:01:55.663561Z","steps":["trace[216043443] 'read index received' (duration: 170.070303ms)","trace[216043443] 'applied index is now lower than readState.Index' (duration: 69.564663ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:01:55.663779Z","caller":"traceutil/trace.go:171","msg":"trace[1810013344] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"337.313985ms","start":"2026-06-18T15:01:55.326451Z","end":"2026-06-18T15:01:55.663765Z","steps":["trace[1810013344] 'process raft request' (duration: 267.524699ms)","trace[1810013344] 'compare' (duration: 69.180388ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:01:55.663765Z","caller":"traceutil/trace.go:171","msg":"trace[228135479] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"243.062055ms","start":"2026-06-18T15:01:55.420686Z","end":"2026-06-18T15:01:55.663748Z","steps":["trace[228135479] 'process raft request' (duration: 242.795061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:01:55.663894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:01:55.326424Z","time spent":"337.393616ms","remote":"127.0.0.1:48486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:01:55.664038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.245959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0592f5d0-a820-477d-a6a9-d34022746bfe\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-06-18T15:01:55.664077Z","caller":"traceutil/trace.go:171","msg":"trace[852712787] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0592f5d0-a820-477d-a6a9-d34022746bfe; range_end:; response_count:1; response_revision:1854; }","duration":"139.33378ms","start":"2026-06-18T15:01:55.524734Z","end":"2026-06-18T15:01:55.664068Z","steps":["trace[852712787] 'agreement among raft nodes before linearized reading' (duration: 139.256379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:01:55.664098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.653283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:01:55.664179Z","caller":"traceutil/trace.go:171","msg":"trace[1418408084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1854; }","duration":"168.770174ms","start":"2026-06-18T15:01:55.495392Z","end":"2026-06-18T15:01:55.664162Z","steps":["trace[1418408084] 'agreement among raft nodes before linearized reading' (duration: 168.653012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:01:55.664204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.28469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-18T15:01:55.664281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.350026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-18T15:01:55.664318Z","caller":"traceutil/trace.go:171","msg":"trace[746619822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1854; }","duration":"240.404897ms","start":"2026-06-18T15:01:55.423901Z","end":"2026-06-18T15:01:55.664306Z","steps":["trace[746619822] 'agreement among raft nodes before linearized reading' (duration: 240.289235ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.664343Z","caller":"traceutil/trace.go:171","msg":"trace[1690713498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1854; }","duration":"239.406212ms","start":"2026-06-18T15:01:55.424894Z","end":"2026-06-18T15:01:55.6643Z","steps":["trace[1690713498] 'agreement among raft nodes before linearized reading' (duration: 239.064727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:01:55.939684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.600142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:01:55.939897Z","caller":"traceutil/trace.go:171","msg":"trace[878863797] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"171.2873ms","start":"2026-06-18T15:01:55.768586Z","end":"2026-06-18T15:01:55.939873Z","steps":["trace[878863797] 'process raft request' (duration: 171.216419ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:01:55.940013Z","caller":"traceutil/trace.go:171","msg":"trace[1161861598] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"270.122335ms","start":"2026-06-18T15:01:55.66979Z","end":"2026-06-18T15:01:55.939913Z","steps":["trace[1161861598] 'process raft request' (duration: 155.198828ms)","trace[1161861598] 'compare' (duration: 114.478691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:02:11.240443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.995535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-18T15:02:11.240522Z","caller":"traceutil/trace.go:171","msg":"trace[1604780353] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1982; }","duration":"121.116216ms","start":"2026-06-18T15:02:11.119387Z","end":"2026-06-18T15:02:11.240503Z","steps":["trace[1604780353] 'range keys from in-memory index tree' (duration: 120.848702ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:02:33.630648Z","caller":"traceutil/trace.go:171","msg":"trace[1621739767] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"107.742229ms","start":"2026-06-18T15:02:33.52287Z","end":"2026-06-18T15:02:33.630612Z","steps":["trace[1621739767] 'process raft request' (duration: 107.587218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:02:34.747861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.166057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:02:34.748568Z","caller":"traceutil/trace.go:171","msg":"trace[2123986221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"252.921425ms","start":"2026-06-18T15:02:34.495623Z","end":"2026-06-18T15:02:34.748544Z","steps":["trace[2123986221] 'range keys from in-memory index tree' (duration: 252.082206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:02:34.748141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.688196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:02:34.749006Z","caller":"traceutil/trace.go:171","msg":"trace[1100015340] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"251.255675ms","start":"2026-06-18T15:02:34.497714Z","end":"2026-06-18T15:02:34.74897Z","steps":["trace[1100015340] 'process raft request' (duration: 109.636808ms)","trace[1100015340] 'compare' (duration: 140.515504ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:02:34.749245Z","caller":"traceutil/trace.go:171","msg":"trace[901211693] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2191; }","duration":"199.857918ms","start":"2026-06-18T15:02:34.549245Z","end":"2026-06-18T15:02:34.749103Z","steps":["trace[901211693] 'read index received' (duration: 58.029198ms)","trace[901211693] 'applied index is now lower than readState.Index' (duration: 141.82573ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:02:34.749634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.382884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:02:34.74979Z","caller":"traceutil/trace.go:171","msg":"trace[38251809] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2117; }","duration":"200.495205ms","start":"2026-06-18T15:02:34.549195Z","end":"2026-06-18T15:02:34.74969Z","steps":["trace[38251809] 'agreement among raft nodes before linearized reading' (duration: 200.119861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:02:35.017239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.645912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:02:35.017386Z","caller":"traceutil/trace.go:171","msg":"trace[394768141] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"188.889304ms","start":"2026-06-18T15:02:34.828476Z","end":"2026-06-18T15:02:35.017366Z","steps":["trace[394768141] 'process raft request' (duration: 54.02346ms)","trace[394768141] 'compare' (duration: 134.52111ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:03:26.441384Z","caller":"traceutil/trace.go:171","msg":"trace[1880369951] linearizableReadLoop","detail":"{readStateIndex:2589; appliedIndex:2588; }","duration":"124.80549ms","start":"2026-06-18T15:03:26.316555Z","end":"2026-06-18T15:03:26.44136Z","steps":["trace[1880369951] 'read index received' (duration: 124.672849ms)","trace[1880369951] 'applied index is now lower than readState.Index' (duration: 131.861µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:03:26.441509Z","caller":"traceutil/trace.go:171","msg":"trace[1846587744] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"168.777032ms","start":"2026-06-18T15:03:26.27271Z","end":"2026-06-18T15:03:26.441487Z","steps":["trace[1846587744] 'process raft request' (duration: 168.512509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:03:26.441587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.018042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:03:26.441627Z","caller":"traceutil/trace.go:171","msg":"trace[2026953639] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2501; }","duration":"125.103753ms","start":"2026-06-18T15:03:26.316514Z","end":"2026-06-18T15:03:26.441617Z","steps":["trace[2026953639] 'agreement among raft nodes before linearized reading' (duration: 124.951442ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:03:59.706846Z","caller":"traceutil/trace.go:171","msg":"trace[1329615105] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"140.087028ms","start":"2026-06-18T15:03:59.566701Z","end":"2026-06-18T15:03:59.706788Z","steps":["trace[1329615105] 'process raft request' (duration: 139.169628ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:04:00.742674Z","caller":"traceutil/trace.go:171","msg":"trace[357146294] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"184.40012ms","start":"2026-06-18T15:04:00.558242Z","end":"2026-06-18T15:04:00.742643Z","steps":["trace[357146294] 'process raft request' (duration: 184.180558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:01.174254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.948296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:04:01.174427Z","caller":"traceutil/trace.go:171","msg":"trace[914828430] linearizableReadLoop","detail":"{readStateIndex:2788; appliedIndex:2787; }","duration":"363.692658ms","start":"2026-06-18T15:04:00.810705Z","end":"2026-06-18T15:04:01.174398Z","steps":["trace[914828430] 'read index received' (duration: 17.444129ms)","trace[914828430] 'applied index is now lower than readState.Index' (duration: 346.246479ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:04:01.174443Z","caller":"traceutil/trace.go:171","msg":"trace[347386111] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"426.25225ms","start":"2026-06-18T15:04:00.748167Z","end":"2026-06-18T15:04:01.174419Z","steps":["trace[347386111] 'process raft request' (duration: 80.053371ms)","trace[347386111] 'compare' (duration: 345.786384ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:04:01.174618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:00.748145Z","time spent":"426.386361ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:04:01.175719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.011391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-18T15:04:01.175776Z","caller":"traceutil/trace.go:171","msg":"trace[1994610889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2692; }","duration":"365.106322ms","start":"2026-06-18T15:04:00.810655Z","end":"2026-06-18T15:04:01.175762Z","steps":["trace[1994610889] 'agreement among raft nodes before linearized reading' (duration: 363.820359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:01.175819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:00.810636Z","time spent":"365.174333ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-18T15:04:01.81667Z","caller":"traceutil/trace.go:171","msg":"trace[521891648] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"102.758143ms","start":"2026-06-18T15:04:01.713887Z","end":"2026-06-18T15:04:01.816646Z","steps":["trace[521891648] 'process raft request' (duration: 102.002476ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:04:02.247556Z","caller":"traceutil/trace.go:171","msg":"trace[707213240] linearizableReadLoop","detail":"{readStateIndex:2791; appliedIndex:2790; }","duration":"202.410812ms","start":"2026-06-18T15:04:02.045124Z","end":"2026-06-18T15:04:02.247535Z","steps":["trace[707213240] 'read index received' (duration: 202.350901ms)","trace[707213240] 'applied index is now lower than readState.Index' (duration: 59.141µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:04:02.247866Z","caller":"traceutil/trace.go:171","msg":"trace[1865612778] transaction","detail":"{read_only:false; response_revision:2695; number_of_response:1; }","duration":"213.86136ms","start":"2026-06-18T15:04:02.033966Z","end":"2026-06-18T15:04:02.247827Z","steps":["trace[1865612778] 'process raft request' (duration: 213.385235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.247896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.756456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-18T15:04:02.248157Z","caller":"traceutil/trace.go:171","msg":"trace[2060597295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2695; }","duration":"203.003178ms","start":"2026-06-18T15:04:02.045084Z","end":"2026-06-18T15:04:02.248088Z","steps":["trace[2060597295] 'agreement among raft nodes before linearized reading' (duration: 202.696265ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:04:02.607552Z","caller":"traceutil/trace.go:171","msg":"trace[1421924119] linearizableReadLoop","detail":"{readStateIndex:2793; appliedIndex:2791; }","duration":"359.895183ms","start":"2026-06-18T15:04:02.247611Z","end":"2026-06-18T15:04:02.607506Z","steps":["trace[1421924119] 'read index received' (duration: 358.617311ms)","trace[1421924119] 'applied index is now lower than readState.Index' (duration: 1.276512ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:04:02.60769Z","caller":"traceutil/trace.go:171","msg":"trace[951423938] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"557.391086ms","start":"2026-06-18T15:04:02.050271Z","end":"2026-06-18T15:04:02.607662Z","steps":["trace[951423938] 'process raft request' (duration: 556.001132ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:04:02.607903Z","caller":"traceutil/trace.go:171","msg":"trace[575899227] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"501.254001ms","start":"2026-06-18T15:04:02.106621Z","end":"2026-06-18T15:04:02.607875Z","steps":["trace[575899227] 'process raft request' (duration: 500.805297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.608041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.578215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-06-18T15:04:02.608842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:02.106602Z","time spent":"502.153581ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:04:02.608906Z","caller":"traceutil/trace.go:171","msg":"trace[1616914342] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2697; }","duration":"551.490255ms","start":"2026-06-18T15:04:02.057397Z","end":"2026-06-18T15:04:02.608888Z","steps":["trace[1616914342] 'agreement among raft nodes before linearized reading' (duration: 550.440204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.608926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:02.05025Z","time spent":"558.380787ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:04:02.609006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:02.057384Z","time spent":"551.597546ms","remote":"127.0.0.1:48502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-18T15:04:02.608192Z","caller":"traceutil/trace.go:171","msg":"trace[963618025] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"356.845773ms","start":"2026-06-18T15:04:02.25133Z","end":"2026-06-18T15:04:02.608175Z","steps":["trace[963618025] 'process raft request' (duration: 356.753272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.609265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:02.251312Z","time spent":"357.912184ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:04:02.608303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.874329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:04:02.609486Z","caller":"traceutil/trace.go:171","msg":"trace[444589577] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2698; }","duration":"557.079883ms","start":"2026-06-18T15:04:02.052382Z","end":"2026-06-18T15:04:02.609462Z","steps":["trace[444589577] 'agreement among raft nodes before linearized reading' (duration: 555.801559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.609559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:04:02.052369Z","time spent":"557.174454ms","remote":"127.0.0.1:48788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-18T15:04:02.608407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.128818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:04:02.609688Z","caller":"traceutil/trace.go:171","msg":"trace[1277461143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2698; }","duration":"114.439712ms","start":"2026-06-18T15:04:02.495211Z","end":"2026-06-18T15:04:02.609651Z","steps":["trace[1277461143] 'agreement among raft nodes before linearized reading' (duration: 113.145268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.608491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.095015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:04:02.610055Z","caller":"traceutil/trace.go:171","msg":"trace[1643949614] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2698; }","duration":"231.560951ms","start":"2026-06-18T15:04:02.378305Z","end":"2026-06-18T15:04:02.609866Z","steps":["trace[1643949614] 'agreement among raft nodes before linearized reading' (duration: 230.135276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.608554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.876298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-18T15:04:02.610236Z","caller":"traceutil/trace.go:171","msg":"trace[2102499185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2698; }","duration":"245.597834ms","start":"2026-06-18T15:04:02.364626Z","end":"2026-06-18T15:04:02.610224Z","steps":["trace[2102499185] 'agreement among raft nodes before linearized reading' (duration: 243.824826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:04:02.608537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.265733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ba3520bf78bab0\" ","response":"range_response_count:1 size:780"} {"level":"info","ts":"2026-06-18T15:04:02.610389Z","caller":"traceutil/trace.go:171","msg":"trace[798261184] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ba3520bf78bab0; range_end:; response_count:1; response_revision:2698; }","duration":"259.152823ms","start":"2026-06-18T15:04:02.35122Z","end":"2026-06-18T15:04:02.610373Z","steps":["trace[798261184] 'agreement among raft nodes before linearized reading' (duration: 257.119472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:31.455559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.368998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/alertmanager-tls\" ","response":"range_response_count:1 size:2872"} {"level":"info","ts":"2026-06-18T15:07:31.455654Z","caller":"traceutil/trace.go:171","msg":"trace[1261985414] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/alertmanager-tls; range_end:; response_count:1; response_revision:4297; }","duration":"111.497581ms","start":"2026-06-18T15:07:31.344127Z","end":"2026-06-18T15:07:31.455624Z","steps":["trace[1261985414] 'range keys from in-memory index tree' (duration: 111.276306ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:36.004236Z","caller":"traceutil/trace.go:171","msg":"trace[1966248057] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4440; }","duration":"106.264584ms","start":"2026-06-18T15:07:35.897948Z","end":"2026-06-18T15:07:36.004213Z","steps":["trace[1966248057] 'compare' (duration: 95.390848ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.396943Z","caller":"traceutil/trace.go:171","msg":"trace[2025620764] linearizableReadLoop","detail":"{readStateIndex:4698; appliedIndex:4697; }","duration":"253.120606ms","start":"2026-06-18T15:07:40.143797Z","end":"2026-06-18T15:07:40.396917Z","steps":["trace[2025620764] 'read index received' (duration: 252.899172ms)","trace[2025620764] 'applied index is now lower than readState.Index' (duration: 220.304µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:40.397107Z","caller":"traceutil/trace.go:171","msg":"trace[779562270] transaction","detail":"{read_only:false; response_revision:4531; number_of_response:1; }","duration":"254.574546ms","start":"2026-06-18T15:07:40.142409Z","end":"2026-06-18T15:07:40.396983Z","steps":["trace[779562270] 'process raft request' (duration: 254.334681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:40.397204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.384541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"warn","ts":"2026-06-18T15:07:40.397679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.329008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:07:40.397834Z","caller":"traceutil/trace.go:171","msg":"trace[21148873] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4531; }","duration":"254.029805ms","start":"2026-06-18T15:07:40.143747Z","end":"2026-06-18T15:07:40.397777Z","steps":["trace[21148873] 'agreement among raft nodes before linearized reading' (duration: 253.31457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:40.397558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.902248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-18T15:07:40.398219Z","caller":"traceutil/trace.go:171","msg":"trace[1225563027] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4531; }","duration":"216.616792ms","start":"2026-06-18T15:07:40.181574Z","end":"2026-06-18T15:07:40.398191Z","steps":["trace[1225563027] 'agreement among raft nodes before linearized reading' (duration: 215.651703ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.39787Z","caller":"traceutil/trace.go:171","msg":"trace[564034716] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:4531; }","duration":"250.576054ms","start":"2026-06-18T15:07:40.147209Z","end":"2026-06-18T15:07:40.397785Z","steps":["trace[564034716] 'agreement among raft nodes before linearized reading' (duration: 249.965181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:40.398254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-18T15:07:40.398886Z","caller":"traceutil/trace.go:171","msg":"trace[586423169] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4531; }","duration":"166.346814ms","start":"2026-06-18T15:07:40.232519Z","end":"2026-06-18T15:07:40.398866Z","steps":["trace[586423169] 'agreement among raft nodes before linearized reading' (duration: 164.69749ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:40.403005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.292526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-18T15:07:40.40326Z","caller":"traceutil/trace.go:171","msg":"trace[912362032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4531; }","duration":"109.591152ms","start":"2026-06-18T15:07:40.293645Z","end":"2026-06-18T15:07:40.403236Z","steps":["trace[912362032] 'agreement among raft nodes before linearized reading' (duration: 104.014617ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:47.057643Z","caller":"traceutil/trace.go:171","msg":"trace[760766558] linearizableReadLoop","detail":"{readStateIndex:4817; appliedIndex:4816; }","duration":"144.559482ms","start":"2026-06-18T15:07:46.913055Z","end":"2026-06-18T15:07:47.057615Z","steps":["trace[760766558] 'read index received' (duration: 144.41915ms)","trace[760766558] 'applied index is now lower than readState.Index' (duration: 139.372µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:47.057714Z","caller":"traceutil/trace.go:171","msg":"trace[1203929268] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"205.622214ms","start":"2026-06-18T15:07:46.852052Z","end":"2026-06-18T15:07:47.057674Z","steps":["trace[1203929268] 'process raft request' (duration: 205.409259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.05804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.956521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aba54d6f-5520-457b-91af-35d0335c6e42\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-18T15:07:47.058121Z","caller":"traceutil/trace.go:171","msg":"trace[1484828783] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aba54d6f-5520-457b-91af-35d0335c6e42; range_end:; response_count:1; response_revision:4649; }","duration":"145.084913ms","start":"2026-06-18T15:07:46.913017Z","end":"2026-06-18T15:07:47.058102Z","steps":["trace[1484828783] 'agreement among raft nodes before linearized reading' (duration: 144.736876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.417862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.067135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:07:47.417982Z","caller":"traceutil/trace.go:171","msg":"trace[201511314] linearizableReadLoop","detail":"{readStateIndex:4818; appliedIndex:4817; }","duration":"360.257041ms","start":"2026-06-18T15:07:47.057709Z","end":"2026-06-18T15:07:47.417966Z","steps":["trace[201511314] 'read index received' (duration: 156.968211ms)","trace[201511314] 'applied index is now lower than readState.Index' (duration: 203.28526ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:47.418145Z","caller":"traceutil/trace.go:171","msg":"trace[2062561609] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"388.85598ms","start":"2026-06-18T15:07:47.029203Z","end":"2026-06-18T15:07:47.418059Z","steps":["trace[2062561609] 'process raft request' (duration: 185.514779ms)","trace[2062561609] 'compare' (duration: 202.961423ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:07:47.418212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.779042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6bc5d4567f-jp56t.18ba355a9e899ad1\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-18T15:07:47.418457Z","caller":"traceutil/trace.go:171","msg":"trace[570224763] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6bc5d4567f-jp56t.18ba355a9e899ad1; range_end:; response_count:1; response_revision:4650; }","duration":"505.071768ms","start":"2026-06-18T15:07:46.91337Z","end":"2026-06-18T15:07:47.418442Z","steps":["trace[570224763] 'agreement among raft nodes before linearized reading' (duration: 504.701181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.418489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:46.913352Z","time spent":"505.1287ms","remote":"127.0.0.1:48358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":919,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6bc5d4567f-jp56t.18ba355a9e899ad1\" "} {"level":"warn","ts":"2026-06-18T15:07:47.418429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:47.029173Z","time spent":"389.139856ms","remote":"127.0.0.1:48588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T15:07:47.507462Z","caller":"traceutil/trace.go:171","msg":"trace[1718255325] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"442.321363ms","start":"2026-06-18T15:07:47.06508Z","end":"2026-06-18T15:07:47.507401Z","steps":["trace[1718255325] 'process raft request' (duration: 442.073608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.507612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.977312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aba54d6f-5520-457b-91af-35d0335c6e42\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-06-18T15:07:47.507686Z","caller":"traceutil/trace.go:171","msg":"trace[1190544509] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aba54d6f-5520-457b-91af-35d0335c6e42; range_end:; response_count:1; response_revision:4651; }","duration":"314.267387ms","start":"2026-06-18T15:07:47.193398Z","end":"2026-06-18T15:07:47.507665Z","steps":["trace[1190544509] 'agreement among raft nodes before linearized reading' (duration: 314.124645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.507728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:47.193371Z","time spent":"314.347159ms","remote":"127.0.0.1:48486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aba54d6f-5520-457b-91af-35d0335c6e42\" "} {"level":"warn","ts":"2026-06-18T15:07:47.507762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.440556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:07:47.507762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:47.065057Z","time spent":"442.509206ms","remote":"127.0.0.1:48486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:07:47.507634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.424097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-18T15:07:47.508053Z","caller":"traceutil/trace.go:171","msg":"trace[517784974] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4651; }","duration":"333.876565ms","start":"2026-06-18T15:07:47.174161Z","end":"2026-06-18T15:07:47.508037Z","steps":["trace[517784974] 'agreement among raft nodes before linearized reading' (duration: 333.244172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.508245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:47.174105Z","time spent":"334.126221ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-06-18T15:07:47.507924Z","caller":"traceutil/trace.go:171","msg":"trace[1930791229] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4651; }","duration":"334.744402ms","start":"2026-06-18T15:07:47.173119Z","end":"2026-06-18T15:07:47.507864Z","steps":["trace[1930791229] 'agreement among raft nodes before linearized reading' (duration: 334.384735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.508612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:47.1731Z","time spent":"335.487559ms","remote":"127.0.0.1:45266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-06-18T15:07:47.681214Z","caller":"traceutil/trace.go:171","msg":"trace[794515010] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"260.10448ms","start":"2026-06-18T15:07:47.421086Z","end":"2026-06-18T15:07:47.68119Z","steps":["trace[794515010] 'process raft request' (duration: 178.795333ms)","trace[794515010] 'compare' (duration: 81.170625ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:47.681199Z","caller":"traceutil/trace.go:171","msg":"trace[1276659889] linearizableReadLoop","detail":"{readStateIndex:4820; appliedIndex:4819; }","duration":"173.808932ms","start":"2026-06-18T15:07:47.507369Z","end":"2026-06-18T15:07:47.681178Z","steps":["trace[1276659889] 'read index received' (duration: 92.501684ms)","trace[1276659889] 'applied index is now lower than readState.Index' (duration: 81.306078ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:07:47.681342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.857089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:07:47.681383Z","caller":"traceutil/trace.go:171","msg":"trace[649228122] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:4652; }","duration":"198.949901ms","start":"2026-06-18T15:07:47.482424Z","end":"2026-06-18T15:07:47.681374Z","steps":["trace[649228122] 'agreement among raft nodes before linearized reading' (duration: 198.821298ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:47.730129Z","caller":"traceutil/trace.go:171","msg":"trace[516445631] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"138.138969ms","start":"2026-06-18T15:07:47.59197Z","end":"2026-06-18T15:07:47.730109Z","steps":["trace[516445631] 'process raft request' (duration: 138.095418ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:47.730275Z","caller":"traceutil/trace.go:171","msg":"trace[1771548585] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"157.969131ms","start":"2026-06-18T15:07:47.57226Z","end":"2026-06-18T15:07:47.730229Z","steps":["trace[1771548585] 'process raft request' (duration: 157.626454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.780036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.119322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-06-18T15:07:47.780097Z","caller":"traceutil/trace.go:171","msg":"trace[22662330] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4656; }","duration":"264.214163ms","start":"2026-06-18T15:07:47.515869Z","end":"2026-06-18T15:07:47.780083Z","steps":["trace[22662330] 'agreement among raft nodes before linearized reading' (duration: 264.003969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.780102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.022429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-18T15:07:47.780178Z","caller":"traceutil/trace.go:171","msg":"trace[662105241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4656; }","duration":"109.107481ms","start":"2026-06-18T15:07:47.671052Z","end":"2026-06-18T15:07:47.780159Z","steps":["trace[662105241] 'agreement among raft nodes before linearized reading' (duration: 108.860756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.7802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.263717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T15:07:47.780436Z","caller":"traceutil/trace.go:171","msg":"trace[618051876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4656; }","duration":"120.656425ms","start":"2026-06-18T15:07:47.659767Z","end":"2026-06-18T15:07:47.780423Z","steps":["trace[618051876] 'agreement among raft nodes before linearized reading' (duration: 120.232676ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:47.780045Z","caller":"traceutil/trace.go:171","msg":"trace[547214910] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"172.69904ms","start":"2026-06-18T15:07:47.607287Z","end":"2026-06-18T15:07:47.779986Z","steps":["trace[547214910] 'process raft request' (duration: 172.420465ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:01.34862Z","caller":"traceutil/trace.go:171","msg":"trace[1040207158] linearizableReadLoop","detail":"{readStateIndex:5010; appliedIndex:5009; }","duration":"284.055327ms","start":"2026-06-18T15:08:01.06454Z","end":"2026-06-18T15:08:01.348595Z","steps":["trace[1040207158] 'read index received' (duration: 283.802382ms)","trace[1040207158] 'applied index is now lower than readState.Index' (duration: 251.775µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:08:01.348705Z","caller":"traceutil/trace.go:171","msg":"trace[736317045] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"292.204256ms","start":"2026-06-18T15:08:01.056476Z","end":"2026-06-18T15:08:01.34868Z","steps":["trace[736317045] 'process raft request' (duration: 291.917691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:01.348879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.323971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-18T15:08:01.348939Z","caller":"traceutil/trace.go:171","msg":"trace[1709326412] 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:4836; }","duration":"284.444364ms","start":"2026-06-18T15:08:01.064477Z","end":"2026-06-18T15:08:01.348922Z","steps":["trace[1709326412] 'agreement among raft nodes before linearized reading' (duration: 284.25203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:01.348968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.510335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-18T15:08:01.34904Z","caller":"traceutil/trace.go:171","msg":"trace[350440960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4836; }","duration":"149.625638ms","start":"2026-06-18T15:08:01.199399Z","end":"2026-06-18T15:08:01.349025Z","steps":["trace[350440960] 'agreement among raft nodes before linearized reading' (duration: 149.400213ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:01.469062Z","caller":"traceutil/trace.go:171","msg":"trace[546606211] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"107.100005ms","start":"2026-06-18T15:08:01.36194Z","end":"2026-06-18T15:08:01.46904Z","steps":["trace[546606211] 'process raft request' (duration: 83.949722ms)","trace[546606211] 'compare' (duration: 23.023091ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:08:01.968184Z","caller":"traceutil/trace.go:171","msg":"trace[458670925] linearizableReadLoop","detail":"{readStateIndex:5020; appliedIndex:5017; }","duration":"130.078105ms","start":"2026-06-18T15:08:01.838081Z","end":"2026-06-18T15:08:01.968159Z","steps":["trace[458670925] 'read index received' (duration: 17.067715ms)","trace[458670925] 'applied index is now lower than readState.Index' (duration: 113.00927ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:08:01.968402Z","caller":"traceutil/trace.go:171","msg":"trace[1896007488] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"181.189854ms","start":"2026-06-18T15:08:01.787191Z","end":"2026-06-18T15:08:01.968381Z","steps":["trace[1896007488] 'process raft request' (duration: 115.470339ms)","trace[1896007488] 'compare' (duration: 65.251086ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:08:01.968644Z","caller":"traceutil/trace.go:171","msg":"trace[1313375605] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"139.962678ms","start":"2026-06-18T15:08:01.828639Z","end":"2026-06-18T15:08:01.968602Z","steps":["trace[1313375605] 'process raft request' (duration: 139.453448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:01.968711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.605365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-06-18T15:08:01.968748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.064494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T15:08:01.968849Z","caller":"traceutil/trace.go:171","msg":"trace[1005273284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4846; }","duration":"108.227297ms","start":"2026-06-18T15:08:01.860598Z","end":"2026-06-18T15:08:01.968825Z","steps":["trace[1005273284] 'agreement among raft nodes before linearized reading' (duration: 107.941051ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:01.968897Z","caller":"traceutil/trace.go:171","msg":"trace[228990747] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4846; }","duration":"130.715917ms","start":"2026-06-18T15:08:01.838045Z","end":"2026-06-18T15:08:01.968761Z","steps":["trace[228990747] 'agreement among raft nodes before linearized reading' (duration: 130.35043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:01.96904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.007934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:08:01.969363Z","caller":"traceutil/trace.go:171","msg":"trace[1573925467] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4846; }","duration":"102.492254ms","start":"2026-06-18T15:08:01.866816Z","end":"2026-06-18T15:08:01.969308Z","steps":["trace[1573925467] 'agreement among raft nodes before linearized reading' (duration: 101.897803ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:02.166791Z","caller":"traceutil/trace.go:171","msg":"trace[279948771] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"100.835807ms","start":"2026-06-18T15:08:02.065917Z","end":"2026-06-18T15:08:02.166753Z","steps":["trace[279948771] 'process raft request' (duration: 100.599253ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:49.431691Z","caller":"traceutil/trace.go:171","msg":"trace[818719019] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"169.079595ms","start":"2026-06-18T15:08:49.262584Z","end":"2026-06-18T15:08:49.431663Z","steps":["trace[818719019] 'process raft request' (duration: 168.888852ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:09:36.669649Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-06-18T15:09:36.787455Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"116.311663ms","hash":2611684413,"current-db-size-bytes":53665792,"current-db-size":"54 MB","current-db-size-in-use-bytes":29589504,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-18T15:09:36.787524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2611684413,"revision":2875,"compact-revision":-1} {"level":"info","ts":"2026-06-18T15:14:36.678461Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5579} {"level":"info","ts":"2026-06-18T15:14:36.754935Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5579,"took":"75.146214ms","hash":2342570518,"current-db-size-bytes":53665792,"current-db-size":"54 MB","current-db-size-in-use-bytes":18489344,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-18T15:14:36.75501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2342570518,"revision":5579,"compact-revision":2875}