{"level":"warn","ts":"2026-09-13T17:32:35.981548Z","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-13T17:32:35.981694Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.191: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.191:2380","--initial-cluster=instance=https://162.253.55.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.191: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-13T17:32:35.981798Z","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-13T17:32:35.981809Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-09-13T17:32:35.98183Z","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-13T17:32:35.982498Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"]} {"level":"info","ts":"2026-09-13T17:32:35.982582Z","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.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.191: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-13T17:32:35.987234Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.436529ms"} {"level":"info","ts":"2026-09-13T17:32:35.995847Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adb6690514c92321","cluster-id":"ee04900e3a861beb"} {"level":"info","ts":"2026-09-13T17:32:35.995966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=()"} {"level":"info","ts":"2026-09-13T17:32:35.996012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 0"} {"level":"info","ts":"2026-09-13T17:32:35.996047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adb6690514c92321 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-13T17:32:35.996056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became follower at term 1"} {"level":"info","ts":"2026-09-13T17:32:35.996099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"warn","ts":"2026-09-13T17:32:36.004435Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-13T17:32:36.005926Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-13T17:32:36.007233Z","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-13T17:32:36.009344Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adb6690514c92321","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-13T17:32:36.009655Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adb6690514c92321","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-13T17:32:36.00979Z","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-13T17:32:36.009822Z","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-13T17:32:36.009832Z","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-13T17:32:36.01068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 switched to configuration voters=(12517307684867351329)"} {"level":"info","ts":"2026-09-13T17:32:36.01205Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","added-peer-id":"adb6690514c92321","added-peer-peer-urls":["https://162.253.55.191:2380"]} {"level":"info","ts":"2026-09-13T17:32:36.012741Z","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-13T17:32:36.013089Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adb6690514c92321","initial-advertise-peer-urls":["https://162.253.55.191:2380"],"listen-peer-urls":["https://162.253.55.191:2380"],"advertise-client-urls":["https://162.253.55.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-13T17:32:36.013307Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-09-13T17:32:36.013338Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.191:2380"} {"level":"info","ts":"2026-09-13T17:32:36.01398Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-13T17:32:36.096827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 is starting a new election at term 1"} {"level":"info","ts":"2026-09-13T17:32:36.096941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-13T17:32:36.096977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgPreVoteResp from adb6690514c92321 at term 1"} {"level":"info","ts":"2026-09-13T17:32:36.097002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became candidate at term 2"} {"level":"info","ts":"2026-09-13T17:32:36.097018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 received MsgVoteResp from adb6690514c92321 at term 2"} {"level":"info","ts":"2026-09-13T17:32:36.097035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adb6690514c92321 became leader at term 2"} {"level":"info","ts":"2026-09-13T17:32:36.097055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adb6690514c92321 elected leader adb6690514c92321 at term 2"} {"level":"info","ts":"2026-09-13T17:32:36.098347Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-13T17:32:36.098355Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adb6690514c92321","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.191:2379]}","request-path":"/0/members/adb6690514c92321/attributes","cluster-id":"ee04900e3a861beb","publish-timeout":"7s"} {"level":"info","ts":"2026-09-13T17:32:36.098069Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-13T17:32:36.098681Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-13T17:32:36.09862Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-13T17:32:36.098724Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-13T17:32:36.099442Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ee04900e3a861beb","local-member-id":"adb6690514c92321","cluster-version":"3.5"} {"level":"info","ts":"2026-09-13T17:32:36.099512Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-13T17:32:36.099569Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-13T17:32:36.101872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.191:2379"} {"level":"info","ts":"2026-09-13T17:32:36.102176Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-13T17:32:41.085607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.295092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-13T17:32:41.085714Z","caller":"traceutil/trace.go:171","msg":"trace[1608617571] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:229; }","duration":"218.639398ms","start":"2026-09-13T17:32:40.86706Z","end":"2026-09-13T17:32:41.0857Z","steps":["trace[1608617571] 'read index received' (duration: 11.748597ms)","trace[1608617571] 'applied index is now lower than readState.Index' (duration: 206.889961ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:32:41.085718Z","caller":"traceutil/trace.go:171","msg":"trace[1174396051] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"332.292666ms","start":"2026-09-13T17:32:40.753407Z","end":"2026-09-13T17:32:41.0857Z","steps":["trace[1174396051] 'process raft request' (duration: 125.429965ms)","trace[1174396051] 'compare' (duration: 206.137469ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:32:41.085839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.789171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"} {"level":"info","ts":"2026-09-13T17:32:41.085866Z","caller":"traceutil/trace.go:171","msg":"trace[1482730607] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:224; }","duration":"218.866552ms","start":"2026-09-13T17:32:40.866994Z","end":"2026-09-13T17:32:41.08586Z","steps":["trace[1482730607] 'agreement among raft nodes before linearized reading' (duration: 218.78157ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:32:41.085877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:32:40.753387Z","time spent":"332.372528ms","remote":"127.0.0.1:33112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":180,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-13T17:32:41.08602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.543857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-13T17:32:41.08604Z","caller":"traceutil/trace.go:171","msg":"trace[1953611183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:224; }","duration":"137.602677ms","start":"2026-09-13T17:32:40.948434Z","end":"2026-09-13T17:32:41.086036Z","steps":["trace[1953611183] 'agreement among raft nodes before linearized reading' (duration: 137.569967ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:32:41.383828Z","caller":"traceutil/trace.go:171","msg":"trace[681723399] linearizableReadLoop","detail":"{readStateIndex:231; appliedIndex:230; }","duration":"291.533478ms","start":"2026-09-13T17:32:41.092258Z","end":"2026-09-13T17:32:41.383791Z","steps":["trace[681723399] 'read index received' (duration: 223.472446ms)","trace[681723399] 'applied index is now lower than readState.Index' (duration: 68.059542ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:32:41.384138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.825623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-13T17:32:41.384197Z","caller":"traceutil/trace.go:171","msg":"trace[1055949711] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:225; }","duration":"291.947894ms","start":"2026-09-13T17:32:41.092232Z","end":"2026-09-13T17:32:41.38418Z","steps":["trace[1055949711] 'agreement among raft nodes before linearized reading' (duration: 291.752311ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:32:41.384612Z","caller":"traceutil/trace.go:171","msg":"trace[3010636] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"292.636047ms","start":"2026-09-13T17:32:41.091249Z","end":"2026-09-13T17:32:41.383886Z","steps":["trace[3010636] 'process raft request' (duration: 224.467733ms)","trace[3010636] 'compare' (duration: 67.902079ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:32:41.438057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.549799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-13T17:32:41.438004Z","caller":"traceutil/trace.go:171","msg":"trace[1596795053] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"344.694033ms","start":"2026-09-13T17:32:41.093244Z","end":"2026-09-13T17:32:41.437938Z","steps":["trace[1596795053] 'process raft request' (duration: 344.470468ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:32:41.438165Z","caller":"traceutil/trace.go:171","msg":"trace[1828235766] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:226; }","duration":"196.719512ms","start":"2026-09-13T17:32:41.241425Z","end":"2026-09-13T17:32:41.438145Z","steps":["trace[1828235766] 'agreement among raft nodes before linearized reading' (duration: 196.538089ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:32:41.438754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:32:41.093224Z","time spent":"344.993387ms","remote":"127.0.0.1:33104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-13T17:33:17.198559Z","caller":"traceutil/trace.go:171","msg":"trace[1981740020] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"121.675578ms","start":"2026-09-13T17:33:17.076855Z","end":"2026-09-13T17:33:17.198531Z","steps":["trace[1981740020] 'process raft request' (duration: 120.450512ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:17.198679Z","caller":"traceutil/trace.go:171","msg":"trace[2046886835] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"120.824678ms","start":"2026-09-13T17:33:17.077819Z","end":"2026-09-13T17:33:17.198644Z","steps":["trace[2046886835] 'process raft request' (duration: 120.624095ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:17.198838Z","caller":"traceutil/trace.go:171","msg":"trace[497806270] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"104.755375ms","start":"2026-09-13T17:33:17.094073Z","end":"2026-09-13T17:33:17.198828Z","steps":["trace[497806270] 'process raft request' (duration: 104.515732ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:17.198825Z","caller":"traceutil/trace.go:171","msg":"trace[1700226682] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"108.500355ms","start":"2026-09-13T17:33:17.090254Z","end":"2026-09-13T17:33:17.198755Z","steps":["trace[1700226682] 'process raft request' (duration: 108.274282ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:17.198964Z","caller":"traceutil/trace.go:171","msg":"trace[881762806] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"102.833109ms","start":"2026-09-13T17:33:17.096122Z","end":"2026-09-13T17:33:17.198955Z","steps":["trace[881762806] 'process raft request' (duration: 102.557376ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:17.198928Z","caller":"traceutil/trace.go:171","msg":"trace[878139113] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"102.804639ms","start":"2026-09-13T17:33:17.096116Z","end":"2026-09-13T17:33:17.19892Z","steps":["trace[878139113] 'process raft request' (duration: 102.521375ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:23.859737Z","caller":"traceutil/trace.go:171","msg":"trace[1921502720] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"121.432957ms","start":"2026-09-13T17:33:23.738262Z","end":"2026-09-13T17:33:23.859695Z","steps":["trace[1921502720] 'read index received' (duration: 120.251678ms)","trace[1921502720] 'applied index is now lower than readState.Index' (duration: 1.179489ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:33:23.859824Z","caller":"traceutil/trace.go:171","msg":"trace[489043014] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"302.886658ms","start":"2026-09-13T17:33:23.556883Z","end":"2026-09-13T17:33:23.85977Z","steps":["trace[489043014] 'process raft request' (duration: 301.922028ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:23.860075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:33:23.556819Z","time spent":"303.105876ms","remote":"127.0.0.1:33024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-13T17:33:23.860102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.330801ms","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-13T17:33:23.860333Z","caller":"traceutil/trace.go:171","msg":"trace[1023499249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"121.500518ms","start":"2026-09-13T17:33:23.738705Z","end":"2026-09-13T17:33:23.860206Z","steps":["trace[1023499249] 'agreement among raft nodes before linearized reading' (duration: 121.261769ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:23.86049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.196628ms","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-09-13T17:33:23.860583Z","caller":"traceutil/trace.go:171","msg":"trace[112294983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"122.375015ms","start":"2026-09-13T17:33:23.738189Z","end":"2026-09-13T17:33:23.860564Z","steps":["trace[112294983] 'agreement among raft nodes before linearized reading' (duration: 121.711948ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:24.042748Z","caller":"traceutil/trace.go:171","msg":"trace[668415056] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"176.593449ms","start":"2026-09-13T17:33:23.866123Z","end":"2026-09-13T17:33:24.042716Z","steps":["trace[668415056] 'process raft request' (duration: 102.428432ms)","trace[668415056] 'compare' (duration: 74.031761ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:33:24.201613Z","caller":"traceutil/trace.go:171","msg":"trace[1846886091] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:623; }","duration":"177.634485ms","start":"2026-09-13T17:33:24.023953Z","end":"2026-09-13T17:33:24.201587Z","steps":["trace[1846886091] 'read index received' (duration: 139.06129ms)","trace[1846886091] 'applied index is now lower than readState.Index' (duration: 38.571955ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:33:24.201739Z","caller":"traceutil/trace.go:171","msg":"trace[622628624] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"334.699155ms","start":"2026-09-13T17:33:23.867029Z","end":"2026-09-13T17:33:24.201729Z","steps":["trace[622628624] 'process raft request' (duration: 296.005306ms)","trace[622628624] 'compare' (duration: 38.180379ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:33:24.20185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:33:23.866968Z","time spent":"334.792049ms","remote":"127.0.0.1:33162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-13T17:33:24.202153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.201688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cn5j9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-13T17:33:24.202189Z","caller":"traceutil/trace.go:171","msg":"trace[1566465263] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cn5j9; range_end:; response_count:1; response_revision:603; }","duration":"178.287501ms","start":"2026-09-13T17:33:24.023889Z","end":"2026-09-13T17:33:24.202177Z","steps":["trace[1566465263] 'agreement among raft nodes before linearized reading' (duration: 178.201588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:24.202231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.532315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-13T17:33:24.202361Z","caller":"traceutil/trace.go:171","msg":"trace[292951618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"129.726523ms","start":"2026-09-13T17:33:24.072613Z","end":"2026-09-13T17:33:24.20234Z","steps":["trace[292951618] 'agreement among raft nodes before linearized reading' (duration: 129.469572ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:24.202306Z","caller":"traceutil/trace.go:171","msg":"trace[77829263] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"265.8345ms","start":"2026-09-13T17:33:23.936463Z","end":"2026-09-13T17:33:24.202298Z","steps":["trace[77829263] 'process raft request' (duration: 265.050398ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:24.865742Z","caller":"traceutil/trace.go:171","msg":"trace[1463682273] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"336.962511ms","start":"2026-09-13T17:33:24.528725Z","end":"2026-09-13T17:33:24.865688Z","steps":["trace[1463682273] 'read index received' (duration: 336.71448ms)","trace[1463682273] 'applied index is now lower than readState.Index' (duration: 246.571µs)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:33:24.865798Z","caller":"traceutil/trace.go:171","msg":"trace[287439914] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"637.254304ms","start":"2026-09-13T17:33:24.228508Z","end":"2026-09-13T17:33:24.865762Z","steps":["trace[287439914] 'process raft request' (duration: 636.904529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:24.865994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.257883ms","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-13T17:33:24.866041Z","caller":"traceutil/trace.go:171","msg":"trace[477450107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"337.355296ms","start":"2026-09-13T17:33:24.528675Z","end":"2026-09-13T17:33:24.866031Z","steps":["trace[477450107] 'agreement among raft nodes before linearized reading' (duration: 337.176379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:24.866069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:33:24.52866Z","time spent":"337.402879ms","remote":"127.0.0.1:33162","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-13T17:33:24.866255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:33:24.228482Z","time spent":"637.389959ms","remote":"127.0.0.1:33106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-13T17:33:24.888516Z","caller":"traceutil/trace.go:171","msg":"trace[1883542038] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"233.336891ms","start":"2026-09-13T17:33:24.655155Z","end":"2026-09-13T17:33:24.888492Z","steps":["trace[1883542038] 'process raft request' (duration: 232.811339ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:26.31775Z","caller":"traceutil/trace.go:171","msg":"trace[1164162354] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"106.055354ms","start":"2026-09-13T17:33:26.211665Z","end":"2026-09-13T17:33:26.31772Z","steps":["trace[1164162354] 'process raft request' (duration: 101.333537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:33:40.538922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.991631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-13T17:33:40.538959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.196048ms","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-13T17:33:40.539001Z","caller":"traceutil/trace.go:171","msg":"trace[54714353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"145.126285ms","start":"2026-09-13T17:33:40.393857Z","end":"2026-09-13T17:33:40.538983Z","steps":["trace[54714353] 'range keys from in-memory index tree' (duration: 144.752753ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:33:40.539044Z","caller":"traceutil/trace.go:171","msg":"trace[1506500203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:767; }","duration":"145.317821ms","start":"2026-09-13T17:33:40.393706Z","end":"2026-09-13T17:33:40.539023Z","steps":["trace[1506500203] 'range keys from in-memory index tree' (duration: 145.055593ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:34:13.751692Z","caller":"traceutil/trace.go:171","msg":"trace[819060228] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"111.451819ms","start":"2026-09-13T17:34:13.640206Z","end":"2026-09-13T17:34:13.751658Z","steps":["trace[819060228] 'process raft request' (duration: 110.987597ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:34:50.612528Z","caller":"traceutil/trace.go:171","msg":"trace[1227257936] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1686; }","duration":"100.099329ms","start":"2026-09-13T17:34:50.512406Z","end":"2026-09-13T17:34:50.612505Z","steps":["trace[1227257936] 'process raft request' (duration: 99.899045ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:35:01.216387Z","caller":"traceutil/trace.go:171","msg":"trace[1758427755] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"360.459034ms","start":"2026-09-13T17:35:00.855903Z","end":"2026-09-13T17:35:01.216362Z","steps":["trace[1758427755] 'read index received' (duration: 360.310161ms)","trace[1758427755] 'applied index is now lower than readState.Index' (duration: 147.973µs)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:35:01.216466Z","caller":"traceutil/trace.go:171","msg":"trace[1229770227] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"447.709152ms","start":"2026-09-13T17:35:00.768717Z","end":"2026-09-13T17:35:01.216426Z","steps":["trace[1229770227] 'process raft request' (duration: 447.475077ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.216687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:35:00.768681Z","time spent":"447.891756ms","remote":"127.0.0.1:33162","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-13T17:35:01.216774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.547565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-13T17:35:01.216856Z","caller":"traceutil/trace.go:171","msg":"trace[1212929113] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1846; }","duration":"294.693258ms","start":"2026-09-13T17:35:00.922144Z","end":"2026-09-13T17:35:01.216837Z","steps":["trace[1212929113] 'agreement among raft nodes before linearized reading' (duration: 294.558094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.217184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.090425ms","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-09-13T17:35:01.217237Z","caller":"traceutil/trace.go:171","msg":"trace[1795095932] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1846; }","duration":"119.163517ms","start":"2026-09-13T17:35:01.098061Z","end":"2026-09-13T17:35:01.217225Z","steps":["trace[1795095932] 'agreement among raft nodes before linearized reading' (duration: 118.988973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.217196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.582307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-800ed692-fb3a-48a1-a0c7-baae42f016d5\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-09-13T17:35:01.217403Z","caller":"traceutil/trace.go:171","msg":"trace[993978399] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-800ed692-fb3a-48a1-a0c7-baae42f016d5; range_end:; response_count:1; response_revision:1846; }","duration":"179.865702ms","start":"2026-09-13T17:35:01.037523Z","end":"2026-09-13T17:35:01.217388Z","steps":["trace[993978399] 'agreement among raft nodes before linearized reading' (duration: 179.560196ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.217629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.885821ms","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-13T17:35:01.217662Z","caller":"traceutil/trace.go:171","msg":"trace[337828379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1846; }","duration":"117.929641ms","start":"2026-09-13T17:35:01.099724Z","end":"2026-09-13T17:35:01.217654Z","steps":["trace[337828379] 'agreement among raft nodes before linearized reading' (duration: 117.815369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.217697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.81686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-13T17:35:01.21815Z","caller":"traceutil/trace.go:171","msg":"trace[736288851] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1846; }","duration":"362.282591ms","start":"2026-09-13T17:35:00.855837Z","end":"2026-09-13T17:35:01.21812Z","steps":["trace[736288851] 'agreement among raft nodes before linearized reading' (duration: 360.754889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:01.218231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-13T17:35:00.855812Z","time spent":"362.406924ms","remote":"127.0.0.1:44706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5468,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-13T17:35:01.349138Z","caller":"traceutil/trace.go:171","msg":"trace[1742405771] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"126.006417ms","start":"2026-09-13T17:35:01.223102Z","end":"2026-09-13T17:35:01.349109Z","steps":["trace[1742405771] 'process raft request' (duration: 94.933869ms)","trace[1742405771] 'compare' (duration: 30.937676ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:35:01.544055Z","caller":"traceutil/trace.go:171","msg":"trace[1287923652] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"142.799411ms","start":"2026-09-13T17:35:01.401209Z","end":"2026-09-13T17:35:01.544009Z","steps":["trace[1287923652] 'process raft request' (duration: 91.10927ms)","trace[1287923652] 'compare' (duration: 51.317414ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:35:15.561005Z","caller":"traceutil/trace.go:171","msg":"trace[1914483739] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2040; }","duration":"134.986255ms","start":"2026-09-13T17:35:15.425987Z","end":"2026-09-13T17:35:15.560973Z","steps":["trace[1914483739] 'read index received' (duration: 134.944614ms)","trace[1914483739] 'applied index is now lower than readState.Index' (duration: 40.321µs)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:35:15.561143Z","caller":"traceutil/trace.go:171","msg":"trace[603787058] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"185.11976ms","start":"2026-09-13T17:35:15.375946Z","end":"2026-09-13T17:35:15.561066Z","steps":["trace[603787058] 'process raft request' (duration: 184.840695ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:35:15.561271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.263111ms","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-13T17:35:15.561313Z","caller":"traceutil/trace.go:171","msg":"trace[1271267097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1965; }","duration":"135.366583ms","start":"2026-09-13T17:35:15.425931Z","end":"2026-09-13T17:35:15.561297Z","steps":["trace[1271267097] 'agreement among raft nodes before linearized reading' (duration: 135.165619ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:36:42.883145Z","caller":"traceutil/trace.go:171","msg":"trace[49422015] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"119.41305ms","start":"2026-09-13T17:36:42.763698Z","end":"2026-09-13T17:36:42.883111Z","steps":["trace[49422015] 'process raft request' (duration: 119.219106ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:37:19.19596Z","caller":"traceutil/trace.go:171","msg":"trace[1134616522] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"103.097275ms","start":"2026-09-13T17:37:19.092831Z","end":"2026-09-13T17:37:19.195928Z","steps":["trace[1134616522] 'process raft request' (duration: 84.384702ms)","trace[1134616522] 'compare' (duration: 18.556971ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:42:00.963753Z","caller":"traceutil/trace.go:171","msg":"trace[303742428] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4862; }","duration":"108.093086ms","start":"2026-09-13T17:42:00.855613Z","end":"2026-09-13T17:42:00.963706Z","steps":["trace[303742428] 'process raft request' (duration: 29.396887ms)","trace[303742428] 'compare' (duration: 78.493425ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:42:05.15699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.919795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362739"} {"level":"info","ts":"2026-09-13T17:42:05.157056Z","caller":"traceutil/trace.go:171","msg":"trace[242197290] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4956; }","duration":"102.001067ms","start":"2026-09-13T17:42:05.055039Z","end":"2026-09-13T17:42:05.15704Z","steps":["trace[242197290] 'range keys from in-memory index tree' (duration: 100.930482ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:11.77534Z","caller":"traceutil/trace.go:171","msg":"trace[1529683766] linearizableReadLoop","detail":"{readStateIndex:5252; appliedIndex:5251; }","duration":"155.05931ms","start":"2026-09-13T17:42:11.620252Z","end":"2026-09-13T17:42:11.775312Z","steps":["trace[1529683766] 'read index received' (duration: 154.838766ms)","trace[1529683766] 'applied index is now lower than readState.Index' (duration: 219.734µs)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:42:11.775449Z","caller":"traceutil/trace.go:171","msg":"trace[1337365206] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"163.006465ms","start":"2026-09-13T17:42:11.612414Z","end":"2026-09-13T17:42:11.77542Z","steps":["trace[1337365206] 'process raft request' (duration: 162.742519ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:11.775611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.345206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c9a9f2ac-5546-46d9-93e5-0405559f7951\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-13T17:42:11.775671Z","caller":"traceutil/trace.go:171","msg":"trace[243521328] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c9a9f2ac-5546-46d9-93e5-0405559f7951; range_end:; response_count:1; response_revision:5060; }","duration":"155.471329ms","start":"2026-09-13T17:42:11.620182Z","end":"2026-09-13T17:42:11.775654Z","steps":["trace[243521328] 'agreement among raft nodes before linearized reading' (duration: 155.284095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:11.775722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.426779ms","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-09-13T17:42:11.775764Z","caller":"traceutil/trace.go:171","msg":"trace[1894837012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5060; }","duration":"146.497931ms","start":"2026-09-13T17:42:11.629254Z","end":"2026-09-13T17:42:11.775751Z","steps":["trace[1894837012] 'agreement among raft nodes before linearized reading' (duration: 146.348768ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:12.290651Z","caller":"traceutil/trace.go:171","msg":"trace[744339558] linearizableReadLoop","detail":"{readStateIndex:5258; appliedIndex:5255; }","duration":"220.262622ms","start":"2026-09-13T17:42:12.070364Z","end":"2026-09-13T17:42:12.290627Z","steps":["trace[744339558] 'read index received' (duration: 10.248145ms)","trace[744339558] 'applied index is now lower than readState.Index' (duration: 210.013527ms)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:42:12.29094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.552998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-13T17:42:12.29099Z","caller":"traceutil/trace.go:171","msg":"trace[557233913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5066; }","duration":"220.64518ms","start":"2026-09-13T17:42:12.070331Z","end":"2026-09-13T17:42:12.290976Z","steps":["trace[557233913] 'agreement among raft nodes before linearized reading' (duration: 220.551308ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:12.29097Z","caller":"traceutil/trace.go:171","msg":"trace[620080105] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"225.982429ms","start":"2026-09-13T17:42:12.064907Z","end":"2026-09-13T17:42:12.290889Z","steps":["trace[620080105] 'process raft request' (duration: 225.630991ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:12.291042Z","caller":"traceutil/trace.go:171","msg":"trace[1657638729] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"228.381112ms","start":"2026-09-13T17:42:12.062569Z","end":"2026-09-13T17:42:12.29095Z","steps":["trace[1657638729] 'process raft request' (duration: 220.346545ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:12.3003Z","caller":"traceutil/trace.go:171","msg":"trace[1490414713] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"184.361922ms","start":"2026-09-13T17:42:12.115897Z","end":"2026-09-13T17:42:12.300259Z","steps":["trace[1490414713] 'process raft request' (duration: 183.998814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:12.30032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.461885ms","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-13T17:42:12.300397Z","caller":"traceutil/trace.go:171","msg":"trace[1933369164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5068; }","duration":"199.570088ms","start":"2026-09-13T17:42:12.100807Z","end":"2026-09-13T17:42:12.300377Z","steps":["trace[1933369164] 'agreement among raft nodes before linearized reading' (duration: 199.317032ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:12.300321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.943257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-13T17:42:12.300543Z","caller":"traceutil/trace.go:171","msg":"trace[1099408017] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5068; }","duration":"186.210462ms","start":"2026-09-13T17:42:12.114318Z","end":"2026-09-13T17:42:12.300528Z","steps":["trace[1099408017] 'agreement among raft nodes before linearized reading' (duration: 185.800853ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:12.300754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.428968ms","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-13T17:42:12.3008Z","caller":"traceutil/trace.go:171","msg":"trace[1674575161] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5068; }","duration":"201.517059ms","start":"2026-09-13T17:42:12.09927Z","end":"2026-09-13T17:42:12.300788Z","steps":["trace[1674575161] 'agreement among raft nodes before linearized reading' (duration: 201.355166ms)"],"step_count":1} {"level":"warn","ts":"2026-09-13T17:42:12.302167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.802573ms","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-13T17:42:12.302244Z","caller":"traceutil/trace.go:171","msg":"trace[2040885227] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5068; }","duration":"210.928596ms","start":"2026-09-13T17:42:12.091302Z","end":"2026-09-13T17:42:12.30223Z","steps":["trace[2040885227] 'agreement among raft nodes before linearized reading' (duration: 208.975953ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:25.862266Z","caller":"traceutil/trace.go:171","msg":"trace[981287076] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"184.652528ms","start":"2026-09-13T17:42:25.67759Z","end":"2026-09-13T17:42:25.862243Z","steps":["trace[981287076] 'process raft request' (duration: 184.479885ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:25.862268Z","caller":"traceutil/trace.go:171","msg":"trace[1276433420] linearizableReadLoop","detail":"{readStateIndex:5447; appliedIndex:5447; }","duration":"182.136763ms","start":"2026-09-13T17:42:25.680109Z","end":"2026-09-13T17:42:25.862246Z","steps":["trace[1276433420] 'read index received' (duration: 182.128643ms)","trace[1276433420] 'applied index is now lower than readState.Index' (duration: 6.53µs)"],"step_count":2} {"level":"warn","ts":"2026-09-13T17:42:25.862451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.340058ms","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-13T17:42:25.862494Z","caller":"traceutil/trace.go:171","msg":"trace[1423911717] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5248; }","duration":"182.44334ms","start":"2026-09-13T17:42:25.68004Z","end":"2026-09-13T17:42:25.862484Z","steps":["trace[1423911717] 'agreement among raft nodes before linearized reading' (duration: 182.272097ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:25.898276Z","caller":"traceutil/trace.go:171","msg":"trace[1683504947] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"127.899477ms","start":"2026-09-13T17:42:25.770341Z","end":"2026-09-13T17:42:25.89824Z","steps":["trace[1683504947] 'process raft request' (duration: 127.664562ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:26.088532Z","caller":"traceutil/trace.go:171","msg":"trace[1929001621] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"182.634103ms","start":"2026-09-13T17:42:25.905859Z","end":"2026-09-13T17:42:26.088493Z","steps":["trace[1929001621] 'process raft request' (duration: 179.579335ms)"],"step_count":1} {"level":"info","ts":"2026-09-13T17:42:36.334235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2840} {"level":"info","ts":"2026-09-13T17:42:36.424535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2840,"took":"88.730195ms","hash":232880397,"current-db-size-bytes":51392512,"current-db-size":"51 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-13T17:42:36.424605Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":232880397,"revision":2840,"compact-revision":-1} {"level":"info","ts":"2026-09-13T17:45:35.769033Z","caller":"traceutil/trace.go:171","msg":"trace[17571453] transaction","detail":"{read_only:false; response_revision:6540; number_of_response:1; }","duration":"116.697292ms","start":"2026-09-13T17:45:35.652291Z","end":"2026-09-13T17:45:35.768988Z","steps":["trace[17571453] 'process raft request' (duration: 70.907594ms)","trace[17571453] 'compare' (duration: 44.854779ms)"],"step_count":2} {"level":"info","ts":"2026-09-13T17:47:36.342553Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5324} {"level":"info","ts":"2026-09-13T17:47:36.430931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5324,"took":"86.044966ms","hash":1789844273,"current-db-size-bytes":51392512,"current-db-size":"51 MB","current-db-size-in-use-bytes":18927616,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-13T17:47:36.431016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1789844273,"revision":5324,"compact-revision":2840}