{"level":"warn","ts":"2026-10-15T19:04:23.706549Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:04:23.706714Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.179: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://162.253.55.179:2380","--initial-cluster=instance=https://162.253.55.179:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.179:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.179: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-10-15T19:04:23.706834Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:04:23.706849Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.179:2380"]} {"level":"info","ts":"2026-10-15T19:04:23.706881Z","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-10-15T19:04:23.708352Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"]} {"level":"info","ts":"2026-10-15T19:04:23.708537Z","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":16,"max-cpu-available":16,"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://162.253.55.179:2380"],"listen-peer-urls":["https://162.253.55.179:2380"],"advertise-client-urls":["https://162.253.55.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.179: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-10-15T19:04:23.71306Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.971805ms"} {"level":"info","ts":"2026-10-15T19:04:23.721314Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"68b29b9453c9d66d","cluster-id":"f39bc50358d1a417"} {"level":"info","ts":"2026-10-15T19:04:23.721431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T19:04:23.72147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became follower at term 0"} {"level":"info","ts":"2026-10-15T19:04:23.72149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 68b29b9453c9d66d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T19:04:23.721502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became follower at term 1"} {"level":"info","ts":"2026-10-15T19:04:23.721581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=(7544263387162203757)"} {"level":"warn","ts":"2026-10-15T19:04:23.728834Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T19:04:23.73139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T19:04:23.73345Z","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-10-15T19:04:23.737237Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"68b29b9453c9d66d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T19:04:23.737502Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"68b29b9453c9d66d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T19:04:23.737594Z","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-10-15T19:04:23.737717Z","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-10-15T19:04:23.7378Z","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-10-15T19:04:23.740083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=(7544263387162203757)"} {"level":"info","ts":"2026-10-15T19:04:23.741206Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f39bc50358d1a417","local-member-id":"68b29b9453c9d66d","added-peer-id":"68b29b9453c9d66d","added-peer-peer-urls":["https://162.253.55.179:2380"]} {"level":"info","ts":"2026-10-15T19:04:23.743737Z","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-10-15T19:04:23.743864Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.179:2380"} {"level":"info","ts":"2026-10-15T19:04:23.743946Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.179:2380"} {"level":"info","ts":"2026-10-15T19:04:23.744247Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"68b29b9453c9d66d","initial-advertise-peer-urls":["https://162.253.55.179:2380"],"listen-peer-urls":["https://162.253.55.179:2380"],"advertise-client-urls":["https://162.253.55.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T19:04:23.744326Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T19:04:23.922676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T19:04:23.92274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T19:04:23.922763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d received MsgPreVoteResp from 68b29b9453c9d66d at term 1"} {"level":"info","ts":"2026-10-15T19:04:23.922782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became candidate at term 2"} {"level":"info","ts":"2026-10-15T19:04:23.922792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d received MsgVoteResp from 68b29b9453c9d66d at term 2"} {"level":"info","ts":"2026-10-15T19:04:23.922807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became leader at term 2"} {"level":"info","ts":"2026-10-15T19:04:23.922819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 68b29b9453c9d66d elected leader 68b29b9453c9d66d at term 2"} {"level":"info","ts":"2026-10-15T19:04:23.924307Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"68b29b9453c9d66d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.179:2379]}","request-path":"/0/members/68b29b9453c9d66d/attributes","cluster-id":"f39bc50358d1a417","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T19:04:23.92435Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:04:23.924531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:04:23.924662Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T19:04:23.92458Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:04:23.924739Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T19:04:23.926162Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f39bc50358d1a417","local-member-id":"68b29b9453c9d66d","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:04:23.926412Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:04:23.92651Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:04:23.926951Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.179:2379"} {"level":"info","ts":"2026-10-15T19:04:23.928177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T19:04:39.902453Z","caller":"traceutil/trace.go:171","msg":"trace[305847107] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"137.931214ms","start":"2026-10-15T19:04:39.764493Z","end":"2026-10-15T19:04:39.902424Z","steps":["trace[305847107] 'process raft request' (duration: 137.76036ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:04:40.062177Z","caller":"traceutil/trace.go:171","msg":"trace[1347699140] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"159.606191ms","start":"2026-10-15T19:04:39.902549Z","end":"2026-10-15T19:04:40.062155Z","steps":["trace[1347699140] 'process raft request' (duration: 158.441603ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:09.318795Z","caller":"traceutil/trace.go:171","msg":"trace[1068884808] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"111.28114ms","start":"2026-10-15T19:05:09.207497Z","end":"2026-10-15T19:05:09.318778Z","steps":["trace[1068884808] 'process raft request' (duration: 111.183328ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:09.326168Z","caller":"traceutil/trace.go:171","msg":"trace[90999965] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"107.750623ms","start":"2026-10-15T19:05:09.218367Z","end":"2026-10-15T19:05:09.326117Z","steps":["trace[90999965] 'process raft request' (duration: 107.032015ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:09.326224Z","caller":"traceutil/trace.go:171","msg":"trace[211461002] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"107.725382ms","start":"2026-10-15T19:05:09.21848Z","end":"2026-10-15T19:05:09.326205Z","steps":["trace[211461002] 'process raft request' (duration: 106.984434ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:13.5571Z","caller":"traceutil/trace.go:171","msg":"trace[1027155217] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"109.757133ms","start":"2026-10-15T19:05:13.447311Z","end":"2026-10-15T19:05:13.557068Z","steps":["trace[1027155217] 'read index received' (duration: 107.009996ms)","trace[1027155217] 'applied index is now lower than readState.Index' (duration: 2.746037ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:05:13.557214Z","caller":"traceutil/trace.go:171","msg":"trace[1525071517] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"113.29753ms","start":"2026-10-15T19:05:13.443864Z","end":"2026-10-15T19:05:13.557162Z","steps":["trace[1525071517] 'process raft request' (duration: 111.522206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:13.557365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.011979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:13.557559Z","caller":"traceutil/trace.go:171","msg":"trace[1911764402] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"110.257675ms","start":"2026-10-15T19:05:13.447269Z","end":"2026-10-15T19:05:13.557527Z","steps":["trace[1911764402] 'agreement among raft nodes before linearized reading' (duration: 109.946598ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:17.221905Z","caller":"traceutil/trace.go:171","msg":"trace[1350487789] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"372.411981ms","start":"2026-10-15T19:05:16.849464Z","end":"2026-10-15T19:05:17.221876Z","steps":["trace[1350487789] 'read index received' (duration: 289.208742ms)","trace[1350487789] 'applied index is now lower than readState.Index' (duration: 83.202229ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:05:17.222056Z","caller":"traceutil/trace.go:171","msg":"trace[1333172664] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"395.467619ms","start":"2026-10-15T19:05:16.82652Z","end":"2026-10-15T19:05:17.221987Z","steps":["trace[1333172664] 'process raft request' (duration: 312.176328ms)","trace[1333172664] 'compare' (duration: 83.008824ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:17.22211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.621426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p4tw9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T19:05:17.222172Z","caller":"traceutil/trace.go:171","msg":"trace[1388780431] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p4tw9; range_end:; response_count:1; response_revision:616; }","duration":"372.76167ms","start":"2026-10-15T19:05:16.849394Z","end":"2026-10-15T19:05:17.222155Z","steps":["trace[1388780431] 'agreement among raft nodes before linearized reading' (duration: 372.590946ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:17.222226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:16.849368Z","time spent":"372.846142ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-p4tw9\" "} {"level":"warn","ts":"2026-10-15T19:05:17.222956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:16.826503Z","time spent":"395.653353ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T19:05:17.894475Z","caller":"traceutil/trace.go:171","msg":"trace[1261256523] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"666.074314ms","start":"2026-10-15T19:05:17.228323Z","end":"2026-10-15T19:05:17.894397Z","steps":["trace[1261256523] 'process raft request' (duration: 611.826527ms)","trace[1261256523] 'compare' (duration: 53.811506ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:17.894676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:17.228291Z","time spent":"666.293879ms","remote":"127.0.0.1:48792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T19:05:17.894773Z","caller":"traceutil/trace.go:171","msg":"trace[660342106] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"140.53837ms","start":"2026-10-15T19:05:17.754187Z","end":"2026-10-15T19:05:17.894725Z","steps":["trace[660342106] 'process raft request' (duration: 140.474009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:17.894975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.538878ms","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-10-15T19:05:17.895055Z","caller":"traceutil/trace.go:171","msg":"trace[186137256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"282.671542ms","start":"2026-10-15T19:05:17.612346Z","end":"2026-10-15T19:05:17.895018Z","steps":["trace[186137256] 'agreement among raft nodes before linearized reading' (duration: 282.540868ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:17.894811Z","caller":"traceutil/trace.go:171","msg":"trace[444368961] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"665.284244ms","start":"2026-10-15T19:05:17.22949Z","end":"2026-10-15T19:05:17.894774Z","steps":["trace[444368961] 'process raft request' (duration: 665.028468ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:17.894813Z","caller":"traceutil/trace.go:171","msg":"trace[2081646752] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"649.819612ms","start":"2026-10-15T19:05:17.244966Z","end":"2026-10-15T19:05:17.894786Z","steps":["trace[2081646752] 'process raft request' (duration: 649.630008ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:17.89482Z","caller":"traceutil/trace.go:171","msg":"trace[852398107] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"665.710544ms","start":"2026-10-15T19:05:17.229086Z","end":"2026-10-15T19:05:17.894797Z","steps":["trace[852398107] 'process raft request' (duration: 665.192742ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:17.89484Z","caller":"traceutil/trace.go:171","msg":"trace[1672133002] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:642; }","duration":"282.366144ms","start":"2026-10-15T19:05:17.61243Z","end":"2026-10-15T19:05:17.894796Z","steps":["trace[1672133002] 'read index received' (duration: 227.800381ms)","trace[1672133002] 'applied index is now lower than readState.Index' (duration: 54.561223ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:17.895532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.270921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-10-15T19:05:17.89553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:17.229471Z","time spent":"665.654182ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:05:17.895584Z","caller":"traceutil/trace.go:171","msg":"trace[946872927] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"176.368803ms","start":"2026-10-15T19:05:17.719202Z","end":"2026-10-15T19:05:17.895571Z","steps":["trace[946872927] 'agreement among raft nodes before linearized reading' (duration: 176.279261ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:17.895687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.652218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.179\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-15T19:05:17.895737Z","caller":"traceutil/trace.go:171","msg":"trace[2090588681] range","detail":"{range_begin:/registry/masterleases/162.253.55.179; range_end:; response_count:1; response_revision:622; }","duration":"102.74849ms","start":"2026-10-15T19:05:17.792975Z","end":"2026-10-15T19:05:17.895723Z","steps":["trace[2090588681] 'agreement among raft nodes before linearized reading' (duration: 102.661118ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:17.895819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:17.244952Z","time spent":"650.332634ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:05:17.895923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:17.229074Z","time spent":"666.303169ms","remote":"127.0.0.1:48964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:05:34.47043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.144514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.470452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.797012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.470539Z","caller":"traceutil/trace.go:171","msg":"trace[140569462] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"268.324919ms","start":"2026-10-15T19:05:34.202195Z","end":"2026-10-15T19:05:34.470519Z","steps":["trace[140569462] 'range keys from in-memory index tree' (duration: 268.034971ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.470592Z","caller":"traceutil/trace.go:171","msg":"trace[1147824924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:783; }","duration":"198.018108ms","start":"2026-10-15T19:05:34.272527Z","end":"2026-10-15T19:05:34.470545Z","steps":["trace[1147824924] 'range keys from in-memory index tree' (duration: 197.651338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.470767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.595195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.470854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.56846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.47086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.56054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.470924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.973166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.470957Z","caller":"traceutil/trace.go:171","msg":"trace[2025176983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"289.041087ms","start":"2026-10-15T19:05:34.181908Z","end":"2026-10-15T19:05:34.470949Z","steps":["trace[2025176983] 'range keys from in-memory index tree' (duration: 288.910414ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.470888Z","caller":"traceutil/trace.go:171","msg":"trace[304423367] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"289.633612ms","start":"2026-10-15T19:05:34.181244Z","end":"2026-10-15T19:05:34.470877Z","steps":["trace[304423367] 'count revisions from in-memory index tree' (duration: 289.444317ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.470941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.651719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.470999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.579555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.471066Z","caller":"traceutil/trace.go:171","msg":"trace[555656697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:783; }","duration":"100.786722ms","start":"2026-10-15T19:05:34.370224Z","end":"2026-10-15T19:05:34.471011Z","steps":["trace[555656697] 'range keys from in-memory index tree' (duration: 100.531326ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.471097Z","caller":"traceutil/trace.go:171","msg":"trace[523116364] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"268.681387ms","start":"2026-10-15T19:05:34.202399Z","end":"2026-10-15T19:05:34.47108Z","steps":["trace[523116364] 'count revisions from in-memory index tree' (duration: 268.519722ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.47108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.850234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.471158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.874668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.471185Z","caller":"traceutil/trace.go:171","msg":"trace[2112594770] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:783; }","duration":"101.011878ms","start":"2026-10-15T19:05:34.370139Z","end":"2026-10-15T19:05:34.471151Z","steps":["trace[2112594770] 'count revisions from in-memory index tree' (duration: 100.746731ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.471224Z","caller":"traceutil/trace.go:171","msg":"trace[1722569977] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:783; }","duration":"316.000491ms","start":"2026-10-15T19:05:34.15521Z","end":"2026-10-15T19:05:34.471211Z","steps":["trace[1722569977] 'count revisions from in-memory index tree' (duration: 315.706234ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:34.155184Z","time spent":"316.077334ms","remote":"127.0.0.1:45014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-10-15T19:05:34.470878Z","caller":"traceutil/trace.go:171","msg":"trace[1182056112] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:783; }","duration":"160.751488ms","start":"2026-10-15T19:05:34.310097Z","end":"2026-10-15T19:05:34.470849Z","steps":["trace[1182056112] 'range keys from in-memory index tree' (duration: 160.512283ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.567063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.4714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.064283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.471546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.188213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.471566Z","caller":"traceutil/trace.go:171","msg":"trace[1621377891] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:783; }","duration":"316.292959ms","start":"2026-10-15T19:05:34.155252Z","end":"2026-10-15T19:05:34.471545Z","steps":["trace[1621377891] 'range keys from in-memory index tree' (duration: 315.90856ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.471494Z","caller":"traceutil/trace.go:171","msg":"trace[1896981790] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"268.660706ms","start":"2026-10-15T19:05:34.202813Z","end":"2026-10-15T19:05:34.471474Z","steps":["trace[1896981790] 'range keys from in-memory index tree' (duration: 268.487722ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.552553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.471701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.034941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.471743Z","caller":"traceutil/trace.go:171","msg":"trace[1088167213] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:783; }","duration":"162.620754ms","start":"2026-10-15T19:05:34.30911Z","end":"2026-10-15T19:05:34.47173Z","steps":["trace[1088167213] 'range keys from in-memory index tree' (duration: 162.486441ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.471627Z","caller":"traceutil/trace.go:171","msg":"trace[1686752881] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:783; }","duration":"242.272396ms","start":"2026-10-15T19:05:34.229315Z","end":"2026-10-15T19:05:34.471587Z","steps":["trace[1686752881] 'count revisions from in-memory index tree' (duration: 242.122832ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.471973Z","caller":"traceutil/trace.go:171","msg":"trace[1641782197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:783; }","duration":"199.34232ms","start":"2026-10-15T19:05:34.272602Z","end":"2026-10-15T19:05:34.471944Z","steps":["trace[1641782197] 'count revisions from in-memory index tree' (duration: 198.997001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.812685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.472074Z","caller":"traceutil/trace.go:171","msg":"trace[1030114893] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:783; }","duration":"241.912058ms","start":"2026-10-15T19:05:34.23012Z","end":"2026-10-15T19:05:34.472032Z","steps":["trace[1030114893] 'range keys from in-memory index tree' (duration: 241.495958ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.472104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.728287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.470949Z","caller":"traceutil/trace.go:171","msg":"trace[443919982] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"289.690553ms","start":"2026-10-15T19:05:34.181236Z","end":"2026-10-15T19:05:34.470926Z","steps":["trace[443919982] 'range keys from in-memory index tree' (duration: 289.421087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.912814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:05:34.47211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.819419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:05:34.472232Z","caller":"traceutil/trace.go:171","msg":"trace[42169758] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:783; }","duration":"242.919842ms","start":"2026-10-15T19:05:34.229274Z","end":"2026-10-15T19:05:34.472194Z","steps":["trace[42169758] 'range keys from in-memory index tree' (duration: 242.608485ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.472232Z","caller":"traceutil/trace.go:171","msg":"trace[1891863287] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:783; }","duration":"315.636372ms","start":"2026-10-15T19:05:34.156569Z","end":"2026-10-15T19:05:34.472206Z","steps":["trace[1891863287] 'range keys from in-memory index tree' (duration: 314.774271ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:05:34.472305Z","caller":"traceutil/trace.go:171","msg":"trace[1954817072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:783; }","duration":"163.098906ms","start":"2026-10-15T19:05:34.309159Z","end":"2026-10-15T19:05:34.472258Z","steps":["trace[1954817072] 'count revisions from in-memory index tree' (duration: 162.723387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.472353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:34.15654Z","time spent":"315.794646ms","remote":"127.0.0.1:45014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-10-15T19:05:34.471683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:05:34.155217Z","time spent":"316.449613ms","remote":"127.0.0.1:45014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-10-15T19:05:34.472411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.310066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T19:05:34.472524Z","caller":"traceutil/trace.go:171","msg":"trace[138333974] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:783; }","duration":"192.446729ms","start":"2026-10-15T19:05:34.280033Z","end":"2026-10-15T19:05:34.47248Z","steps":["trace[138333974] 'count revisions from in-memory index tree' (duration: 192.226333ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:05:34.471093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.312022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T19:05:34.472599Z","caller":"traceutil/trace.go:171","msg":"trace[2007338116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"163.102306ms","start":"2026-10-15T19:05:34.30948Z","end":"2026-10-15T19:05:34.472583Z","steps":["trace[2007338116] 'range keys from in-memory index tree' (duration: 161.037916ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:03.122257Z","caller":"traceutil/trace.go:171","msg":"trace[1092995643] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"199.62124ms","start":"2026-10-15T19:06:02.922592Z","end":"2026-10-15T19:06:03.122214Z","steps":["trace[1092995643] 'read index received' (duration: 195.731195ms)","trace[1092995643] 'applied index is now lower than readState.Index' (duration: 3.888145ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:06:03.122523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.914827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-15T19:06:03.122606Z","caller":"traceutil/trace.go:171","msg":"trace[15846074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1185; }","duration":"200.0495ms","start":"2026-10-15T19:06:02.922537Z","end":"2026-10-15T19:06:03.122586Z","steps":["trace[15846074] 'agreement among raft nodes before linearized reading' (duration: 199.803084ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:26.488199Z","caller":"traceutil/trace.go:171","msg":"trace[1438478341] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"122.705676ms","start":"2026-10-15T19:06:26.365441Z","end":"2026-10-15T19:06:26.488147Z","steps":["trace[1438478341] 'process raft request' (duration: 116.882313ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:26.526467Z","caller":"traceutil/trace.go:171","msg":"trace[1537081784] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"160.803219ms","start":"2026-10-15T19:06:26.365524Z","end":"2026-10-15T19:06:26.526327Z","steps":["trace[1537081784] 'process raft request' (duration: 160.601784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:53.199304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.047568ms","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-10-15T19:06:53.199493Z","caller":"traceutil/trace.go:171","msg":"trace[1918783953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1878; }","duration":"144.270084ms","start":"2026-10-15T19:06:53.05516Z","end":"2026-10-15T19:06:53.19943Z","steps":["trace[1918783953] 'range keys from in-memory index tree' (duration: 143.71315ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:53.394544Z","caller":"traceutil/trace.go:171","msg":"trace[1841854868] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"192.612508ms","start":"2026-10-15T19:06:53.201893Z","end":"2026-10-15T19:06:53.394505Z","steps":["trace[1841854868] 'read index received' (duration: 192.375832ms)","trace[1841854868] 'applied index is now lower than readState.Index' (duration: 234.966µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:53.394656Z","caller":"traceutil/trace.go:171","msg":"trace[524643170] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"336.055752ms","start":"2026-10-15T19:06:53.058571Z","end":"2026-10-15T19:06:53.394627Z","steps":["trace[524643170] 'process raft request' (duration: 335.643292ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:53.394809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:53.058526Z","time spent":"336.199506ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:06:53.394841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.912245ms","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-10-15T19:06:53.39489Z","caller":"traceutil/trace.go:171","msg":"trace[1247956957] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"193.025078ms","start":"2026-10-15T19:06:53.201846Z","end":"2026-10-15T19:06:53.394871Z","steps":["trace[1247956957] 'agreement among raft nodes before linearized reading' (duration: 192.806183ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:53.449165Z","caller":"traceutil/trace.go:171","msg":"trace[682098453] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"243.77315ms","start":"2026-10-15T19:06:53.205343Z","end":"2026-10-15T19:06:53.449116Z","steps":["trace[682098453] 'process raft request' (duration: 201.859094ms)","trace[682098453] 'compare' (duration: 41.594429ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:53.861462Z","caller":"traceutil/trace.go:171","msg":"trace[866918496] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"401.614237ms","start":"2026-10-15T19:06:53.459818Z","end":"2026-10-15T19:06:53.861432Z","steps":["trace[866918496] 'process raft request' (duration: 401.374471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:06:53.861639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:06:53.45978Z","time spent":"401.760841ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:07:44.477712Z","caller":"traceutil/trace.go:171","msg":"trace[357857916] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"187.107236ms","start":"2026-10-15T19:07:44.290562Z","end":"2026-10-15T19:07:44.477669Z","steps":["trace[357857916] 'process raft request' (duration: 186.826559ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:07:44.626612Z","caller":"traceutil/trace.go:171","msg":"trace[1305073006] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"142.992859ms","start":"2026-10-15T19:07:44.483565Z","end":"2026-10-15T19:07:44.626558Z","steps":["trace[1305073006] 'process raft request' (duration: 141.010191ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:07:49.933886Z","caller":"traceutil/trace.go:171","msg":"trace[1457754208] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"236.50574ms","start":"2026-10-15T19:07:49.697352Z","end":"2026-10-15T19:07:49.933857Z","steps":["trace[1457754208] 'process raft request' (duration: 236.319226ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:07:49.963339Z","caller":"traceutil/trace.go:171","msg":"trace[307549286] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2317; }","duration":"115.94502ms","start":"2026-10-15T19:07:49.84737Z","end":"2026-10-15T19:07:49.963315Z","steps":["trace[307549286] 'read index received' (duration: 86.328666ms)","trace[307549286] 'applied index is now lower than readState.Index' (duration: 29.614884ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:07:49.963442Z","caller":"traceutil/trace.go:171","msg":"trace[837041239] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"265.613572ms","start":"2026-10-15T19:07:49.6978Z","end":"2026-10-15T19:07:49.963413Z","steps":["trace[837041239] 'process raft request' (duration: 265.379666ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:07:49.963587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.203295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T19:07:49.963633Z","caller":"traceutil/trace.go:171","msg":"trace[2105368959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2235; }","duration":"116.305017ms","start":"2026-10-15T19:07:49.847317Z","end":"2026-10-15T19:07:49.963622Z","steps":["trace[2105368959] 'agreement among raft nodes before linearized reading' (duration: 116.142234ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:07:49.963718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.765921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-15T19:07:49.963813Z","caller":"traceutil/trace.go:171","msg":"trace[1078554447] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2235; }","duration":"105.916125ms","start":"2026-10-15T19:07:49.857875Z","end":"2026-10-15T19:07:49.963791Z","steps":["trace[1078554447] 'agreement among raft nodes before linearized reading' (duration: 105.651768ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:09:18.605118Z","caller":"traceutil/trace.go:171","msg":"trace[1167836586] transaction","detail":"{read_only:false; response_revision:2907; number_of_response:1; }","duration":"100.689538ms","start":"2026-10-15T19:09:18.504357Z","end":"2026-10-15T19:09:18.605046Z","steps":["trace[1167836586] 'process raft request' (duration: 100.406641ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:42.666229Z","caller":"traceutil/trace.go:171","msg":"trace[1813242137] linearizableReadLoop","detail":"{readStateIndex:4339; appliedIndex:4338; }","duration":"114.315098ms","start":"2026-10-15T19:12:42.55189Z","end":"2026-10-15T19:12:42.666205Z","steps":["trace[1813242137] 'read index received' (duration: 114.095143ms)","trace[1813242137] 'applied index is now lower than readState.Index' (duration: 218.945µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:12:42.666288Z","caller":"traceutil/trace.go:171","msg":"trace[1923896203] transaction","detail":"{read_only:false; response_revision:4181; number_of_response:1; }","duration":"116.544452ms","start":"2026-10-15T19:12:42.549722Z","end":"2026-10-15T19:12:42.666266Z","steps":["trace[1923896203] 'process raft request' (duration: 116.339287ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:12:42.66648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.565484ms","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-10-15T19:12:42.666518Z","caller":"traceutil/trace.go:171","msg":"trace[796844741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4181; }","duration":"114.642656ms","start":"2026-10-15T19:12:42.551865Z","end":"2026-10-15T19:12:42.666508Z","steps":["trace[796844741] 'agreement among raft nodes before linearized reading' (duration: 114.468981ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:12:42.818395Z","caller":"traceutil/trace.go:171","msg":"trace[2018843559] linearizableReadLoop","detail":"{readStateIndex:4340; appliedIndex:4339; }","duration":"135.109142ms","start":"2026-10-15T19:12:42.683262Z","end":"2026-10-15T19:12:42.818371Z","steps":["trace[2018843559] 'read index received' (duration: 48.824542ms)","trace[2018843559] 'applied index is now lower than readState.Index' (duration: 86.28377ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:12:42.818481Z","caller":"traceutil/trace.go:171","msg":"trace[2117504031] transaction","detail":"{read_only:false; response_revision:4182; number_of_response:1; }","duration":"147.43769ms","start":"2026-10-15T19:12:42.670997Z","end":"2026-10-15T19:12:42.818435Z","steps":["trace[2117504031] 'process raft request' (duration: 61.105149ms)","trace[2117504031] 'compare' (duration: 86.134357ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:12:42.818633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.364588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-10-15T19:12:42.818718Z","caller":"traceutil/trace.go:171","msg":"trace[373259555] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:4182; }","duration":"135.504672ms","start":"2026-10-15T19:12:42.683195Z","end":"2026-10-15T19:12:42.8187Z","steps":["trace[373259555] 'agreement among raft nodes before linearized reading' (duration: 135.256026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:18.951993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.056986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85529978-885b-4c7c-9045-a62357b08cbd\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T19:14:18.952095Z","caller":"traceutil/trace.go:171","msg":"trace[1429065745] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85529978-885b-4c7c-9045-a62357b08cbd; range_end:; response_count:1; response_revision:5432; }","duration":"115.23237ms","start":"2026-10-15T19:14:18.83684Z","end":"2026-10-15T19:14:18.952072Z","steps":["trace[1429065745] 'range keys from in-memory index tree' (duration: 114.765129ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:18.952095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.791574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:14:18.95218Z","caller":"traceutil/trace.go:171","msg":"trace[450600523] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5432; }","duration":"103.924836ms","start":"2026-10-15T19:14:18.848236Z","end":"2026-10-15T19:14:18.95216Z","steps":["trace[450600523] 'range keys from in-memory index tree' (duration: 103.606449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:18.952212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.344736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85529978-885b-4c7c-9045-a62357b08cbd\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T19:14:18.952302Z","caller":"traceutil/trace.go:171","msg":"trace[1285524797] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85529978-885b-4c7c-9045-a62357b08cbd; range_end:; response_count:1; response_revision:5432; }","duration":"265.488569ms","start":"2026-10-15T19:14:18.686792Z","end":"2026-10-15T19:14:18.952281Z","steps":["trace[1285524797] 'range keys from in-memory index tree' (duration: 265.142861ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:19.079675Z","caller":"traceutil/trace.go:171","msg":"trace[1507599922] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"119.991005ms","start":"2026-10-15T19:14:18.959646Z","end":"2026-10-15T19:14:19.079637Z","steps":["trace[1507599922] 'process raft request' (duration: 119.75671ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:19.433568Z","caller":"traceutil/trace.go:171","msg":"trace[318620762] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"139.279533ms","start":"2026-10-15T19:14:19.294257Z","end":"2026-10-15T19:14:19.433537Z","steps":["trace[318620762] 'process raft request' (duration: 138.956665ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:21.122902Z","caller":"traceutil/trace.go:171","msg":"trace[1636414790] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"124.632107ms","start":"2026-10-15T19:14:20.998197Z","end":"2026-10-15T19:14:21.122829Z","steps":["trace[1636414790] 'process raft request' (duration: 54.719344ms)","trace[1636414790] 'compare' (duration: 69.610246ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:14:24.430667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2936} {"level":"info","ts":"2026-10-15T19:14:24.515136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2936,"took":"82.674883ms","hash":1346941338,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":30744576,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T19:14:24.515221Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1346941338,"revision":2936,"compact-revision":-1} {"level":"info","ts":"2026-10-15T19:14:33.793481Z","caller":"traceutil/trace.go:171","msg":"trace[1053706829] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"161.793227ms","start":"2026-10-15T19:14:33.631663Z","end":"2026-10-15T19:14:33.793456Z","steps":["trace[1053706829] 'process raft request' (duration: 161.736086ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:33.793791Z","caller":"traceutil/trace.go:171","msg":"trace[252319703] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"183.540754ms","start":"2026-10-15T19:14:33.610233Z","end":"2026-10-15T19:14:33.793774Z","steps":["trace[252319703] 'process raft request' (duration: 149.937321ms)","trace[252319703] 'compare' (duration: 32.670581ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:14:42.275055Z","caller":"traceutil/trace.go:171","msg":"trace[914338281] linearizableReadLoop","detail":"{readStateIndex:6080; appliedIndex:6079; }","duration":"200.993953ms","start":"2026-10-15T19:14:42.074032Z","end":"2026-10-15T19:14:42.275026Z","steps":["trace[914338281] 'read index received' (duration: 200.743446ms)","trace[914338281] 'applied index is now lower than readState.Index' (duration: 245.696µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:14:42.275118Z","caller":"traceutil/trace.go:171","msg":"trace[1236116466] transaction","detail":"{read_only:false; response_revision:5864; number_of_response:1; }","duration":"222.025314ms","start":"2026-10-15T19:14:42.053045Z","end":"2026-10-15T19:14:42.275071Z","steps":["trace[1236116466] 'process raft request' (duration: 221.793328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.275332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.27262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:14:42.275465Z","caller":"traceutil/trace.go:171","msg":"trace[34474509] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5864; }","duration":"201.422284ms","start":"2026-10-15T19:14:42.074014Z","end":"2026-10-15T19:14:42.275436Z","steps":["trace[34474509] 'agreement among raft nodes before linearized reading' (duration: 201.163147ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.275497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.305069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-15T19:14:42.275529Z","caller":"traceutil/trace.go:171","msg":"trace[407173316] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5864; }","duration":"104.391012ms","start":"2026-10-15T19:14:42.171128Z","end":"2026-10-15T19:14:42.275519Z","steps":["trace[407173316] 'agreement among raft nodes before linearized reading' (duration: 104.30509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.275404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.85364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5835"} {"level":"info","ts":"2026-10-15T19:14:42.275608Z","caller":"traceutil/trace.go:171","msg":"trace[1029975427] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5864; }","duration":"135.157607ms","start":"2026-10-15T19:14:42.140435Z","end":"2026-10-15T19:14:42.275592Z","steps":["trace[1029975427] 'agreement among raft nodes before linearized reading' (duration: 134.746517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.27576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.550612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8fa023b-1f17-4f6e-9f59-060f055fa7e9\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T19:14:42.275894Z","caller":"traceutil/trace.go:171","msg":"trace[1593370717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8fa023b-1f17-4f6e-9f59-060f055fa7e9; range_end:; response_count:1; response_revision:5864; }","duration":"122.745546ms","start":"2026-10-15T19:14:42.153116Z","end":"2026-10-15T19:14:42.275862Z","steps":["trace[1593370717] 'agreement among raft nodes before linearized reading' (duration: 122.321227ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.534615Z","caller":"traceutil/trace.go:171","msg":"trace[2102300959] transaction","detail":"{read_only:false; response_revision:5866; number_of_response:1; }","duration":"245.03327ms","start":"2026-10-15T19:14:42.289547Z","end":"2026-10-15T19:14:42.53458Z","steps":["trace[2102300959] 'process raft request' (duration: 244.704672ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.824646Z","caller":"traceutil/trace.go:171","msg":"trace[1489568798] transaction","detail":"{read_only:false; response_revision:5868; number_of_response:1; }","duration":"281.7324ms","start":"2026-10-15T19:14:42.542874Z","end":"2026-10-15T19:14:42.824606Z","steps":["trace[1489568798] 'process raft request' (duration: 281.450094ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.824665Z","caller":"traceutil/trace.go:171","msg":"trace[1053038536] transaction","detail":"{read_only:false; response_revision:5869; number_of_response:1; }","duration":"277.961419ms","start":"2026-10-15T19:14:42.546678Z","end":"2026-10-15T19:14:42.824639Z","steps":["trace[1053038536] 'process raft request' (duration: 277.856826ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.825027Z","caller":"traceutil/trace.go:171","msg":"trace[1496991353] transaction","detail":"{read_only:false; response_revision:5870; number_of_response:1; }","duration":"278.315267ms","start":"2026-10-15T19:14:42.546702Z","end":"2026-10-15T19:14:42.825017Z","steps":["trace[1496991353] 'process raft request' (duration: 277.873286ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.825501Z","caller":"traceutil/trace.go:171","msg":"trace[699043228] transaction","detail":"{read_only:false; response_revision:5871; number_of_response:1; }","duration":"278.588044ms","start":"2026-10-15T19:14:42.546895Z","end":"2026-10-15T19:14:42.825483Z","steps":["trace[699043228] 'process raft request' (duration: 278.009449ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.825562Z","caller":"traceutil/trace.go:171","msg":"trace[533772148] transaction","detail":"{read_only:false; response_revision:5872; number_of_response:1; }","duration":"278.562913ms","start":"2026-10-15T19:14:42.546985Z","end":"2026-10-15T19:14:42.825548Z","steps":["trace[533772148] 'process raft request' (duration: 278.387329ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:42.825736Z","caller":"traceutil/trace.go:171","msg":"trace[75911373] linearizableReadLoop","detail":"{readStateIndex:6085; appliedIndex:6082; }","duration":"279.014244ms","start":"2026-10-15T19:14:42.546709Z","end":"2026-10-15T19:14:42.825723Z","steps":["trace[75911373] 'read index received' (duration: 50.780521ms)","trace[75911373] 'applied index is now lower than readState.Index' (duration: 228.232573ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:14:42.825995Z","caller":"traceutil/trace.go:171","msg":"trace[1263788097] transaction","detail":"{read_only:false; response_revision:5873; number_of_response:1; }","duration":"240.86243ms","start":"2026-10-15T19:14:42.58512Z","end":"2026-10-15T19:14:42.825983Z","steps":["trace[1263788097] 'process raft request' (duration: 240.368998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.82609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.280088ms","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-10-15T19:14:42.826132Z","caller":"traceutil/trace.go:171","msg":"trace[1704205636] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5873; }","duration":"172.39649ms","start":"2026-10-15T19:14:42.653725Z","end":"2026-10-15T19:14:42.826121Z","steps":["trace[1704205636] 'agreement among raft nodes before linearized reading' (duration: 172.230636ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.826268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.000726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T19:14:42.826298Z","caller":"traceutil/trace.go:171","msg":"trace[224601463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5873; }","duration":"171.078007ms","start":"2026-10-15T19:14:42.655212Z","end":"2026-10-15T19:14:42.82629Z","steps":["trace[224601463] 'agreement among raft nodes before linearized reading' (duration: 170.998595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:14:42.826559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.754903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8fa023b-1f17-4f6e-9f59-060f055fa7e9\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T19:14:42.8268Z","caller":"traceutil/trace.go:171","msg":"trace[369930498] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8fa023b-1f17-4f6e-9f59-060f055fa7e9; range_end:; response_count:1; response_revision:5873; }","duration":"280.122862ms","start":"2026-10-15T19:14:42.546641Z","end":"2026-10-15T19:14:42.826764Z","steps":["trace[369930498] 'agreement among raft nodes before linearized reading' (duration: 279.23427ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:54.517775Z","caller":"traceutil/trace.go:171","msg":"trace[2066502684] linearizableReadLoop","detail":"{readStateIndex:6237; appliedIndex:6236; }","duration":"105.627972ms","start":"2026-10-15T19:14:54.412116Z","end":"2026-10-15T19:14:54.517744Z","steps":["trace[2066502684] 'read index received' (duration: 105.475058ms)","trace[2066502684] 'applied index is now lower than readState.Index' (duration: 151.844µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:14:54.518115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.96153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lzkvp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-15T19:14:54.518159Z","caller":"traceutil/trace.go:171","msg":"trace[1519131837] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lzkvp; range_end:; response_count:1; response_revision:6017; }","duration":"106.065703ms","start":"2026-10-15T19:14:54.412081Z","end":"2026-10-15T19:14:54.518147Z","steps":["trace[1519131837] 'agreement among raft nodes before linearized reading' (duration: 105.787516ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:14:54.518419Z","caller":"traceutil/trace.go:171","msg":"trace[699889890] transaction","detail":"{read_only:false; response_revision:6017; number_of_response:1; }","duration":"127.927102ms","start":"2026-10-15T19:14:54.390451Z","end":"2026-10-15T19:14:54.518378Z","steps":["trace[699889890] 'process raft request' (duration: 127.037091ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:24.440405Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5555} {"level":"info","ts":"2026-10-15T19:19:24.544102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5555,"took":"101.263868ms","hash":2648514505,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":28348416,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T19:19:24.544176Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2648514505,"revision":5555,"compact-revision":2936} {"level":"info","ts":"2026-10-15T19:21:02.392307Z","caller":"traceutil/trace.go:171","msg":"trace[1339000627] linearizableReadLoop","detail":"{readStateIndex:9069; appliedIndex:9068; }","duration":"500.315933ms","start":"2026-10-15T19:21:01.891969Z","end":"2026-10-15T19:21:02.392285Z","steps":["trace[1339000627] 'read index received' (duration: 500.175949ms)","trace[1339000627] 'applied index is now lower than readState.Index' (duration: 138.864µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:02.392606Z","caller":"traceutil/trace.go:171","msg":"trace[536601251] transaction","detail":"{read_only:false; response_revision:8759; number_of_response:1; }","duration":"532.075154ms","start":"2026-10-15T19:21:01.860497Z","end":"2026-10-15T19:21:02.392572Z","steps":["trace[536601251] 'process raft request' (duration: 531.637453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:02.392705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:21:01.860468Z","time spent":"532.171546ms","remote":"127.0.0.1:48988","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-10-15T19:21:02.392921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.968109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-15T19:21:02.392947Z","caller":"traceutil/trace.go:171","msg":"trace[1236889015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8759; }","duration":"501.047081ms","start":"2026-10-15T19:21:01.891893Z","end":"2026-10-15T19:21:02.39294Z","steps":["trace[1236889015] 'agreement among raft nodes before linearized reading' (duration: 500.955838ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:02.392967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:21:01.891858Z","time spent":"501.101742ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-15T19:21:02.393821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.680723ms","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-10-15T19:21:02.393864Z","caller":"traceutil/trace.go:171","msg":"trace[55963486] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8760; }","duration":"367.777785ms","start":"2026-10-15T19:21:02.026076Z","end":"2026-10-15T19:21:02.393854Z","steps":["trace[55963486] 'agreement among raft nodes before linearized reading' (duration: 367.677753ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:02.393883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:21:02.026056Z","time spent":"367.823667ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T19:21:02.39383Z","caller":"traceutil/trace.go:171","msg":"trace[1941154469] transaction","detail":"{read_only:false; response_revision:8760; number_of_response:1; }","duration":"232.164375ms","start":"2026-10-15T19:21:02.161619Z","end":"2026-10-15T19:21:02.393784Z","steps":["trace[1941154469] 'process raft request' (duration: 232.085013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:02.393995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.445994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T19:21:02.394014Z","caller":"traceutil/trace.go:171","msg":"trace[1082036051] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8760; }","duration":"345.500915ms","start":"2026-10-15T19:21:02.048507Z","end":"2026-10-15T19:21:02.394008Z","steps":["trace[1082036051] 'agreement among raft nodes before linearized reading' (duration: 345.464714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:02.394029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:21:02.048485Z","time spent":"345.539455ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":30,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-10-15T19:21:13.569856Z","caller":"traceutil/trace.go:171","msg":"trace[1919790286] linearizableReadLoop","detail":"{readStateIndex:9131; appliedIndex:9130; }","duration":"169.506923ms","start":"2026-10-15T19:21:13.400326Z","end":"2026-10-15T19:21:13.569832Z","steps":["trace[1919790286] 'read index received' (duration: 169.220946ms)","trace[1919790286] 'applied index is now lower than readState.Index' (duration: 284.877µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:13.569936Z","caller":"traceutil/trace.go:171","msg":"trace[1228434007] transaction","detail":"{read_only:false; response_revision:8818; number_of_response:1; }","duration":"226.767527ms","start":"2026-10-15T19:21:13.343126Z","end":"2026-10-15T19:21:13.569893Z","steps":["trace[1228434007] 'process raft request' (duration: 226.50905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:13.570168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.226373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:21:13.570249Z","caller":"traceutil/trace.go:171","msg":"trace[257948870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8818; }","duration":"122.364117ms","start":"2026-10-15T19:21:13.447856Z","end":"2026-10-15T19:21:13.57022Z","steps":["trace[257948870] 'agreement among raft nodes before linearized reading' (duration: 122.171332ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:13.570219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.872752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T19:21:13.570336Z","caller":"traceutil/trace.go:171","msg":"trace[49243054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8818; }","duration":"170.050546ms","start":"2026-10-15T19:21:13.400265Z","end":"2026-10-15T19:21:13.570316Z","steps":["trace[49243054] 'agreement among raft nodes before linearized reading' (duration: 169.706358ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:15.499352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.091604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:21:15.499473Z","caller":"traceutil/trace.go:171","msg":"trace[2097558882] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8827; }","duration":"146.247477ms","start":"2026-10-15T19:21:15.353199Z","end":"2026-10-15T19:21:15.499447Z","steps":["trace[2097558882] 'range keys from in-memory index tree' (duration: 145.757236ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:15.834773Z","caller":"traceutil/trace.go:171","msg":"trace[1839217691] transaction","detail":"{read_only:false; response_revision:8830; number_of_response:1; }","duration":"217.762878ms","start":"2026-10-15T19:21:15.616965Z","end":"2026-10-15T19:21:15.834728Z","steps":["trace[1839217691] 'process raft request' (duration: 131.195742ms)","trace[1839217691] 'compare' (duration: 86.314119ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:15.834878Z","caller":"traceutil/trace.go:171","msg":"trace[359991324] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"146.230658ms","start":"2026-10-15T19:21:15.688637Z","end":"2026-10-15T19:21:15.834867Z","steps":["trace[359991324] 'process raft request' (duration: 146.050184ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:15.834762Z","caller":"traceutil/trace.go:171","msg":"trace[385223195] linearizableReadLoop","detail":"{readStateIndex:9143; appliedIndex:9142; }","duration":"190.767021ms","start":"2026-10-15T19:21:15.643963Z","end":"2026-10-15T19:21:15.83473Z","steps":["trace[385223195] 'read index received' (duration: 104.214135ms)","trace[385223195] 'applied index is now lower than readState.Index' (duration: 86.551836ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:21:15.835159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.166951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20207"} {"level":"info","ts":"2026-10-15T19:21:15.835261Z","caller":"traceutil/trace.go:171","msg":"trace[1080397587] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8831; }","duration":"191.344325ms","start":"2026-10-15T19:21:15.643896Z","end":"2026-10-15T19:21:15.83524Z","steps":["trace[1080397587] 'agreement among raft nodes before linearized reading' (duration: 190.929015ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:45.673333Z","caller":"traceutil/trace.go:171","msg":"trace[64420022] linearizableReadLoop","detail":"{readStateIndex:9367; appliedIndex:9366; }","duration":"278.123056ms","start":"2026-10-15T19:21:45.395175Z","end":"2026-10-15T19:21:45.673298Z","steps":["trace[64420022] 'read index received' (duration: 277.513451ms)","trace[64420022] 'applied index is now lower than readState.Index' (duration: 607.575µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:45.673381Z","caller":"traceutil/trace.go:171","msg":"trace[728274046] transaction","detail":"{read_only:false; response_revision:9045; number_of_response:1; }","duration":"417.6397ms","start":"2026-10-15T19:21:45.2557Z","end":"2026-10-15T19:21:45.67334Z","steps":["trace[728274046] 'process raft request' (duration: 417.078807ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:45.673596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.824164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:21:45.673672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:21:45.255592Z","time spent":"417.876706ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:21:45.673684Z","caller":"traceutil/trace.go:171","msg":"trace[1406251102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9045; }","duration":"218.975577ms","start":"2026-10-15T19:21:45.454692Z","end":"2026-10-15T19:21:45.673667Z","steps":["trace[1406251102] 'agreement among raft nodes before linearized reading' (duration: 218.820624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:45.673665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.428474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lzkvp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-15T19:21:45.673764Z","caller":"traceutil/trace.go:171","msg":"trace[29542720] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lzkvp; range_end:; response_count:1; response_revision:9045; }","duration":"278.637939ms","start":"2026-10-15T19:21:45.395105Z","end":"2026-10-15T19:21:45.673743Z","steps":["trace[29542720] 'agreement among raft nodes before linearized reading' (duration: 278.305691ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:47.94378Z","caller":"traceutil/trace.go:171","msg":"trace[110628016] linearizableReadLoop","detail":"{readStateIndex:9378; appliedIndex:9377; }","duration":"142.415814ms","start":"2026-10-15T19:21:47.801316Z","end":"2026-10-15T19:21:47.943732Z","steps":["trace[110628016] 'read index received' (duration: 141.749168ms)","trace[110628016] 'applied index is now lower than readState.Index' (duration: 665.556µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:47.943936Z","caller":"traceutil/trace.go:171","msg":"trace[1863466647] transaction","detail":"{read_only:false; response_revision:9056; number_of_response:1; }","duration":"150.210045ms","start":"2026-10-15T19:21:47.793689Z","end":"2026-10-15T19:21:47.943899Z","steps":["trace[1863466647] 'process raft request' (duration: 149.478457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:21:47.944856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.947837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T19:21:47.944953Z","caller":"traceutil/trace.go:171","msg":"trace[2054158819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9056; }","duration":"143.679514ms","start":"2026-10-15T19:21:47.801251Z","end":"2026-10-15T19:21:47.94493Z","steps":["trace[2054158819] 'agreement among raft nodes before linearized reading' (duration: 142.741862ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:56.146151Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024d3.wal"} {"level":"info","ts":"2026-10-15T19:21:56.146713Z","caller":"traceutil/trace.go:171","msg":"trace[563190165] transaction","detail":"{read_only:false; response_revision:9102; number_of_response:1; }","duration":"110.343224ms","start":"2026-10-15T19:21:56.036338Z","end":"2026-10-15T19:21:56.146681Z","steps":["trace[563190165] 'process raft request' (duration: 110.084208ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:21:57.076546Z","caller":"traceutil/trace.go:171","msg":"trace[1677261704] transaction","detail":"{read_only:false; response_revision:9108; number_of_response:1; }","duration":"184.375826ms","start":"2026-10-15T19:21:56.892115Z","end":"2026-10-15T19:21:57.076491Z","steps":["trace[1677261704] 'process raft request' (duration: 184.102499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:22:00.290215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.350878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:22:00.290525Z","caller":"traceutil/trace.go:171","msg":"trace[1393565838] transaction","detail":"{read_only:false; response_revision:9133; number_of_response:1; }","duration":"191.601561ms","start":"2026-10-15T19:22:00.098903Z","end":"2026-10-15T19:22:00.290504Z","steps":["trace[1393565838] 'process raft request' (duration: 191.439597ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:22:00.290759Z","caller":"traceutil/trace.go:171","msg":"trace[427818242] linearizableReadLoop","detail":"{readStateIndex:9457; appliedIndex:9456; }","duration":"201.497591ms","start":"2026-10-15T19:22:00.089222Z","end":"2026-10-15T19:22:00.29072Z","steps":["trace[427818242] 'read index received' (duration: 50.344994ms)","trace[427818242] 'applied index is now lower than readState.Index' (duration: 151.147577ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:22:00.290799Z","caller":"traceutil/trace.go:171","msg":"trace[650005369] transaction","detail":"{read_only:false; response_revision:9132; number_of_response:1; }","duration":"232.189468ms","start":"2026-10-15T19:22:00.058554Z","end":"2026-10-15T19:22:00.290743Z","steps":["trace[650005369] 'process raft request' (duration: 81.050851ms)","trace[650005369] 'compare' (duration: 150.076042ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:22:00.290999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.862789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-7cn5b\" ","response":"range_response_count:1 size:4665"} {"level":"info","ts":"2026-10-15T19:22:00.291046Z","caller":"traceutil/trace.go:171","msg":"trace[1479681550] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-7cn5b; range_end:; response_count:1; response_revision:9133; }","duration":"240.925031ms","start":"2026-10-15T19:22:00.050108Z","end":"2026-10-15T19:22:00.291033Z","steps":["trace[1479681550] 'agreement among raft nodes before linearized reading' (duration: 240.731316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:22:00.291132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.407549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-15T19:22:00.291208Z","caller":"traceutil/trace.go:171","msg":"trace[382220697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9133; }","duration":"127.528072ms","start":"2026-10-15T19:22:00.163666Z","end":"2026-10-15T19:22:00.291195Z","steps":["trace[382220697] 'agreement among raft nodes before linearized reading' (duration: 127.293086ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:22:00.291209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.453013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-7cn5b\" ","response":"range_response_count:1 size:4665"} {"level":"info","ts":"2026-10-15T19:22:00.291345Z","caller":"traceutil/trace.go:171","msg":"trace[601668217] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-7cn5b; range_end:; response_count:1; response_revision:9133; }","duration":"190.608227ms","start":"2026-10-15T19:22:00.100689Z","end":"2026-10-15T19:22:00.291297Z","steps":["trace[601668217] 'agreement among raft nodes before linearized reading' (duration: 190.262008ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:22:00.436067Z","caller":"traceutil/trace.go:171","msg":"trace[68509635] transaction","detail":"{read_only:false; response_revision:9134; number_of_response:1; }","duration":"138.555841ms","start":"2026-10-15T19:22:00.297475Z","end":"2026-10-15T19:22:00.436031Z","steps":["trace[68509635] 'process raft request' (duration: 130.793742ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:22:00.49884Z","caller":"traceutil/trace.go:171","msg":"trace[1530167413] transaction","detail":"{read_only:false; response_revision:9136; number_of_response:1; }","duration":"189.995422ms","start":"2026-10-15T19:22:00.308793Z","end":"2026-10-15T19:22:00.498789Z","steps":["trace[1530167413] 'process raft request' (duration: 189.810768ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:22:00.499165Z","caller":"traceutil/trace.go:171","msg":"trace[1208180039] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9135; }","duration":"198.358666ms","start":"2026-10-15T19:22:00.30077Z","end":"2026-10-15T19:22:00.499129Z","steps":["trace[1208180039] 'process raft request' (duration: 197.628198ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:22:59.779989Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:22:59.789111Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-15T19:22:59.789234Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-10-15T19:23:29.222475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.440553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-10-15T19:23:29.2226Z","caller":"traceutil/trace.go:171","msg":"trace[745488236] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:9979; }","duration":"157.659059ms","start":"2026-10-15T19:23:29.064915Z","end":"2026-10-15T19:23:29.222574Z","steps":["trace[745488236] 'range keys from in-memory index tree' (duration: 157.250728ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:23:29.222836Z","caller":"traceutil/trace.go:171","msg":"trace[97597508] linearizableReadLoop","detail":"{readStateIndex:10331; appliedIndex:10330; }","duration":"146.738233ms","start":"2026-10-15T19:23:29.076067Z","end":"2026-10-15T19:23:29.222806Z","steps":["trace[97597508] 'read index received' (duration: 140.00847ms)","trace[97597508] 'applied index is now lower than readState.Index' (duration: 6.727983ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:23:29.222919Z","caller":"traceutil/trace.go:171","msg":"trace[1563377842] transaction","detail":"{read_only:false; response_revision:9980; number_of_response:1; }","duration":"147.494251ms","start":"2026-10-15T19:23:29.075342Z","end":"2026-10-15T19:23:29.222836Z","steps":["trace[1563377842] 'process raft request' (duration: 140.701826ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:23:29.223258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.02716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-15T19:23:29.223424Z","caller":"traceutil/trace.go:171","msg":"trace[1964081605] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9980; }","duration":"147.41609ms","start":"2026-10-15T19:23:29.07599Z","end":"2026-10-15T19:23:29.223407Z","steps":["trace[1964081605] 'agreement among raft nodes before linearized reading' (duration: 146.931718ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:24:24.449553Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7982} {"level":"info","ts":"2026-10-15T19:24:24.542171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7982,"took":"89.36453ms","hash":2678364669,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":25554944,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-15T19:24:24.542319Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2678364669,"revision":7982,"compact-revision":5555} {"level":"info","ts":"2026-10-15T19:29:24.458654Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10373} {"level":"info","ts":"2026-10-15T19:29:24.552291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10373,"took":"90.520126ms","hash":1276552791,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":26091520,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-15T19:29:24.552376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1276552791,"revision":10373,"compact-revision":7982} {"level":"info","ts":"2026-10-15T19:34:24.469228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12527} {"level":"info","ts":"2026-10-15T19:34:24.565664Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12527,"took":"92.887154ms","hash":1951977849,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":28147712,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T19:34:24.565751Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1951977849,"revision":12527,"compact-revision":10373} {"level":"warn","ts":"2026-10-15T19:34:45.667342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.411092ms","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-10-15T19:34:45.667462Z","caller":"traceutil/trace.go:171","msg":"trace[152248760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14686; }","duration":"101.602888ms","start":"2026-10-15T19:34:45.56584Z","end":"2026-10-15T19:34:45.667443Z","steps":["trace[152248760] 'range keys from in-memory index tree' (duration: 101.247618ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:34:45.797415Z","caller":"traceutil/trace.go:171","msg":"trace[1913457548] transaction","detail":"{read_only:false; response_revision:14689; number_of_response:1; }","duration":"124.332269ms","start":"2026-10-15T19:34:45.673045Z","end":"2026-10-15T19:34:45.797378Z","steps":["trace[1913457548] 'process raft request' (duration: 124.137955ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:35:36.149066Z","caller":"traceutil/trace.go:171","msg":"trace[713823957] linearizableReadLoop","detail":"{readStateIndex:15528; appliedIndex:15527; }","duration":"112.386429ms","start":"2026-10-15T19:35:36.036642Z","end":"2026-10-15T19:35:36.149028Z","steps":["trace[713823957] 'read index received' (duration: 112.259996ms)","trace[713823957] 'applied index is now lower than readState.Index' (duration: 124.963µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:35:36.149491Z","caller":"traceutil/trace.go:171","msg":"trace[1324640667] transaction","detail":"{read_only:false; response_revision:15006; number_of_response:1; }","duration":"225.250749ms","start":"2026-10-15T19:35:35.924228Z","end":"2026-10-15T19:35:36.149478Z","steps":["trace[1324640667] 'process raft request' (duration: 224.590113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:36.149869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.212519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T19:35:36.149933Z","caller":"traceutil/trace.go:171","msg":"trace[555531779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15006; }","duration":"113.331383ms","start":"2026-10-15T19:35:36.036571Z","end":"2026-10-15T19:35:36.149902Z","steps":["trace[555531779] 'agreement among raft nodes before linearized reading' (duration: 113.165489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:45.619382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.873209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:35:45.619508Z","caller":"traceutil/trace.go:171","msg":"trace[1383647680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15054; }","duration":"171.058953ms","start":"2026-10-15T19:35:45.448418Z","end":"2026-10-15T19:35:45.619477Z","steps":["trace[1383647680] 'range keys from in-memory index tree' (duration: 170.767096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:45.619703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.375181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:35:45.620036Z","caller":"traceutil/trace.go:171","msg":"trace[275366064] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:15054; }","duration":"108.74226ms","start":"2026-10-15T19:35:45.511263Z","end":"2026-10-15T19:35:45.620005Z","steps":["trace[275366064] 'count revisions from in-memory index tree' (duration: 108.275868ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:35:54.466855Z","caller":"traceutil/trace.go:171","msg":"trace[2017061564] linearizableReadLoop","detail":"{readStateIndex:15642; appliedIndex:15641; }","duration":"132.59544ms","start":"2026-10-15T19:35:54.334233Z","end":"2026-10-15T19:35:54.466828Z","steps":["trace[2017061564] 'read index received' (duration: 132.364874ms)","trace[2017061564] 'applied index is now lower than readState.Index' (duration: 228.706µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:35:54.46722Z","caller":"traceutil/trace.go:171","msg":"trace[395415138] transaction","detail":"{read_only:false; response_revision:15114; number_of_response:1; }","duration":"160.156228ms","start":"2026-10-15T19:35:54.307052Z","end":"2026-10-15T19:35:54.467208Z","steps":["trace[395415138] 'process raft request' (duration: 159.545673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:54.467497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.247934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-15T19:35:54.467539Z","caller":"traceutil/trace.go:171","msg":"trace[421401860] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15114; }","duration":"133.339927ms","start":"2026-10-15T19:35:54.334181Z","end":"2026-10-15T19:35:54.467521Z","steps":["trace[421401860] 'agreement among raft nodes before linearized reading' (duration: 133.207424ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:54.467783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.802386ms","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-10-15T19:35:54.467822Z","caller":"traceutil/trace.go:171","msg":"trace[347357418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15114; }","duration":"116.901698ms","start":"2026-10-15T19:35:54.350908Z","end":"2026-10-15T19:35:54.46781Z","steps":["trace[347357418] 'agreement among raft nodes before linearized reading' (duration: 116.791745ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:35:55.407153Z","caller":"traceutil/trace.go:171","msg":"trace[1414725871] linearizableReadLoop","detail":"{readStateIndex:15648; appliedIndex:15647; }","duration":"188.377274ms","start":"2026-10-15T19:35:55.218753Z","end":"2026-10-15T19:35:55.407131Z","steps":["trace[1414725871] 'read index received' (duration: 188.162539ms)","trace[1414725871] 'applied index is now lower than readState.Index' (duration: 213.585µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:35:55.407383Z","caller":"traceutil/trace.go:171","msg":"trace[78363244] transaction","detail":"{read_only:false; response_revision:15120; number_of_response:1; }","duration":"367.114823ms","start":"2026-10-15T19:35:55.040259Z","end":"2026-10-15T19:35:55.407373Z","steps":["trace[78363244] 'process raft request' (duration: 366.729074ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:35:55.407518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:35:55.040225Z","time spent":"367.184955ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:35:55.40775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.011459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lzkvp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-15T19:35:55.407781Z","caller":"traceutil/trace.go:171","msg":"trace[1857621543] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lzkvp; range_end:; response_count:1; response_revision:15120; }","duration":"189.086631ms","start":"2026-10-15T19:35:55.218686Z","end":"2026-10-15T19:35:55.407773Z","steps":["trace[1857621543] 'agreement among raft nodes before linearized reading' (duration: 188.977809ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:35:57.857826Z","caller":"traceutil/trace.go:171","msg":"trace[1955403366] transaction","detail":"{read_only:false; response_revision:15141; number_of_response:1; }","duration":"107.206302ms","start":"2026-10-15T19:35:57.750557Z","end":"2026-10-15T19:35:57.857764Z","steps":["trace[1955403366] 'process raft request' (duration: 106.945286ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:36:05.889703Z","caller":"traceutil/trace.go:171","msg":"trace[96759277] transaction","detail":"{read_only:false; response_revision:15293; number_of_response:1; }","duration":"115.466202ms","start":"2026-10-15T19:36:05.774202Z","end":"2026-10-15T19:36:05.889668Z","steps":["trace[96759277] 'process raft request' (duration: 115.237608ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:36:06.032847Z","caller":"traceutil/trace.go:171","msg":"trace[919527413] linearizableReadLoop","detail":"{readStateIndex:15825; appliedIndex:15824; }","duration":"132.000705ms","start":"2026-10-15T19:36:05.900811Z","end":"2026-10-15T19:36:06.032812Z","steps":["trace[919527413] 'read index received' (duration: 74.256293ms)","trace[919527413] 'applied index is now lower than readState.Index' (duration: 57.742892ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:36:06.033172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.338804ms","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-10-15T19:36:06.033215Z","caller":"traceutil/trace.go:171","msg":"trace[775004830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15294; }","duration":"132.452545ms","start":"2026-10-15T19:36:05.90075Z","end":"2026-10-15T19:36:06.033203Z","steps":["trace[775004830] 'agreement among raft nodes before linearized reading' (duration: 132.22684ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:36:06.033264Z","caller":"traceutil/trace.go:171","msg":"trace[2130878380] transaction","detail":"{read_only:false; response_revision:15294; number_of_response:1; }","duration":"137.128749ms","start":"2026-10-15T19:36:05.895851Z","end":"2026-10-15T19:36:06.032979Z","steps":["trace[2130878380] 'process raft request' (duration: 79.265354ms)","trace[2130878380] 'compare' (duration: 57.27844ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:36:06.324986Z","caller":"traceutil/trace.go:171","msg":"trace[526928203] transaction","detail":"{read_only:false; response_revision:15296; number_of_response:1; }","duration":"287.541941ms","start":"2026-10-15T19:36:06.037414Z","end":"2026-10-15T19:36:06.324956Z","steps":["trace[526928203] 'process raft request' (duration: 209.959658ms)","trace[526928203] 'compare' (duration: 77.263335ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:36:06.32525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.986985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-gstkw.18decb0e742e6892\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-10-15T19:36:06.325342Z","caller":"traceutil/trace.go:171","msg":"trace[660325596] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-gstkw.18decb0e742e6892; range_end:; response_count:1; response_revision:15296; }","duration":"111.145998ms","start":"2026-10-15T19:36:06.214169Z","end":"2026-10-15T19:36:06.325315Z","steps":["trace[660325596] 'agreement among raft nodes before linearized reading' (duration: 110.882501ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:36:06.324974Z","caller":"traceutil/trace.go:171","msg":"trace[773331249] linearizableReadLoop","detail":"{readStateIndex:15827; appliedIndex:15826; }","duration":"110.648626ms","start":"2026-10-15T19:36:06.214259Z","end":"2026-10-15T19:36:06.324908Z","steps":["trace[773331249] 'read index received' (duration: 33.143385ms)","trace[773331249] 'applied index is now lower than readState.Index' (duration: 77.503081ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:37:15.607468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.810237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:37:15.607582Z","caller":"traceutil/trace.go:171","msg":"trace[917365188] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16227; }","duration":"106.95615ms","start":"2026-10-15T19:37:15.5006Z","end":"2026-10-15T19:37:15.607556Z","steps":["trace[917365188] 'range keys from in-memory index tree' (duration: 106.683204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:15.608066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.624257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"warn","ts":"2026-10-15T19:37:15.608039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.396369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-15T19:37:15.608127Z","caller":"traceutil/trace.go:171","msg":"trace[1517942753] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16227; }","duration":"107.742219ms","start":"2026-10-15T19:37:15.500371Z","end":"2026-10-15T19:37:15.608113Z","steps":["trace[1517942753] 'range keys from in-memory index tree' (duration: 107.416092ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:15.608224Z","caller":"traceutil/trace.go:171","msg":"trace[1988429355] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16227; }","duration":"102.599045ms","start":"2026-10-15T19:37:15.505535Z","end":"2026-10-15T19:37:15.608134Z","steps":["trace[1988429355] 'range keys from in-memory index tree' (duration: 101.998129ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:50.606506Z","caller":"traceutil/trace.go:171","msg":"trace[1787569937] transaction","detail":"{read_only:false; response_revision:16409; number_of_response:1; }","duration":"106.666354ms","start":"2026-10-15T19:37:50.499797Z","end":"2026-10-15T19:37:50.606463Z","steps":["trace[1787569937] 'process raft request' (duration: 106.406368ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:50.964133Z","caller":"traceutil/trace.go:171","msg":"trace[916313890] transaction","detail":"{read_only:false; response_revision:16410; number_of_response:1; }","duration":"142.566786ms","start":"2026-10-15T19:37:50.821521Z","end":"2026-10-15T19:37:50.964087Z","steps":["trace[916313890] 'process raft request' (duration: 142.30614ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:39:24.476962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14559} {"level":"info","ts":"2026-10-15T19:39:24.566678Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14559,"took":"86.118424ms","hash":2178961505,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":31313920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T19:39:24.56713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2178961505,"revision":14559,"compact-revision":12527} {"level":"info","ts":"2026-10-15T19:43:29.948767Z","caller":"traceutil/trace.go:171","msg":"trace[2070440072] linearizableReadLoop","detail":"{readStateIndex:19527; appliedIndex:19526; }","duration":"147.964244ms","start":"2026-10-15T19:43:29.800768Z","end":"2026-10-15T19:43:29.948733Z","steps":["trace[2070440072] 'read index received' (duration: 147.659446ms)","trace[2070440072] 'applied index is now lower than readState.Index' (duration: 303.748µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:43:29.948949Z","caller":"traceutil/trace.go:171","msg":"trace[531076851] transaction","detail":"{read_only:false; response_revision:18879; number_of_response:1; }","duration":"220.283009ms","start":"2026-10-15T19:43:29.728614Z","end":"2026-10-15T19:43:29.948897Z","steps":["trace[531076851] 'process raft request' (duration: 219.88947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:29.949128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.313531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:43:29.949216Z","caller":"traceutil/trace.go:171","msg":"trace[1202632207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:18879; }","duration":"148.466935ms","start":"2026-10-15T19:43:29.800727Z","end":"2026-10-15T19:43:29.949194Z","steps":["trace[1202632207] 'agreement among raft nodes before linearized reading' (duration: 148.25771ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:29.949265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.502458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-15T19:43:29.949331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.216477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-10-15T19:43:29.949338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.852742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-10-15T19:43:29.949373Z","caller":"traceutil/trace.go:171","msg":"trace[1199790471] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:18879; }","duration":"119.676312ms","start":"2026-10-15T19:43:29.829675Z","end":"2026-10-15T19:43:29.949351Z","steps":["trace[1199790471] 'agreement among raft nodes before linearized reading' (duration: 119.429806ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:29.949387Z","caller":"traceutil/trace.go:171","msg":"trace[452877668] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18879; }","duration":"100.292458ms","start":"2026-10-15T19:43:29.849077Z","end":"2026-10-15T19:43:29.949369Z","steps":["trace[452877668] 'agreement among raft nodes before linearized reading' (duration: 100.062063ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:29.949434Z","caller":"traceutil/trace.go:171","msg":"trace[1637437017] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18879; }","duration":"118.960724ms","start":"2026-10-15T19:43:29.830449Z","end":"2026-10-15T19:43:29.94941Z","steps":["trace[1637437017] 'agreement among raft nodes before linearized reading' (duration: 118.708968ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:30.286306Z","caller":"traceutil/trace.go:171","msg":"trace[271203982] linearizableReadLoop","detail":"{readStateIndex:19528; appliedIndex:19527; }","duration":"159.083944ms","start":"2026-10-15T19:43:30.127193Z","end":"2026-10-15T19:43:30.286277Z","steps":["trace[271203982] 'read index received' (duration: 158.850588ms)","trace[271203982] 'applied index is now lower than readState.Index' (duration: 228.076µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:43:30.286373Z","caller":"traceutil/trace.go:171","msg":"trace[534531668] transaction","detail":"{read_only:false; response_revision:18880; number_of_response:1; }","duration":"207.334893ms","start":"2026-10-15T19:43:30.078979Z","end":"2026-10-15T19:43:30.286314Z","steps":["trace[534531668] 'process raft request' (duration: 207.100337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:30.286548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.31589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:43:30.286642Z","caller":"traceutil/trace.go:171","msg":"trace[1386010183] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:18880; }","duration":"159.460633ms","start":"2026-10-15T19:43:30.127156Z","end":"2026-10-15T19:43:30.286617Z","steps":["trace[1386010183] 'agreement among raft nodes before linearized reading' (duration: 159.228668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:30.603212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.284222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-10-15T19:43:30.603301Z","caller":"traceutil/trace.go:171","msg":"trace[1157759313] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18880; }","duration":"300.416806ms","start":"2026-10-15T19:43:30.302866Z","end":"2026-10-15T19:43:30.603282Z","steps":["trace[1157759313] 'range keys from in-memory index tree' (duration: 300.106428ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:30.603343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:43:30.302855Z","time spent":"300.478617ms","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-15T19:43:30.603424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.385223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-15T19:43:30.603555Z","caller":"traceutil/trace.go:171","msg":"trace[1887637382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18880; }","duration":"302.577708ms","start":"2026-10-15T19:43:30.300945Z","end":"2026-10-15T19:43:30.603523Z","steps":["trace[1887637382] 'range keys from in-memory index tree' (duration: 302.118667ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:30.603631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:43:30.300922Z","time spent":"302.692431ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T19:43:30.603776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.702563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:43:30.603814Z","caller":"traceutil/trace.go:171","msg":"trace[1604690437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18880; }","duration":"154.539144ms","start":"2026-10-15T19:43:30.449264Z","end":"2026-10-15T19:43:30.603803Z","steps":["trace[1604690437] 'range keys from in-memory index tree' (duration: 153.536279ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:30.629019Z","caller":"traceutil/trace.go:171","msg":"trace[546742397] transaction","detail":"{read_only:false; response_revision:18881; number_of_response:1; }","duration":"169.93367ms","start":"2026-10-15T19:43:30.459043Z","end":"2026-10-15T19:43:30.628976Z","steps":["trace[546742397] 'process raft request' (duration: 169.723175ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:30.649132Z","caller":"traceutil/trace.go:171","msg":"trace[507243873] transaction","detail":"{read_only:false; response_revision:18882; number_of_response:1; }","duration":"185.011318ms","start":"2026-10-15T19:43:30.464096Z","end":"2026-10-15T19:43:30.649107Z","steps":["trace[507243873] 'process raft request' (duration: 184.777012ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:30.649318Z","caller":"traceutil/trace.go:171","msg":"trace[1108313673] linearizableReadLoop","detail":"{readStateIndex:19530; appliedIndex:19528; }","duration":"119.775295ms","start":"2026-10-15T19:43:30.529513Z","end":"2026-10-15T19:43:30.649288Z","steps":["trace[1108313673] 'read index received' (duration: 99.233593ms)","trace[1108313673] 'applied index is now lower than readState.Index' (duration: 20.540262ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:43:30.649495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.964039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-qt9vw\" ","response":"range_response_count:1 size:22126"} {"level":"info","ts":"2026-10-15T19:43:30.649528Z","caller":"traceutil/trace.go:171","msg":"trace[791532873] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-qt9vw; range_end:; response_count:1; response_revision:18883; }","duration":"120.090362ms","start":"2026-10-15T19:43:30.529428Z","end":"2026-10-15T19:43:30.649518Z","steps":["trace[791532873] 'agreement among raft nodes before linearized reading' (duration: 119.964999ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:44:15.784697Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:44:15.791452Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-15T19:44:15.791586Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-15T19:44:24.489977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17025} {"level":"info","ts":"2026-10-15T19:44:24.602666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17025,"took":"106.045559ms","hash":339050242,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":32829440,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T19:44:24.602776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":339050242,"revision":17025,"compact-revision":14559} {"level":"info","ts":"2026-10-15T19:45:38.97732Z","caller":"traceutil/trace.go:171","msg":"trace[1546006832] transaction","detail":"{read_only:false; response_revision:20117; number_of_response:1; }","duration":"124.163232ms","start":"2026-10-15T19:45:38.853116Z","end":"2026-10-15T19:45:38.977279Z","steps":["trace[1546006832] 'process raft request' (duration: 112.767694ms)","trace[1546006832] 'compare' (duration: 10.707041ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:24.513456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19416} {"level":"info","ts":"2026-10-15T19:49:24.629959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19416,"took":"112.577179ms","hash":3597024165,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":30236672,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T19:49:24.630065Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3597024165,"revision":19416,"compact-revision":17025} {"level":"info","ts":"2026-10-15T19:49:56.259585Z","caller":"traceutil/trace.go:171","msg":"trace[237090434] transaction","detail":"{read_only:false; response_revision:21820; number_of_response:1; }","duration":"137.25197ms","start":"2026-10-15T19:49:56.122305Z","end":"2026-10-15T19:49:56.259557Z","steps":["trace[237090434] 'process raft request' (duration: 137.075425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:56.622403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.861758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:49:56.622554Z","caller":"traceutil/trace.go:171","msg":"trace[95114271] linearizableReadLoop","detail":"{readStateIndex:22566; appliedIndex:22565; }","duration":"289.76142ms","start":"2026-10-15T19:49:56.332772Z","end":"2026-10-15T19:49:56.622533Z","steps":["trace[95114271] 'read index received' (duration: 171.649856ms)","trace[95114271] 'applied index is now lower than readState.Index' (duration: 118.109694ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:49:56.62275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.989416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-15T19:49:56.622715Z","caller":"traceutil/trace.go:171","msg":"trace[401428841] transaction","detail":"{read_only:false; response_revision:21821; number_of_response:1; }","duration":"320.867927ms","start":"2026-10-15T19:49:56.30179Z","end":"2026-10-15T19:49:56.622658Z","steps":["trace[401428841] 'process raft request' (duration: 202.602879ms)","trace[401428841] 'compare' (duration: 117.443138ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:56.622789Z","caller":"traceutil/trace.go:171","msg":"trace[1024592311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21821; }","duration":"290.081668ms","start":"2026-10-15T19:49:56.332697Z","end":"2026-10-15T19:49:56.622778Z","steps":["trace[1024592311] 'agreement among raft nodes before linearized reading' (duration: 289.889763ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:56.622995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:49:56.301756Z","time spent":"321.074892ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:49:56.706278Z","caller":"traceutil/trace.go:171","msg":"trace[1066911680] transaction","detail":"{read_only:false; response_revision:21822; number_of_response:1; }","duration":"264.463606ms","start":"2026-10-15T19:49:56.441776Z","end":"2026-10-15T19:49:56.70624Z","steps":["trace[1066911680] 'process raft request' (duration: 264.22889ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:56.706502Z","caller":"traceutil/trace.go:171","msg":"trace[312657975] transaction","detail":"{read_only:false; response_revision:21823; number_of_response:1; }","duration":"226.883461ms","start":"2026-10-15T19:49:56.479567Z","end":"2026-10-15T19:49:56.70645Z","steps":["trace[312657975] 'process raft request' (duration: 226.622914ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:56.920704Z","caller":"traceutil/trace.go:171","msg":"trace[417587601] linearizableReadLoop","detail":"{readStateIndex:22569; appliedIndex:22568; }","duration":"147.889508ms","start":"2026-10-15T19:49:56.772769Z","end":"2026-10-15T19:49:56.920658Z","steps":["trace[417587601] 'read index received' (duration: 58.155425ms)","trace[417587601] 'applied index is now lower than readState.Index' (duration: 89.732093ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:56.920772Z","caller":"traceutil/trace.go:171","msg":"trace[561524756] transaction","detail":"{read_only:false; response_revision:21824; number_of_response:1; }","duration":"292.6465ms","start":"2026-10-15T19:49:56.62808Z","end":"2026-10-15T19:49:56.920727Z","steps":["trace[561524756] 'process raft request' (duration: 202.926997ms)","trace[561524756] 'compare' (duration: 89.458907ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:49:56.921096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.3572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-10-15T19:49:56.921225Z","caller":"traceutil/trace.go:171","msg":"trace[1948681474] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:21824; }","duration":"148.576615ms","start":"2026-10-15T19:49:56.772621Z","end":"2026-10-15T19:49:56.921198Z","steps":["trace[1948681474] 'agreement among raft nodes before linearized reading' (duration: 148.196395ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:57.241658Z","caller":"traceutil/trace.go:171","msg":"trace[838929437] transaction","detail":"{read_only:false; response_revision:21826; number_of_response:1; }","duration":"224.047681ms","start":"2026-10-15T19:49:57.017577Z","end":"2026-10-15T19:49:57.241625Z","steps":["trace[838929437] 'process raft request' (duration: 173.905011ms)","trace[838929437] 'compare' (duration: 49.681739ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:49:57.600789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.869175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:49:57.600915Z","caller":"traceutil/trace.go:171","msg":"trace[1778745777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21827; }","duration":"152.06558ms","start":"2026-10-15T19:49:57.448807Z","end":"2026-10-15T19:49:57.600873Z","steps":["trace[1778745777] 'range keys from in-memory index tree' (duration: 151.626549ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:57.890531Z","caller":"traceutil/trace.go:171","msg":"trace[1007907652] linearizableReadLoop","detail":"{readStateIndex:22573; appliedIndex:22572; }","duration":"102.386762ms","start":"2026-10-15T19:49:57.788105Z","end":"2026-10-15T19:49:57.890491Z","steps":["trace[1007907652] 'read index received' (duration: 102.128076ms)","trace[1007907652] 'applied index is now lower than readState.Index' (duration: 256.536µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:57.890566Z","caller":"traceutil/trace.go:171","msg":"trace[1476423405] transaction","detail":"{read_only:false; response_revision:21828; number_of_response:1; }","duration":"125.860572ms","start":"2026-10-15T19:49:57.764664Z","end":"2026-10-15T19:49:57.890525Z","steps":["trace[1476423405] 'process raft request' (duration: 125.581995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:57.89098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.794652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-15T19:49:57.89112Z","caller":"traceutil/trace.go:171","msg":"trace[969813213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21828; }","duration":"103.065899ms","start":"2026-10-15T19:49:57.788021Z","end":"2026-10-15T19:49:57.891087Z","steps":["trace[969813213] 'agreement among raft nodes before linearized reading' (duration: 102.597147ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:58.094695Z","caller":"traceutil/trace.go:171","msg":"trace[197461226] transaction","detail":"{read_only:false; response_revision:21829; number_of_response:1; }","duration":"183.66351ms","start":"2026-10-15T19:49:57.910992Z","end":"2026-10-15T19:49:58.094656Z","steps":["trace[197461226] 'process raft request' (duration: 183.474065ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:58.103226Z","caller":"traceutil/trace.go:171","msg":"trace[1895365073] linearizableReadLoop","detail":"{readStateIndex:22575; appliedIndex:22574; }","duration":"156.521579ms","start":"2026-10-15T19:49:57.946676Z","end":"2026-10-15T19:49:58.103198Z","steps":["trace[1895365073] 'read index received' (duration: 147.981221ms)","trace[1895365073] 'applied index is now lower than readState.Index' (duration: 8.539038ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:58.103333Z","caller":"traceutil/trace.go:171","msg":"trace[1080158758] transaction","detail":"{read_only:false; response_revision:21830; number_of_response:1; }","duration":"192.255779ms","start":"2026-10-15T19:49:57.911018Z","end":"2026-10-15T19:49:58.103274Z","steps":["trace[1080158758] 'process raft request' (duration: 192.007372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:58.103456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.760704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.179\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-15T19:49:58.103523Z","caller":"traceutil/trace.go:171","msg":"trace[79443039] range","detail":"{range_begin:/registry/masterleases/162.253.55.179; range_end:; response_count:1; response_revision:21830; }","duration":"156.891327ms","start":"2026-10-15T19:49:57.946612Z","end":"2026-10-15T19:49:58.103504Z","steps":["trace[79443039] 'agreement among raft nodes before linearized reading' (duration: 156.689822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:58.426582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.362358ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:49:58.426852Z","caller":"traceutil/trace.go:171","msg":"trace[1509019845] linearizableReadLoop","detail":"{readStateIndex:22578; appliedIndex:22576; }","duration":"103.186261ms","start":"2026-10-15T19:49:58.323637Z","end":"2026-10-15T19:49:58.426824Z","steps":["trace[1509019845] 'read index received' (duration: 41.755756ms)","trace[1509019845] 'applied index is now lower than readState.Index' (duration: 61.428615ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:49:58.426979Z","caller":"traceutil/trace.go:171","msg":"trace[1129466618] transaction","detail":"{read_only:false; response_revision:21832; number_of_response:1; }","duration":"159.759648ms","start":"2026-10-15T19:49:58.267194Z","end":"2026-10-15T19:49:58.426954Z","steps":["trace[1129466618] 'process raft request' (duration: 159.535292ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:49:58.427046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.397946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T19:49:58.427104Z","caller":"traceutil/trace.go:171","msg":"trace[722381164] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:21832; }","duration":"103.496608ms","start":"2026-10-15T19:49:58.323586Z","end":"2026-10-15T19:49:58.427082Z","steps":["trace[722381164] 'agreement among raft nodes before linearized reading' (duration: 103.357775ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:49:58.426853Z","caller":"traceutil/trace.go:171","msg":"trace[1024464259] transaction","detail":"{read_only:false; response_revision:21831; number_of_response:1; }","duration":"300.513212ms","start":"2026-10-15T19:49:58.126296Z","end":"2026-10-15T19:49:58.426809Z","steps":["trace[1024464259] 'process raft request' (duration: 156.784195ms)","trace[1024464259] 'compare' (duration: 143.131703ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:49:58.42749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:49:58.126272Z","time spent":"301.024435ms","remote":"127.0.0.1:48728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:51:24.815119Z","caller":"traceutil/trace.go:171","msg":"trace[1595451869] transaction","detail":"{read_only:false; response_revision:22619; number_of_response:1; }","duration":"101.008418ms","start":"2026-10-15T19:51:24.714088Z","end":"2026-10-15T19:51:24.815096Z","steps":["trace[1595451869] 'process raft request' (duration: 100.786723ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:54:13.017579Z","caller":"traceutil/trace.go:171","msg":"trace[1790365861] transaction","detail":"{read_only:false; response_revision:24403; number_of_response:1; }","duration":"209.938778ms","start":"2026-10-15T19:54:12.807592Z","end":"2026-10-15T19:54:13.017531Z","steps":["trace[1790365861] 'process raft request' (duration: 209.442146ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:54:13.01781Z","caller":"traceutil/trace.go:171","msg":"trace[160585168] linearizableReadLoop","detail":"{readStateIndex:25228; appliedIndex:25226; }","duration":"161.879088ms","start":"2026-10-15T19:54:12.855876Z","end":"2026-10-15T19:54:13.017755Z","steps":["trace[160585168] 'read index received' (duration: 160.968197ms)","trace[160585168] 'applied index is now lower than readState.Index' (duration: 907.131µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:54:13.018045Z","caller":"traceutil/trace.go:171","msg":"trace[1754375137] transaction","detail":"{read_only:false; response_revision:24404; number_of_response:1; }","duration":"181.537537ms","start":"2026-10-15T19:54:12.836429Z","end":"2026-10-15T19:54:13.017967Z","steps":["trace[1754375137] 'process raft request' (duration: 181.025114ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:54:13.018203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.313089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-15T19:54:13.018253Z","caller":"traceutil/trace.go:171","msg":"trace[1838965118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24404; }","duration":"162.448702ms","start":"2026-10-15T19:54:12.855791Z","end":"2026-10-15T19:54:13.01824Z","steps":["trace[1838965118] 'agreement among raft nodes before linearized reading' (duration: 162.168156ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:54:13.372463Z","caller":"traceutil/trace.go:171","msg":"trace[1171158645] transaction","detail":"{read_only:false; response_revision:24405; number_of_response:1; }","duration":"347.581288ms","start":"2026-10-15T19:54:13.024835Z","end":"2026-10-15T19:54:13.372416Z","steps":["trace[1171158645] 'process raft request' (duration: 260.672843ms)","trace[1171158645] 'compare' (duration: 86.645518ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:54:13.372784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:54:13.024801Z","time spent":"347.878474ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:54:13.377729Z","caller":"traceutil/trace.go:171","msg":"trace[1275548081] linearizableReadLoop","detail":"{readStateIndex:25230; appliedIndex:25228; }","duration":"281.192332ms","start":"2026-10-15T19:54:13.096469Z","end":"2026-10-15T19:54:13.377662Z","steps":["trace[1275548081] 'read index received' (duration: 189.073141ms)","trace[1275548081] 'applied index is now lower than readState.Index' (duration: 92.06832ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:54:13.377895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.416748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-15T19:54:13.377983Z","caller":"traceutil/trace.go:171","msg":"trace[591190112] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24405; }","duration":"281.565312ms","start":"2026-10-15T19:54:13.096404Z","end":"2026-10-15T19:54:13.37797Z","steps":["trace[591190112] 'agreement among raft nodes before linearized reading' (duration: 281.306555ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:54:24.524359Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21658} {"level":"info","ts":"2026-10-15T19:54:24.642461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21658,"took":"113.890781ms","hash":3824431119,"current-db-size-bytes":55369728,"current-db-size":"55 MB","current-db-size-in-use-bytes":42467328,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-15T19:54:24.642554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3824431119,"revision":21658,"compact-revision":19416} {"level":"info","ts":"2026-10-15T19:56:41.355307Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000687f.wal"} {"level":"info","ts":"2026-10-15T19:57:51.203247Z","caller":"traceutil/trace.go:171","msg":"trace[1149639503] transaction","detail":"{read_only:false; response_revision:26522; number_of_response:1; }","duration":"198.312105ms","start":"2026-10-15T19:57:51.004907Z","end":"2026-10-15T19:57:51.203219Z","steps":["trace[1149639503] 'process raft request' (duration: 198.135421ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.555943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.110222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:57:51.556286Z","caller":"traceutil/trace.go:171","msg":"trace[645923159] transaction","detail":"{read_only:false; response_revision:26523; number_of_response:1; }","duration":"535.589361ms","start":"2026-10-15T19:57:51.020642Z","end":"2026-10-15T19:57:51.556231Z","steps":["trace[645923159] 'process raft request' (duration: 354.991837ms)","trace[645923159] 'compare' (duration: 179.949349ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:57:51.556467Z","caller":"traceutil/trace.go:171","msg":"trace[848680094] linearizableReadLoop","detail":"{readStateIndex:27401; appliedIndex:27398; }","duration":"486.24156ms","start":"2026-10-15T19:57:51.070199Z","end":"2026-10-15T19:57:51.55644Z","steps":["trace[848680094] 'read index received' (duration: 132.953724ms)","trace[848680094] 'applied index is now lower than readState.Index' (duration: 353.285686ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:57:51.556506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.020619Z","time spent":"535.767865ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:57:51.556624Z","caller":"traceutil/trace.go:171","msg":"trace[476851621] transaction","detail":"{read_only:false; response_revision:26524; number_of_response:1; }","duration":"493.106878ms","start":"2026-10-15T19:57:51.0635Z","end":"2026-10-15T19:57:51.556607Z","steps":["trace[476851621] 'process raft request' (duration: 492.840772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.556888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.676121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-15T19:57:51.556889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.955711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T19:57:51.556889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.605582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:57:51.556965Z","caller":"traceutil/trace.go:171","msg":"trace[546575789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26524; }","duration":"486.784844ms","start":"2026-10-15T19:57:51.07016Z","end":"2026-10-15T19:57:51.556945Z","steps":["trace[546575789] 'agreement among raft nodes before linearized reading' (duration: 486.522687ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:57:51.556978Z","caller":"traceutil/trace.go:171","msg":"trace[637832478] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:26524; }","duration":"356.142185ms","start":"2026-10-15T19:57:51.200814Z","end":"2026-10-15T19:57:51.556956Z","steps":["trace[637832478] 'agreement among raft nodes before linearized reading' (duration: 355.94859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.556983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.051148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-10-15T19:57:51.557018Z","caller":"traceutil/trace.go:171","msg":"trace[1454733070] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:26524; }","duration":"445.766946ms","start":"2026-10-15T19:57:51.111203Z","end":"2026-10-15T19:57:51.55697Z","steps":["trace[1454733070] 'agreement among raft nodes before linearized reading' (duration: 445.552851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.556893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.345421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-15T19:57:51.55703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.200793Z","time spent":"356.225087ms","remote":"127.0.0.1:45066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-10-15T19:57:51.557058Z","caller":"traceutil/trace.go:171","msg":"trace[2105882463] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26524; }","duration":"334.161361ms","start":"2026-10-15T19:57:51.222871Z","end":"2026-10-15T19:57:51.557032Z","steps":["trace[2105882463] 'agreement among raft nodes before linearized reading' (duration: 333.848453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.557072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.111193Z","time spent":"445.862788ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"info","ts":"2026-10-15T19:57:51.557082Z","caller":"traceutil/trace.go:171","msg":"trace[69851926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26524; }","duration":"474.584657ms","start":"2026-10-15T19:57:51.082476Z","end":"2026-10-15T19:57:51.557061Z","steps":["trace[69851926] 'agreement among raft nodes before linearized reading' (duration: 474.209957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.557118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.222836Z","time spent":"334.268214ms","remote":"127.0.0.1:49184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11818,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"warn","ts":"2026-10-15T19:57:51.557147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.082465Z","time spent":"474.663318ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-15T19:57:51.557171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.682156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:57:51.557305Z","caller":"traceutil/trace.go:171","msg":"trace[1483281969] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:26524; }","duration":"263.898412ms","start":"2026-10-15T19:57:51.293369Z","end":"2026-10-15T19:57:51.557267Z","steps":["trace[1483281969] 'agreement among raft nodes before linearized reading' (duration: 263.583374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:51.557431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.070147Z","time spent":"486.852565ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T19:57:51.557039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.002817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-15T19:57:51.55758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:51.063436Z","time spent":"494.087222ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:57:51.557647Z","caller":"traceutil/trace.go:171","msg":"trace[1245031449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26524; }","duration":"108.644913ms","start":"2026-10-15T19:57:51.448939Z","end":"2026-10-15T19:57:51.557584Z","steps":["trace[1245031449] 'agreement among raft nodes before linearized reading' (duration: 107.985707ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:57:52.286654Z","caller":"traceutil/trace.go:171","msg":"trace[257144240] transaction","detail":"{read_only:false; response_revision:26528; number_of_response:1; }","duration":"276.260231ms","start":"2026-10-15T19:57:52.01033Z","end":"2026-10-15T19:57:52.28659Z","steps":["trace[257144240] 'process raft request' (duration: 276.047926ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:57:52.493687Z","caller":"traceutil/trace.go:171","msg":"trace[954501049] transaction","detail":"{read_only:false; response_revision:26529; number_of_response:1; }","duration":"351.987114ms","start":"2026-10-15T19:57:52.141668Z","end":"2026-10-15T19:57:52.493656Z","steps":["trace[954501049] 'process raft request' (duration: 265.703525ms)","trace[954501049] 'compare' (duration: 86.083354ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:57:52.493921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:52.141633Z","time spent":"352.153908ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:57:52.494019Z","caller":"traceutil/trace.go:171","msg":"trace[2107144299] linearizableReadLoop","detail":"{readStateIndex:27406; appliedIndex:27404; }","duration":"323.371067ms","start":"2026-10-15T19:57:52.170605Z","end":"2026-10-15T19:57:52.493976Z","steps":["trace[2107144299] 'read index received' (duration: 115.680984ms)","trace[2107144299] 'applied index is now lower than readState.Index' (duration: 207.688373ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:57:52.494128Z","caller":"traceutil/trace.go:171","msg":"trace[1960429237] transaction","detail":"{read_only:false; response_revision:26530; number_of_response:1; }","duration":"276.876796ms","start":"2026-10-15T19:57:52.217229Z","end":"2026-10-15T19:57:52.494106Z","steps":["trace[1960429237] 'process raft request' (duration: 276.379404ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:52.494388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.719166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-15T19:57:52.494448Z","caller":"traceutil/trace.go:171","msg":"trace[303859107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26530; }","duration":"323.89872ms","start":"2026-10-15T19:57:52.170534Z","end":"2026-10-15T19:57:52.494433Z","steps":["trace[303859107] 'agreement among raft nodes before linearized reading' (duration: 323.571512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:57:52.494496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:57:52.170509Z","time spent":"323.973653ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-15T19:58:50.072454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.792438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-15T19:58:50.072618Z","caller":"traceutil/trace.go:171","msg":"trace[1615905992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27055; }","duration":"158.036885ms","start":"2026-10-15T19:58:49.914555Z","end":"2026-10-15T19:58:50.072592Z","steps":["trace[1615905992] 'range keys from in-memory index tree' (duration: 157.532942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:58:50.072454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.872714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-15T19:58:50.073045Z","caller":"traceutil/trace.go:171","msg":"trace[1091894772] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27055; }","duration":"154.51841ms","start":"2026-10-15T19:58:49.918476Z","end":"2026-10-15T19:58:50.072995Z","steps":["trace[1091894772] 'range keys from in-memory index tree' (duration: 153.683649ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:58:55.988974Z","caller":"traceutil/trace.go:171","msg":"trace[1226673200] transaction","detail":"{read_only:false; response_revision:27096; number_of_response:1; }","duration":"162.179956ms","start":"2026-10-15T19:58:55.826749Z","end":"2026-10-15T19:58:55.988929Z","steps":["trace[1226673200] 'process raft request' (duration: 161.927259ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:58:56.363632Z","caller":"traceutil/trace.go:171","msg":"trace[1711402232] transaction","detail":"{read_only:false; response_revision:27097; number_of_response:1; }","duration":"512.297635ms","start":"2026-10-15T19:58:55.851303Z","end":"2026-10-15T19:58:56.363601Z","steps":["trace[1711402232] 'process raft request' (duration: 512.040098ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:58:56.363842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:58:55.851271Z","time spent":"512.459389ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:58:56.363929Z","caller":"traceutil/trace.go:171","msg":"trace[1559791792] linearizableReadLoop","detail":"{readStateIndex:27990; appliedIndex:27988; }","duration":"346.279145ms","start":"2026-10-15T19:58:56.017609Z","end":"2026-10-15T19:58:56.363888Z","steps":["trace[1559791792] 'read index received' (duration: 345.702961ms)","trace[1559791792] 'applied index is now lower than readState.Index' (duration: 574.714µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:58:56.364078Z","caller":"traceutil/trace.go:171","msg":"trace[966134577] transaction","detail":"{read_only:false; response_revision:27098; number_of_response:1; }","duration":"467.908245ms","start":"2026-10-15T19:58:55.896139Z","end":"2026-10-15T19:58:56.364047Z","steps":["trace[966134577] 'process raft request' (duration: 467.396692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:58:56.364136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.502671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:58:56.36418Z","caller":"traceutil/trace.go:171","msg":"trace[714570330] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:27098; }","duration":"346.623934ms","start":"2026-10-15T19:58:56.01754Z","end":"2026-10-15T19:58:56.364163Z","steps":["trace[714570330] 'agreement among raft nodes before linearized reading' (duration: 346.512121ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:58:56.364225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:58:56.017514Z","time spent":"346.698486ms","remote":"127.0.0.1:33636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"warn","ts":"2026-10-15T19:58:56.364287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:58:55.896099Z","time spent":"468.037568ms","remote":"127.0.0.1:48988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:58:56.364316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.124113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-15T19:58:56.364361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.001368ms","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-10-15T19:58:56.364424Z","caller":"traceutil/trace.go:171","msg":"trace[429313738] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27098; }","duration":"254.300937ms","start":"2026-10-15T19:58:56.110099Z","end":"2026-10-15T19:58:56.3644Z","steps":["trace[429313738] 'agreement among raft nodes before linearized reading' (duration: 253.98799ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:58:56.364441Z","caller":"traceutil/trace.go:171","msg":"trace[1568862287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27098; }","duration":"138.134452ms","start":"2026-10-15T19:58:56.226283Z","end":"2026-10-15T19:58:56.364418Z","steps":["trace[1568862287] 'agreement among raft nodes before linearized reading' (duration: 137.827114ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:58:56.364462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.787503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-15T19:58:56.364519Z","caller":"traceutil/trace.go:171","msg":"trace[109845719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27098; }","duration":"250.867024ms","start":"2026-10-15T19:58:56.113636Z","end":"2026-10-15T19:58:56.364503Z","steps":["trace[109845719] 'agreement among raft nodes before linearized reading' (duration: 250.667499ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:58:56.75071Z","caller":"traceutil/trace.go:171","msg":"trace[82653338] transaction","detail":"{read_only:false; response_revision:27102; number_of_response:1; }","duration":"197.317581ms","start":"2026-10-15T19:58:56.553334Z","end":"2026-10-15T19:58:56.750651Z","steps":["trace[82653338] 'process raft request' (duration: 115.5022ms)","trace[82653338] 'compare' (duration: 81.314339ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:59:24.537197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24544} {"level":"info","ts":"2026-10-15T19:59:24.693624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24544,"took":"152.07092ms","hash":2080802007,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":36573184,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-15T19:59:24.693705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2080802007,"revision":24544,"compact-revision":21658} {"level":"info","ts":"2026-10-15T20:02:12.774014Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":30006,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T20:02:12.784098Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30006} {"level":"info","ts":"2026-10-15T20:02:12.784275Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25006} {"level":"info","ts":"2026-10-15T20:04:24.547361Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27307} {"level":"info","ts":"2026-10-15T20:04:24.676017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27307,"took":"125.425472ms","hash":3639152305,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":37978112,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-10-15T20:04:24.676139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3639152305,"revision":27307,"compact-revision":24544} {"level":"info","ts":"2026-10-15T20:09:24.558045Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30242} {"level":"info","ts":"2026-10-15T20:09:24.703955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30242,"took":"141.079566ms","hash":4075971665,"current-db-size-bytes":56639488,"current-db-size":"57 MB","current-db-size-in-use-bytes":31440896,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:09:24.704028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4075971665,"revision":30242,"compact-revision":27307} {"level":"info","ts":"2026-10-15T20:14:24.565898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32529} {"level":"info","ts":"2026-10-15T20:14:24.737789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32529,"took":"167.680432ms","hash":3259735434,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":30425088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T20:14:24.737857Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3259735434,"revision":32529,"compact-revision":30242} {"level":"info","ts":"2026-10-15T20:19:24.573654Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34749} {"level":"info","ts":"2026-10-15T20:19:24.71973Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34749,"took":"141.951286ms","hash":1528222462,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":30695424,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:19:24.71981Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1528222462,"revision":34749,"compact-revision":32529} {"level":"info","ts":"2026-10-15T20:23:13.210307Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":40007,"local-member-snapshot-index":30006,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T20:23:13.21864Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40007} {"level":"info","ts":"2026-10-15T20:23:13.218837Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35007} {"level":"info","ts":"2026-10-15T20:24:24.582299Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37003} {"level":"info","ts":"2026-10-15T20:24:24.727406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37003,"took":"139.219141ms","hash":1362946738,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":32825344,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T20:24:24.727484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1362946738,"revision":37003,"compact-revision":34749} {"level":"info","ts":"2026-10-15T20:29:24.589041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39318} {"level":"info","ts":"2026-10-15T20:29:24.731868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39318,"took":"139.280952ms","hash":1053297004,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":31338496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:29:24.731969Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1053297004,"revision":39318,"compact-revision":37003} {"level":"info","ts":"2026-10-15T20:34:24.596084Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41544} {"level":"info","ts":"2026-10-15T20:34:24.715363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41544,"took":"116.001946ms","hash":1209579081,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":30924800,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:34:24.715433Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1209579081,"revision":41544,"compact-revision":39318}