{"level":"warn","ts":"2026-09-14T19:39:00.016594Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-14T19:39:00.016678Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.138: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.138:2380","--initial-cluster=instance=https://162.253.55.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.138: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-09-14T19:39:00.016741Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-14T19:39:00.016752Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.138:2380"]} {"level":"info","ts":"2026-09-14T19:39:00.016767Z","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-09-14T19:39:00.01738Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"]} {"level":"info","ts":"2026-09-14T19:39:00.017456Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.138:2380"],"listen-peer-urls":["https://162.253.55.138:2380"],"advertise-client-urls":["https://162.253.55.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.138: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-09-14T19:39:00.021883Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.211251ms"} {"level":"info","ts":"2026-09-14T19:39:00.029058Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ee8e5a779fc25cea","cluster-id":"8f8e3b77da0cbcef"} {"level":"info","ts":"2026-09-14T19:39:00.029253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=()"} {"level":"info","ts":"2026-09-14T19:39:00.0293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became follower at term 0"} {"level":"info","ts":"2026-09-14T19:39:00.029319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ee8e5a779fc25cea [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-14T19:39:00.029331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became follower at term 1"} {"level":"info","ts":"2026-09-14T19:39:00.02948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=(17189776297547685098)"} {"level":"warn","ts":"2026-09-14T19:39:00.036279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-14T19:39:00.037671Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-14T19:39:00.039261Z","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-09-14T19:39:00.041259Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ee8e5a779fc25cea","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-14T19:39:00.044334Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ee8e5a779fc25cea","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-14T19:39:00.04467Z","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-09-14T19:39:00.044745Z","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-09-14T19:39:00.044771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea switched to configuration voters=(17189776297547685098)"} {"level":"info","ts":"2026-09-14T19:39:00.044966Z","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-09-14T19:39:00.045885Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8f8e3b77da0cbcef","local-member-id":"ee8e5a779fc25cea","added-peer-id":"ee8e5a779fc25cea","added-peer-peer-urls":["https://162.253.55.138:2380"]} {"level":"info","ts":"2026-09-14T19:39:00.04611Z","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-09-14T19:39:00.046338Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ee8e5a779fc25cea","initial-advertise-peer-urls":["https://162.253.55.138:2380"],"listen-peer-urls":["https://162.253.55.138:2380"],"advertise-client-urls":["https://162.253.55.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-14T19:39:00.046377Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-14T19:39:00.046432Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.138:2380"} {"level":"info","ts":"2026-09-14T19:39:00.046451Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.138:2380"} {"level":"info","ts":"2026-09-14T19:39:00.129682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea is starting a new election at term 1"} {"level":"info","ts":"2026-09-14T19:39:00.129749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became pre-candidate at term 1"} {"level":"info","ts":"2026-09-14T19:39:00.129829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea received MsgPreVoteResp from ee8e5a779fc25cea at term 1"} {"level":"info","ts":"2026-09-14T19:39:00.129859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became candidate at term 2"} {"level":"info","ts":"2026-09-14T19:39:00.129876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea received MsgVoteResp from ee8e5a779fc25cea at term 2"} {"level":"info","ts":"2026-09-14T19:39:00.129894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee8e5a779fc25cea became leader at term 2"} {"level":"info","ts":"2026-09-14T19:39:00.129914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee8e5a779fc25cea elected leader ee8e5a779fc25cea at term 2"} {"level":"info","ts":"2026-09-14T19:39:00.131063Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ee8e5a779fc25cea","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.138:2379]}","request-path":"/0/members/ee8e5a779fc25cea/attributes","cluster-id":"8f8e3b77da0cbcef","publish-timeout":"7s"} {"level":"info","ts":"2026-09-14T19:39:00.131107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T19:39:00.131291Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T19:39:00.1315Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-14T19:39:00.131563Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-14T19:39:00.132388Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8f8e3b77da0cbcef","local-member-id":"ee8e5a779fc25cea","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T19:39:00.132502Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T19:39:00.132539Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T19:39:00.132685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T19:39:00.133559Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-14T19:39:00.1354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.138:2379"} {"level":"warn","ts":"2026-09-14T19:39:04.260711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.327519ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-14T19:39:04.260833Z","caller":"traceutil/trace.go:171","msg":"trace[1353551385] linearizableReadLoop","detail":"{readStateIndex:121; appliedIndex:120; }","duration":"379.861203ms","start":"2026-09-14T19:39:03.880955Z","end":"2026-09-14T19:39:04.260816Z","steps":["trace[1353551385] 'read index received' (duration: 55.507µs)","trace[1353551385] 'applied index is now lower than readState.Index' (duration: 379.804606ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:39:04.260866Z","caller":"traceutil/trace.go:171","msg":"trace[1198966781] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"924.887945ms","start":"2026-09-14T19:39:03.335942Z","end":"2026-09-14T19:39:04.260829Z","steps":["trace[1198966781] 'process raft request' (duration: 317.910623ms)","trace[1198966781] 'compare' (duration: 606.185676ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:39:04.260968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.016555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-14T19:39:04.261008Z","caller":"traceutil/trace.go:171","msg":"trace[745247231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:117; }","duration":"380.112639ms","start":"2026-09-14T19:39:03.880877Z","end":"2026-09-14T19:39:04.26099Z","steps":["trace[745247231] 'agreement among raft nodes before linearized reading' (duration: 380.029593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:04.260976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:03.335919Z","time spent":"925.011167ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-14T19:39:04.261041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:03.880847Z","time spent":"380.187324ms","remote":"127.0.0.1:44020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-14T19:39:04.261046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.511822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-14T19:39:04.261138Z","caller":"traceutil/trace.go:171","msg":"trace[1234425239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:117; }","duration":"137.650894ms","start":"2026-09-14T19:39:04.123461Z","end":"2026-09-14T19:39:04.261112Z","steps":["trace[1234425239] 'agreement among raft nodes before linearized reading' (duration: 137.499272ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:39:04.762489Z","caller":"traceutil/trace.go:171","msg":"trace[1028282323] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"497.79024ms","start":"2026-09-14T19:39:04.264656Z","end":"2026-09-14T19:39:04.762446Z","steps":["trace[1028282323] 'process raft request' (duration: 449.265198ms)","trace[1028282323] 'compare' (duration: 48.318093ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:39:04.762953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:04.264635Z","time spent":"498.091944ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-14T19:39:04.766697Z","caller":"traceutil/trace.go:171","msg":"trace[1918869654] linearizableReadLoop","detail":"{readStateIndex:123; appliedIndex:121; }","duration":"428.323054ms","start":"2026-09-14T19:39:04.338341Z","end":"2026-09-14T19:39:04.766664Z","steps":["trace[1918869654] 'read index received' (duration: 375.593274ms)","trace[1918869654] 'applied index is now lower than readState.Index' (duration: 52.72823ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:39:04.766938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.560661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-14T19:39:04.766985Z","caller":"traceutil/trace.go:171","msg":"trace[2042795547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:119; }","duration":"428.662485ms","start":"2026-09-14T19:39:04.338308Z","end":"2026-09-14T19:39:04.76697Z","steps":["trace[2042795547] 'agreement among raft nodes before linearized reading' (duration: 428.515573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:04.767031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:04.338296Z","time spent":"428.726062ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-14T19:39:04.76724Z","caller":"traceutil/trace.go:171","msg":"trace[1667563750] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"500.102613ms","start":"2026-09-14T19:39:04.267125Z","end":"2026-09-14T19:39:04.767227Z","steps":["trace[1667563750] 'process raft request' (duration: 499.393423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:04.767332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:04.267107Z","time spent":"500.165929ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":767,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-14T19:39:45.749012Z","caller":"traceutil/trace.go:171","msg":"trace[1382989837] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:515; }","duration":"171.145217ms","start":"2026-09-14T19:39:45.577832Z","end":"2026-09-14T19:39:45.748977Z","steps":["trace[1382989837] 'read index received' (duration: 153.457133ms)","trace[1382989837] 'applied index is now lower than readState.Index' (duration: 17.686704ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:39:45.749119Z","caller":"traceutil/trace.go:171","msg":"trace[958343834] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"223.788415ms","start":"2026-09-14T19:39:45.525289Z","end":"2026-09-14T19:39:45.749078Z","steps":["trace[958343834] 'process raft request' (duration: 206.120191ms)","trace[958343834] 'compare' (duration: 17.398552ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:39:45.749289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.391509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-09-14T19:39:45.749354Z","caller":"traceutil/trace.go:171","msg":"trace[168501081] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:497; }","duration":"171.562061ms","start":"2026-09-14T19:39:45.577772Z","end":"2026-09-14T19:39:45.749334Z","steps":["trace[168501081] 'agreement among raft nodes before linearized reading' (duration: 171.383319ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:45.749526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.537321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-09-14T19:39:45.749616Z","caller":"traceutil/trace.go:171","msg":"trace[1048652083] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:497; }","duration":"171.687662ms","start":"2026-09-14T19:39:45.577912Z","end":"2026-09-14T19:39:45.7496Z","steps":["trace[1048652083] 'agreement among raft nodes before linearized reading' (duration: 171.46123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:45.750093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.578005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-09-14T19:39:45.750222Z","caller":"traceutil/trace.go:171","msg":"trace[1158016096] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:497; }","duration":"151.771977ms","start":"2026-09-14T19:39:45.59842Z","end":"2026-09-14T19:39:45.750192Z","steps":["trace[1158016096] 'agreement among raft nodes before linearized reading' (duration: 151.149721ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:39:53.744801Z","caller":"traceutil/trace.go:171","msg":"trace[545148080] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"112.623431ms","start":"2026-09-14T19:39:53.632145Z","end":"2026-09-14T19:39:53.744769Z","steps":["trace[545148080] 'process raft request' (duration: 111.865938ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:39:53.968768Z","caller":"traceutil/trace.go:171","msg":"trace[2065931929] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"133.989899ms","start":"2026-09-14T19:39:53.834742Z","end":"2026-09-14T19:39:53.968732Z","steps":["trace[2065931929] 'process raft request' (duration: 133.741255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:54.566292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.256911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T19:39:54.566705Z","caller":"traceutil/trace.go:171","msg":"trace[1903168021] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"573.341888ms","start":"2026-09-14T19:39:53.993329Z","end":"2026-09-14T19:39:54.566671Z","steps":["trace[1903168021] 'read index received' (duration: 99.247322ms)","trace[1903168021] 'applied index is now lower than readState.Index' (duration: 474.091496ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:39:54.566734Z","caller":"traceutil/trace.go:171","msg":"trace[1241293158] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"577.702985ms","start":"2026-09-14T19:39:53.988762Z","end":"2026-09-14T19:39:54.566465Z","steps":["trace[1241293158] 'process raft request' (duration: 103.947964ms)","trace[1241293158] 'compare' (duration: 472.954125ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:39:54.566937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:53.988734Z","time spent":"578.087062ms","remote":"127.0.0.1:44222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:39:54.566914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.538991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T19:39:54.567032Z","caller":"traceutil/trace.go:171","msg":"trace[811648272] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"573.720255ms","start":"2026-09-14T19:39:53.993286Z","end":"2026-09-14T19:39:54.567006Z","steps":["trace[811648272] 'agreement among raft nodes before linearized reading' (duration: 573.516991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:54.567092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:53.993272Z","time spent":"573.808926ms","remote":"127.0.0.1:44020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-14T19:39:54.576777Z","caller":"traceutil/trace.go:171","msg":"trace[1847846818] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"148.247406ms","start":"2026-09-14T19:39:54.42848Z","end":"2026-09-14T19:39:54.576727Z","steps":["trace[1847846818] 'process raft request' (duration: 139.158116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:54.576814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.459599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-14T19:39:54.577015Z","caller":"traceutil/trace.go:171","msg":"trace[2141523559] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:612; }","duration":"351.719514ms","start":"2026-09-14T19:39:54.225274Z","end":"2026-09-14T19:39:54.576994Z","steps":["trace[2141523559] 'agreement among raft nodes before linearized reading' (duration: 351.454619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:39:54.577088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:39:54.225247Z","time spent":"351.829226ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-14T19:40:10.821709Z","caller":"traceutil/trace.go:171","msg":"trace[345646998] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"145.004397ms","start":"2026-09-14T19:40:10.676685Z","end":"2026-09-14T19:40:10.82169Z","steps":["trace[345646998] 'read index received' (duration: 144.622384ms)","trace[345646998] 'applied index is now lower than readState.Index' (duration: 381.023µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:40:10.821748Z","caller":"traceutil/trace.go:171","msg":"trace[4919302] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"145.293936ms","start":"2026-09-14T19:40:10.676434Z","end":"2026-09-14T19:40:10.821728Z","steps":["trace[4919302] 'process raft request' (duration: 144.936654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:40:10.822154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.41654ms","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-09-14T19:40:10.822292Z","caller":"traceutil/trace.go:171","msg":"trace[316686338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"145.555115ms","start":"2026-09-14T19:40:10.676644Z","end":"2026-09-14T19:40:10.822199Z","steps":["trace[316686338] 'agreement among raft nodes before linearized reading' (duration: 145.178622ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:40:40.395765Z","caller":"traceutil/trace.go:171","msg":"trace[888317621] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"182.255102ms","start":"2026-09-14T19:40:40.213481Z","end":"2026-09-14T19:40:40.395736Z","steps":["trace[888317621] 'process raft request' (duration: 182.056052ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.435067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.887567ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T19:41:32.435219Z","caller":"traceutil/trace.go:171","msg":"trace[1090822097] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1873; }","duration":"581.058748ms","start":"2026-09-14T19:41:31.854139Z","end":"2026-09-14T19:41:32.435197Z","steps":["trace[1090822097] 'range keys from in-memory index tree' (duration: 580.865995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.435731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.444920588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T19:41:32.435837Z","caller":"traceutil/trace.go:171","msg":"trace[356467733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"1.445078109s","start":"2026-09-14T19:41:30.990735Z","end":"2026-09-14T19:41:32.435813Z","steps":["trace[356467733] 'range keys from in-memory index tree' (duration: 1.444834233s)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.435879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:30.990717Z","time spent":"1.445153214s","remote":"127.0.0.1:44020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-14T19:41:32.436289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.539972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T19:41:32.436911Z","caller":"traceutil/trace.go:171","msg":"trace[1687701915] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"1.374764766s","start":"2026-09-14T19:41:31.062121Z","end":"2026-09-14T19:41:32.436886Z","steps":["trace[1687701915] 'process raft request' (duration: 386.514597ms)","trace[1687701915] 'compare' (duration: 987.053469ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:41:32.437604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.062095Z","time spent":"1.37540791s","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T19:41:32.436931Z","caller":"traceutil/trace.go:171","msg":"trace[1982527571] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"1.362935545s","start":"2026-09-14T19:41:31.073977Z","end":"2026-09-14T19:41:32.436912Z","steps":["trace[1982527571] 'read index received' (duration: 374.60263ms)","trace[1982527571] 'applied index is now lower than readState.Index' (duration: 988.330495ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:41:32.442298Z","caller":"traceutil/trace.go:171","msg":"trace[1177631948] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"630.216349ms","start":"2026-09-14T19:41:31.812066Z","end":"2026-09-14T19:41:32.442282Z","steps":["trace[1177631948] 'process raft request' (duration: 630.07193ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.442393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.81204Z","time spent":"630.305315ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:41:32.442292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368281083s","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-09-14T19:41:32.44263Z","caller":"traceutil/trace.go:171","msg":"trace[1232572818] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"1.36867261s","start":"2026-09-14T19:41:31.073929Z","end":"2026-09-14T19:41:32.442602Z","steps":["trace[1232572818] 'agreement among raft nodes before linearized reading' (duration: 1.363035562s)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:41:32.442781Z","caller":"traceutil/trace.go:171","msg":"trace[1120889864] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"579.952315ms","start":"2026-09-14T19:41:31.862815Z","end":"2026-09-14T19:41:32.442768Z","steps":["trace[1120889864] 'process raft request' (duration: 579.422699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.442854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.862779Z","time spent":"580.041711ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:41:32.442805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.073908Z","time spent":"1.368880074s","remote":"127.0.0.1:40934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-14T19:41:32.443103Z","caller":"traceutil/trace.go:171","msg":"trace[1885052522] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"313.267711ms","start":"2026-09-14T19:41:32.129776Z","end":"2026-09-14T19:41:32.443043Z","steps":["trace[1885052522] 'process raft request' (duration: 313.039615ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.443183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.562446ms","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-09-14T19:41:32.443258Z","caller":"traceutil/trace.go:171","msg":"trace[119974188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1878; }","duration":"720.707256ms","start":"2026-09-14T19:41:31.722529Z","end":"2026-09-14T19:41:32.443236Z","steps":["trace[119974188] 'agreement among raft nodes before linearized reading' (duration: 720.515763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.44331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.722508Z","time spent":"720.791901ms","remote":"127.0.0.1:44324","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-09-14T19:41:32.443393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:32.12976Z","time spent":"313.40123ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T19:41:32.443546Z","caller":"traceutil/trace.go:171","msg":"trace[2052736288] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"324.617813ms","start":"2026-09-14T19:41:32.118905Z","end":"2026-09-14T19:41:32.443523Z","steps":["trace[2052736288] 'process raft request' (duration: 323.660829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.443731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:32.11887Z","time spent":"324.797425ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:41:32.444032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205773689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-14T19:41:32.444095Z","caller":"traceutil/trace.go:171","msg":"trace[1851286354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1878; }","duration":"1.205874885s","start":"2026-09-14T19:41:31.238202Z","end":"2026-09-14T19:41:32.444077Z","steps":["trace[1851286354] 'agreement among raft nodes before linearized reading' (duration: 1.205700144s)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.444374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.012323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-14T19:41:32.444431Z","caller":"traceutil/trace.go:171","msg":"trace[1514285334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1878; }","duration":"712.12408ms","start":"2026-09-14T19:41:31.732292Z","end":"2026-09-14T19:41:32.444416Z","steps":["trace[1514285334] 'agreement among raft nodes before linearized reading' (duration: 711.911786ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.444391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.560832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-09-14T19:41:32.444625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.73222Z","time spent":"712.28731ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-14T19:41:32.444674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.895695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T19:41:32.444741Z","caller":"traceutil/trace.go:171","msg":"trace[173577802] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1878; }","duration":"714.96624ms","start":"2026-09-14T19:41:31.729757Z","end":"2026-09-14T19:41:32.444723Z","steps":["trace[173577802] 'agreement among raft nodes before linearized reading' (duration: 714.863813ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.444734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.23818Z","time spent":"1.206381439s","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-14T19:41:32.44499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.681954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-14T19:41:32.445153Z","caller":"traceutil/trace.go:171","msg":"trace[1446286652] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104; range_end:; response_count:1; response_revision:1878; }","duration":"590.905949ms","start":"2026-09-14T19:41:31.854227Z","end":"2026-09-14T19:41:32.445133Z","steps":["trace[1446286652] 'agreement among raft nodes before linearized reading' (duration: 590.656802ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.445282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.854198Z","time spent":"591.0681ms","remote":"127.0.0.1:44222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104\" "} {"level":"warn","ts":"2026-09-14T19:41:32.445047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074650663s","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-09-14T19:41:32.446554Z","caller":"traceutil/trace.go:171","msg":"trace[1066322851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1878; }","duration":"1.076206028s","start":"2026-09-14T19:41:31.370326Z","end":"2026-09-14T19:41:32.446532Z","steps":["trace[1066322851] 'agreement among raft nodes before linearized reading' (duration: 1.074621101s)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.446643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.370277Z","time spent":"1.076346587s","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-14T19:41:32.444663Z","caller":"traceutil/trace.go:171","msg":"trace[482305334] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104; range_end:; response_count:1; response_revision:1878; }","duration":"991.83008ms","start":"2026-09-14T19:41:31.452814Z","end":"2026-09-14T19:41:32.444645Z","steps":["trace[482305334] 'agreement among raft nodes before linearized reading' (duration: 991.481626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:32.446774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.452736Z","time spent":"994.023167ms","remote":"127.0.0.1:44222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0e34f352-bca1-48f2-b013-41a34ffd3104\" "} {"level":"warn","ts":"2026-09-14T19:41:32.444791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:31.729651Z","time spent":"715.127581ms","remote":"127.0.0.1:44290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-09-14T19:41:44.920674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.395327ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T19:41:44.920793Z","caller":"traceutil/trace.go:171","msg":"trace[426872957] linearizableReadLoop","detail":"{readStateIndex:2053; appliedIndex:2052; }","duration":"344.077069ms","start":"2026-09-14T19:41:44.576699Z","end":"2026-09-14T19:41:44.920776Z","steps":["trace[426872957] 'read index received' (duration: 226.525181ms)","trace[426872957] 'applied index is now lower than readState.Index' (duration: 117.550178ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:41:44.922342Z","caller":"traceutil/trace.go:171","msg":"trace[1753131673] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"361.67922ms","start":"2026-09-14T19:41:44.560641Z","end":"2026-09-14T19:41:44.92232Z","steps":["trace[1753131673] 'process raft request' (duration: 242.527401ms)","trace[1753131673] 'compare' (duration: 116.620253ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:41:44.922433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:44.560623Z","time spent":"361.767427ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:41:44.923004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.264922ms","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-09-14T19:41:44.923367Z","caller":"traceutil/trace.go:171","msg":"trace[1171821007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1979; }","duration":"346.651218ms","start":"2026-09-14T19:41:44.576672Z","end":"2026-09-14T19:41:44.923323Z","steps":["trace[1171821007] 'agreement among raft nodes before linearized reading' (duration: 344.254882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:44.923565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:44.576662Z","time spent":"346.883425ms","remote":"127.0.0.1:44324","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":"info","ts":"2026-09-14T19:41:44.942531Z","caller":"traceutil/trace.go:171","msg":"trace[721564193] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"229.878294ms","start":"2026-09-14T19:41:44.712618Z","end":"2026-09-14T19:41:44.942497Z","steps":["trace[721564193] 'process raft request' (duration: 229.650088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:44.942614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.744434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-14T19:41:44.942688Z","caller":"traceutil/trace.go:171","msg":"trace[1125133830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1980; }","duration":"364.84231ms","start":"2026-09-14T19:41:44.577823Z","end":"2026-09-14T19:41:44.942665Z","steps":["trace[1125133830] 'agreement among raft nodes before linearized reading' (duration: 364.594543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:44.942733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:41:44.577815Z","time spent":"364.909824ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-14T19:41:44.943017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.133724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-dmlqm\" ","response":"range_response_count:1 size:5855"} {"level":"info","ts":"2026-09-14T19:41:44.943054Z","caller":"traceutil/trace.go:171","msg":"trace[449020999] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-dmlqm; range_end:; response_count:1; response_revision:1980; }","duration":"209.200929ms","start":"2026-09-14T19:41:44.733841Z","end":"2026-09-14T19:41:44.943042Z","steps":["trace[449020999] 'agreement among raft nodes before linearized reading' (duration: 209.094501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:41:44.943119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.230594ms","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-09-14T19:41:44.94316Z","caller":"traceutil/trace.go:171","msg":"trace[1177229918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1980; }","duration":"287.333861ms","start":"2026-09-14T19:41:44.655814Z","end":"2026-09-14T19:41:44.943148Z","steps":["trace[1177229918] 'agreement among raft nodes before linearized reading' (duration: 287.152368ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:42:06.787842Z","caller":"traceutil/trace.go:171","msg":"trace[889625070] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2193; }","duration":"148.437025ms","start":"2026-09-14T19:42:06.639375Z","end":"2026-09-14T19:42:06.787812Z","steps":["trace[889625070] 'read index received' (duration: 124.928749ms)","trace[889625070] 'applied index is now lower than readState.Index' (duration: 23.506776ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:42:06.788131Z","caller":"traceutil/trace.go:171","msg":"trace[1419119731] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"170.499647ms","start":"2026-09-14T19:42:06.617556Z","end":"2026-09-14T19:42:06.788055Z","steps":["trace[1419119731] 'process raft request' (duration: 146.867612ms)","trace[1419119731] 'compare' (duration: 22.950736ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:42:06.788321Z","caller":"traceutil/trace.go:171","msg":"trace[428443516] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"169.886263ms","start":"2026-09-14T19:42:06.618396Z","end":"2026-09-14T19:42:06.788282Z","steps":["trace[428443516] 'process raft request' (duration: 169.351755ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:06.788472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.071781ms","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-09-14T19:42:06.788539Z","caller":"traceutil/trace.go:171","msg":"trace[1931960149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2116; }","duration":"149.19345ms","start":"2026-09-14T19:42:06.639328Z","end":"2026-09-14T19:42:06.788522Z","steps":["trace[1931960149] 'agreement among raft nodes before linearized reading' (duration: 148.722506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.339916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.811235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T19:42:07.340037Z","caller":"traceutil/trace.go:171","msg":"trace[2100238459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2117; }","duration":"346.033021ms","start":"2026-09-14T19:42:06.993979Z","end":"2026-09-14T19:42:07.340012Z","steps":["trace[2100238459] 'range keys from in-memory index tree' (duration: 345.683024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.340115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:42:06.993953Z","time spent":"346.127698ms","remote":"127.0.0.1:44020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-14T19:42:07.34051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.068392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-14T19:42:07.340764Z","caller":"traceutil/trace.go:171","msg":"trace[396192371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2117; }","duration":"301.389865ms","start":"2026-09-14T19:42:07.039342Z","end":"2026-09-14T19:42:07.340732Z","steps":["trace[396192371] 'range keys from in-memory index tree' (duration: 300.513112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.340998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:42:07.039314Z","time spent":"301.663385ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-14T19:42:07.348584Z","caller":"traceutil/trace.go:171","msg":"trace[1684971771] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"291.128089ms","start":"2026-09-14T19:42:07.057432Z","end":"2026-09-14T19:42:07.34856Z","steps":["trace[1684971771] 'read index received' (duration: 291.011871ms)","trace[1684971771] 'applied index is now lower than readState.Index' (duration: 114.888µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:42:07.348649Z","caller":"traceutil/trace.go:171","msg":"trace[1213932146] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"304.703826ms","start":"2026-09-14T19:42:07.043911Z","end":"2026-09-14T19:42:07.348615Z","steps":["trace[1213932146] 'process raft request' (duration: 304.446148ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.348834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.388119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-14T19:42:07.348886Z","caller":"traceutil/trace.go:171","msg":"trace[300738880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2118; }","duration":"291.494667ms","start":"2026-09-14T19:42:07.057375Z","end":"2026-09-14T19:42:07.34887Z","steps":["trace[300738880] 'agreement among raft nodes before linearized reading' (duration: 291.308543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.34889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:42:07.043893Z","time spent":"304.867959ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T19:42:07.403339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.820556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-14T19:42:07.403429Z","caller":"traceutil/trace.go:171","msg":"trace[1247884396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2119; }","duration":"341.966756ms","start":"2026-09-14T19:42:07.061441Z","end":"2026-09-14T19:42:07.403408Z","steps":["trace[1247884396] 'agreement among raft nodes before linearized reading' (duration: 341.732039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.403455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.823708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-14T19:42:07.403532Z","caller":"traceutil/trace.go:171","msg":"trace[1749402587] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2119; }","duration":"338.933316ms","start":"2026-09-14T19:42:07.064581Z","end":"2026-09-14T19:42:07.403514Z","steps":["trace[1749402587] 'agreement among raft nodes before linearized reading' (duration: 338.681727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:42:07.403574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:42:07.064564Z","time spent":"339.001871ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-14T19:42:07.403473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T19:42:07.061417Z","time spent":"342.045052ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-14T19:42:07.563378Z","caller":"traceutil/trace.go:171","msg":"trace[96692321] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"155.028953ms","start":"2026-09-14T19:42:07.408322Z","end":"2026-09-14T19:42:07.563351Z","steps":["trace[96692321] 'process raft request' (duration: 81.043843ms)","trace[96692321] 'compare' (duration: 73.770595ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:42:07.563598Z","caller":"traceutil/trace.go:171","msg":"trace[1797271154] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"155.008761ms","start":"2026-09-14T19:42:07.408552Z","end":"2026-09-14T19:42:07.56356Z","steps":["trace[1797271154] 'process raft request' (duration: 154.739591ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:43:22.313778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.967024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-14T19:43:22.313889Z","caller":"traceutil/trace.go:171","msg":"trace[1510950218] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2623; }","duration":"163.143008ms","start":"2026-09-14T19:43:22.150725Z","end":"2026-09-14T19:43:22.313868Z","steps":["trace[1510950218] 'range keys from in-memory index tree' (duration: 162.229211ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:43:55.392844Z","caller":"traceutil/trace.go:171","msg":"trace[752800705] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"139.476656ms","start":"2026-09-14T19:43:55.253329Z","end":"2026-09-14T19:43:55.392805Z","steps":["trace[752800705] 'process raft request' (duration: 127.896498ms)","trace[752800705] 'compare' (duration: 11.40189ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:43:55.693933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.631098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T19:43:55.694138Z","caller":"traceutil/trace.go:171","msg":"trace[254107380] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"259.213132ms","start":"2026-09-14T19:43:55.434891Z","end":"2026-09-14T19:43:55.694104Z","steps":["trace[254107380] 'process raft request' (duration: 130.270048ms)","trace[254107380] 'compare' (duration: 128.368872ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T19:48:32.939098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.840066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-14T19:48:32.939177Z","caller":"traceutil/trace.go:171","msg":"trace[1926619770] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4939; }","duration":"101.941182ms","start":"2026-09-14T19:48:32.837217Z","end":"2026-09-14T19:48:32.939158Z","steps":["trace[1926619770] 'range keys from in-memory index tree' (duration: 101.716789ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:48:38.989093Z","caller":"traceutil/trace.go:171","msg":"trace[2064631764] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"106.093935ms","start":"2026-09-14T19:48:38.882981Z","end":"2026-09-14T19:48:38.989075Z","steps":["trace[2064631764] 'process raft request' (duration: 105.983609ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:48:39.269595Z","caller":"traceutil/trace.go:171","msg":"trace[559962790] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"162.571111ms","start":"2026-09-14T19:48:39.106968Z","end":"2026-09-14T19:48:39.269539Z","steps":["trace[559962790] 'process raft request' (duration: 162.365629ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:48:39.269795Z","caller":"traceutil/trace.go:171","msg":"trace[1624298254] linearizableReadLoop","detail":"{readStateIndex:5192; appliedIndex:5188; }","duration":"156.263166ms","start":"2026-09-14T19:48:39.1135Z","end":"2026-09-14T19:48:39.269763Z","steps":["trace[1624298254] 'read index received' (duration: 13.366544ms)","trace[1624298254] 'applied index is now lower than readState.Index' (duration: 142.893922ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:48:39.269865Z","caller":"traceutil/trace.go:171","msg":"trace[1197037643] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"161.606585ms","start":"2026-09-14T19:48:39.108223Z","end":"2026-09-14T19:48:39.26983Z","steps":["trace[1197037643] 'process raft request' (duration: 161.257844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:48:39.270067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.527421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1c4d9462-4a7f-4cde-a554-ab18276296f2\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-14T19:48:39.270106Z","caller":"traceutil/trace.go:171","msg":"trace[327718911] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1c4d9462-4a7f-4cde-a554-ab18276296f2; range_end:; response_count:1; response_revision:5006; }","duration":"156.613586ms","start":"2026-09-14T19:48:39.11348Z","end":"2026-09-14T19:48:39.270094Z","steps":["trace[327718911] 'agreement among raft nodes before linearized reading' (duration: 156.414454ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:48:53.4268Z","caller":"traceutil/trace.go:171","msg":"trace[390209615] linearizableReadLoop","detail":"{readStateIndex:5432; appliedIndex:5431; }","duration":"207.22284ms","start":"2026-09-14T19:48:53.219545Z","end":"2026-09-14T19:48:53.426767Z","steps":["trace[390209615] 'read index received' (duration: 207.088383ms)","trace[390209615] 'applied index is now lower than readState.Index' (duration: 133.207µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T19:48:53.426962Z","caller":"traceutil/trace.go:171","msg":"trace[582220383] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"229.569284ms","start":"2026-09-14T19:48:53.197381Z","end":"2026-09-14T19:48:53.42695Z","steps":["trace[582220383] 'process raft request' (duration: 229.16023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:48:53.427468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.90163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-14T19:48:53.427569Z","caller":"traceutil/trace.go:171","msg":"trace[550508835] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5240; }","duration":"208.059779ms","start":"2026-09-14T19:48:53.219484Z","end":"2026-09-14T19:48:53.427543Z","steps":["trace[550508835] 'agreement among raft nodes before linearized reading' (duration: 207.774363ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:48:53.444066Z","caller":"traceutil/trace.go:171","msg":"trace[385107217] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"194.478161ms","start":"2026-09-14T19:48:53.249541Z","end":"2026-09-14T19:48:53.444019Z","steps":["trace[385107217] 'process raft request' (duration: 194.339393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T19:48:53.939888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.871857ms","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-09-14T19:48:53.939954Z","caller":"traceutil/trace.go:171","msg":"trace[555831763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5253; }","duration":"102.991844ms","start":"2026-09-14T19:48:53.836945Z","end":"2026-09-14T19:48:53.939937Z","steps":["trace[555831763] 'range keys from in-memory index tree' (duration: 102.660055ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T19:49:00.355975Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2833} {"level":"info","ts":"2026-09-14T19:49:00.438648Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2833,"took":"81.180905ms","hash":1740502888,"current-db-size-bytes":53104640,"current-db-size":"53 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-14T19:49:00.438734Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1740502888,"revision":2833,"compact-revision":-1} {"level":"info","ts":"2026-09-14T19:54:00.364858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5294} {"level":"info","ts":"2026-09-14T19:54:00.482451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5294,"took":"114.44814ms","hash":2325144835,"current-db-size-bytes":53104640,"current-db-size":"53 MB","current-db-size-in-use-bytes":18984960,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-14T19:54:00.482521Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2325144835,"revision":5294,"compact-revision":2833}