{"level":"warn","ts":"2026-07-26T14:35:20.725875Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T14:35:20.726072Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.222: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.222:2380","--initial-cluster=instance=https://162.253.55.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.222: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-07-26T14:35:20.726182Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-26T14:35:20.726218Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T14:35:20.726292Z","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-07-26T14:35:20.727042Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"]} {"level":"info","ts":"2026-07-26T14:35:20.727209Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.222: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-07-26T14:35:20.731251Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.658389ms"} {"level":"info","ts":"2026-07-26T14:35:20.737244Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5a9e84e0e0a90b63","cluster-id":"c7ddd50204a2b828"} {"level":"info","ts":"2026-07-26T14:35:20.737397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=()"} {"level":"info","ts":"2026-07-26T14:35:20.737456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 0"} {"level":"info","ts":"2026-07-26T14:35:20.737502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5a9e84e0e0a90b63 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-26T14:35:20.737553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became follower at term 1"} {"level":"info","ts":"2026-07-26T14:35:20.737631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"warn","ts":"2026-07-26T14:35:20.744209Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-26T14:35:20.747861Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-26T14:35:20.749757Z","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-07-26T14:35:20.752153Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5a9e84e0e0a90b63","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-26T14:35:20.752362Z","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-07-26T14:35:20.7524Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5a9e84e0e0a90b63","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-26T14:35:20.752473Z","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-07-26T14:35:20.752486Z","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-07-26T14:35:20.754453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 switched to configuration voters=(6529802611110513507)"} {"level":"info","ts":"2026-07-26T14:35:20.754758Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","added-peer-id":"5a9e84e0e0a90b63","added-peer-peer-urls":["https://162.253.55.222:2380"]} {"level":"info","ts":"2026-07-26T14:35:20.757539Z","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-07-26T14:35:20.757659Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T14:35:20.757704Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.222:2380"} {"level":"info","ts":"2026-07-26T14:35:20.757825Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5a9e84e0e0a90b63","initial-advertise-peer-urls":["https://162.253.55.222:2380"],"listen-peer-urls":["https://162.253.55.222:2380"],"advertise-client-urls":["https://162.253.55.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-26T14:35:20.757876Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-26T14:35:21.13851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 is starting a new election at term 1"} {"level":"info","ts":"2026-07-26T14:35:21.138615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-26T14:35:21.138645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgPreVoteResp from 5a9e84e0e0a90b63 at term 1"} {"level":"info","ts":"2026-07-26T14:35:21.138668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became candidate at term 2"} {"level":"info","ts":"2026-07-26T14:35:21.13868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 received MsgVoteResp from 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T14:35:21.138709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a9e84e0e0a90b63 became leader at term 2"} {"level":"info","ts":"2026-07-26T14:35:21.138725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a9e84e0e0a90b63 elected leader 5a9e84e0e0a90b63 at term 2"} {"level":"info","ts":"2026-07-26T14:35:21.139674Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T14:35:21.140661Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5a9e84e0e0a90b63","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.222:2379]}","request-path":"/0/members/5a9e84e0e0a90b63/attributes","cluster-id":"c7ddd50204a2b828","publish-timeout":"7s"} {"level":"info","ts":"2026-07-26T14:35:21.140663Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T14:35:21.140699Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T14:35:21.14115Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-26T14:35:21.141237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-26T14:35:21.141565Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c7ddd50204a2b828","local-member-id":"5a9e84e0e0a90b63","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T14:35:21.14167Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T14:35:21.141703Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T14:35:21.142424Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.222:2379"} {"level":"info","ts":"2026-07-26T14:35:21.145792Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-26T14:35:43.220197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.969909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T14:35:43.220153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.357565ms","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-07-26T14:35:43.220313Z","caller":"traceutil/trace.go:171","msg":"trace[258437189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"170.113251ms","start":"2026-07-26T14:35:43.05018Z","end":"2026-07-26T14:35:43.220293Z","steps":["trace[258437189] 'range keys from in-memory index tree' (duration: 169.858567ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:35:43.220404Z","caller":"traceutil/trace.go:171","msg":"trace[747772609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"242.676779ms","start":"2026-07-26T14:35:42.977634Z","end":"2026-07-26T14:35:43.220311Z","steps":["trace[747772609] 'range keys from in-memory index tree' (duration: 242.184322ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:35:43.376741Z","caller":"traceutil/trace.go:171","msg":"trace[1545038852] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"150.793567ms","start":"2026-07-26T14:35:43.225929Z","end":"2026-07-26T14:35:43.376723Z","steps":["trace[1545038852] 'process raft request' (duration: 150.670785ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:35:43.401091Z","caller":"traceutil/trace.go:171","msg":"trace[69895592] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"166.541448ms","start":"2026-07-26T14:35:43.234526Z","end":"2026-07-26T14:35:43.401068Z","steps":["trace[69895592] 'process raft request' (duration: 166.345595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:35:59.744607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.381543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-26T14:35:59.74461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.011757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-26T14:35:59.744703Z","caller":"traceutil/trace.go:171","msg":"trace[604783846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"202.141269ms","start":"2026-07-26T14:35:59.542544Z","end":"2026-07-26T14:35:59.744685Z","steps":["trace[604783846] 'range keys from in-memory index tree' (duration: 201.924176ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:35:59.744694Z","caller":"traceutil/trace.go:171","msg":"trace[1714939423] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"119.521815ms","start":"2026-07-26T14:35:59.625154Z","end":"2026-07-26T14:35:59.744675Z","steps":["trace[1714939423] 'range keys from in-memory index tree' (duration: 119.264541ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:05.639797Z","caller":"traceutil/trace.go:171","msg":"trace[1717241552] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"151.448256ms","start":"2026-07-26T14:36:05.488315Z","end":"2026-07-26T14:36:05.639763Z","steps":["trace[1717241552] 'process raft request' (duration: 151.244034ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:05.679123Z","caller":"traceutil/trace.go:171","msg":"trace[1731398045] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"128.578515ms","start":"2026-07-26T14:36:05.550513Z","end":"2026-07-26T14:36:05.679091Z","steps":["trace[1731398045] 'process raft request' (duration: 127.988107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:06.202338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.401276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T14:36:06.202528Z","caller":"traceutil/trace.go:171","msg":"trace[864891379] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"409.237908ms","start":"2026-07-26T14:36:05.793274Z","end":"2026-07-26T14:36:06.202512Z","steps":["trace[864891379] 'read index received' (duration: 126.158283ms)","trace[864891379] 'applied index is now lower than readState.Index' (duration: 283.078695ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:36:06.202614Z","caller":"traceutil/trace.go:171","msg":"trace[206833848] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"415.757956ms","start":"2026-07-26T14:36:05.786847Z","end":"2026-07-26T14:36:06.202605Z","steps":["trace[206833848] 'process raft request' (duration: 415.592844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:06.202682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:05.786827Z","time spent":"415.810407ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:36:06.202693Z","caller":"traceutil/trace.go:171","msg":"trace[2087229421] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"415.821717ms","start":"2026-07-26T14:36:05.786842Z","end":"2026-07-26T14:36:06.202664Z","steps":["trace[2087229421] 'process raft request' (duration: 132.518759ms)","trace[2087229421] 'compare' (duration: 282.258814ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:36:06.202842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:05.786827Z","time spent":"415.940448ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:36:06.202991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.718994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:36:06.20303Z","caller":"traceutil/trace.go:171","msg":"trace[356729257] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:642; }","duration":"409.775446ms","start":"2026-07-26T14:36:05.793243Z","end":"2026-07-26T14:36:06.203019Z","steps":["trace[356729257] 'agreement among raft nodes before linearized reading' (duration: 409.714155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:06.203061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:05.793232Z","time spent":"409.823116ms","remote":"127.0.0.1:46266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-07-26T14:36:06.202936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.297069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:36:06.203316Z","caller":"traceutil/trace.go:171","msg":"trace[610795164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"154.680933ms","start":"2026-07-26T14:36:06.04859Z","end":"2026-07-26T14:36:06.203271Z","steps":["trace[610795164] 'agreement among raft nodes before linearized reading' (duration: 154.312758ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:06.670038Z","caller":"traceutil/trace.go:171","msg":"trace[1807527587] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"451.203267ms","start":"2026-07-26T14:36:06.218807Z","end":"2026-07-26T14:36:06.670011Z","steps":["trace[1807527587] 'process raft request' (duration: 433.421936ms)","trace[1807527587] 'compare' (duration: 17.68473ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:36:06.670173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:06.218781Z","time spent":"451.329349ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:36:06.938868Z","caller":"traceutil/trace.go:171","msg":"trace[1659733343] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"183.771207ms","start":"2026-07-26T14:36:06.755051Z","end":"2026-07-26T14:36:06.938822Z","steps":["trace[1659733343] 'read index received' (duration: 155.19274ms)","trace[1659733343] 'applied index is now lower than readState.Index' (duration: 28.577537ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:36:06.939009Z","caller":"traceutil/trace.go:171","msg":"trace[355451972] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"321.738194ms","start":"2026-07-26T14:36:06.617236Z","end":"2026-07-26T14:36:06.938974Z","steps":["trace[355451972] 'process raft request' (duration: 293.232858ms)","trace[355451972] 'compare' (duration: 27.899218ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:36:06.939015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.94337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:36:06.939078Z","caller":"traceutil/trace.go:171","msg":"trace[1245802078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"184.074462ms","start":"2026-07-26T14:36:06.754992Z","end":"2026-07-26T14:36:06.939066Z","steps":["trace[1245802078] 'agreement among raft nodes before linearized reading' (duration: 183.97146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:06.939143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:06.617205Z","time spent":"321.867007ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:36:21.273947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.877563ms","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-07-26T14:36:21.27454Z","caller":"traceutil/trace.go:171","msg":"trace[466671618] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"193.51436ms","start":"2026-07-26T14:36:21.080993Z","end":"2026-07-26T14:36:21.274507Z","steps":["trace[466671618] 'range keys from in-memory index tree' (duration: 192.725671ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:21.474958Z","caller":"traceutil/trace.go:171","msg":"trace[1843106099] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"196.57311ms","start":"2026-07-26T14:36:21.278364Z","end":"2026-07-26T14:36:21.474937Z","steps":["trace[1843106099] 'process raft request' (duration: 196.272577ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:21.482639Z","caller":"traceutil/trace.go:171","msg":"trace[949369150] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"200.831786ms","start":"2026-07-26T14:36:21.281794Z","end":"2026-07-26T14:36:21.482625Z","steps":["trace[949369150] 'process raft request' (duration: 200.747135ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:38.47544Z","caller":"traceutil/trace.go:171","msg":"trace[1852903551] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"102.930634ms","start":"2026-07-26T14:36:38.372486Z","end":"2026-07-26T14:36:38.475417Z","steps":["trace[1852903551] 'process raft request' (duration: 102.756752ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:56.730682Z","caller":"traceutil/trace.go:171","msg":"trace[1707106310] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"423.584497ms","start":"2026-07-26T14:36:56.307075Z","end":"2026-07-26T14:36:56.73066Z","steps":["trace[1707106310] 'process raft request' (duration: 423.453055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:56.730826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.307051Z","time spent":"423.704158ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:36:57.311206Z","caller":"traceutil/trace.go:171","msg":"trace[815581171] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1479; }","duration":"632.035398ms","start":"2026-07-26T14:36:56.679141Z","end":"2026-07-26T14:36:57.311177Z","steps":["trace[815581171] 'read index received' (duration: 51.387451ms)","trace[815581171] 'applied index is now lower than readState.Index' (duration: 580.646817ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:36:57.311404Z","caller":"traceutil/trace.go:171","msg":"trace[948418278] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"893.76946ms","start":"2026-07-26T14:36:56.417611Z","end":"2026-07-26T14:36:57.311381Z","steps":["trace[948418278] 'process raft request' (duration: 821.874873ms)","trace[948418278] 'compare' (duration: 71.542133ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:36:57.311554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.417595Z","time spent":"893.860271ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:36:57.311591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.429993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-26T14:36:57.311674Z","caller":"traceutil/trace.go:171","msg":"trace[393589062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1441; }","duration":"632.551954ms","start":"2026-07-26T14:36:56.679101Z","end":"2026-07-26T14:36:57.311653Z","steps":["trace[393589062] 'agreement among raft nodes before linearized reading' (duration: 632.313931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:57.311719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.679077Z","time spent":"632.633836ms","remote":"127.0.0.1:46304","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-07-26T14:36:57.318976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.244997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:36:57.319048Z","caller":"traceutil/trace.go:171","msg":"trace[1317959224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1442; }","duration":"269.374408ms","start":"2026-07-26T14:36:57.049657Z","end":"2026-07-26T14:36:57.319031Z","steps":["trace[1317959224] 'agreement among raft nodes before linearized reading' (duration: 269.255817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:57.319013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.577349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-26T14:36:57.31903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.210793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-26T14:36:57.319057Z","caller":"traceutil/trace.go:171","msg":"trace[1296579328] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"152.879013ms","start":"2026-07-26T14:36:57.166155Z","end":"2026-07-26T14:36:57.319035Z","steps":["trace[1296579328] 'process raft request' (duration: 152.515859ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:57.319096Z","caller":"traceutil/trace.go:171","msg":"trace[31531274] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1442; }","duration":"360.695931ms","start":"2026-07-26T14:36:56.958387Z","end":"2026-07-26T14:36:57.319083Z","steps":["trace[31531274] 'agreement among raft nodes before linearized reading' (duration: 360.58561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:57.319123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.958366Z","time spent":"360.750911ms","remote":"127.0.0.1:46166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-07-26T14:36:57.319122Z","caller":"traceutil/trace.go:171","msg":"trace[137682964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1442; }","duration":"638.318924ms","start":"2026-07-26T14:36:56.680781Z","end":"2026-07-26T14:36:57.3191Z","steps":["trace[137682964] 'agreement among raft nodes before linearized reading' (duration: 638.071731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:57.319183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.680741Z","time spent":"638.418666ms","remote":"127.0.0.1:46304","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-07-26T14:36:57.319411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.606104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:36:57.319486Z","caller":"traceutil/trace.go:171","msg":"trace[1986191128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1443; }","duration":"564.708315ms","start":"2026-07-26T14:36:56.754765Z","end":"2026-07-26T14:36:57.319473Z","steps":["trace[1986191128] 'agreement among raft nodes before linearized reading' (duration: 564.610754ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:57.319521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:56.754752Z","time spent":"564.761805ms","remote":"127.0.0.1:46048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-26T14:36:58.852456Z","caller":"traceutil/trace.go:171","msg":"trace[744527583] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"114.034143ms","start":"2026-07-26T14:36:58.738395Z","end":"2026-07-26T14:36:58.852429Z","steps":["trace[744527583] 'process raft request' (duration: 113.876372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:59.827786Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":820675061724163127,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-26T14:36:59.890125Z","caller":"traceutil/trace.go:171","msg":"trace[267981238] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"565.231355ms","start":"2026-07-26T14:36:59.324868Z","end":"2026-07-26T14:36:59.890099Z","steps":["trace[267981238] 'process raft request' (duration: 565.047213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:59.890301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:59.324854Z","time spent":"565.362186ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:36:59.898678Z","caller":"traceutil/trace.go:171","msg":"trace[1024468396] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"571.409868ms","start":"2026-07-26T14:36:59.327215Z","end":"2026-07-26T14:36:59.898625Z","steps":["trace[1024468396] 'process raft request' (duration: 571.180516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:59.89893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:59.32719Z","time spent":"571.603131ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:36:59.923683Z","caller":"traceutil/trace.go:171","msg":"trace[140647707] linearizableReadLoop","detail":"{readStateIndex:1497; appliedIndex:1494; }","duration":"596.241497ms","start":"2026-07-26T14:36:59.327417Z","end":"2026-07-26T14:36:59.923658Z","steps":["trace[140647707] 'read index received' (duration: 562.552832ms)","trace[140647707] 'applied index is now lower than readState.Index' (duration: 33.687605ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:36:59.923943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.801605ms","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-07-26T14:36:59.923954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.50598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-26T14:36:59.924044Z","caller":"traceutil/trace.go:171","msg":"trace[120065348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1456; }","duration":"596.632422ms","start":"2026-07-26T14:36:59.327387Z","end":"2026-07-26T14:36:59.924019Z","steps":["trace[120065348] 'agreement among raft nodes before linearized reading' (duration: 596.368318ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:36:59.923983Z","caller":"traceutil/trace.go:171","msg":"trace[517810299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1456; }","duration":"156.895766ms","start":"2026-07-26T14:36:59.767078Z","end":"2026-07-26T14:36:59.923974Z","steps":["trace[517810299] 'agreement among raft nodes before linearized reading' (duration: 156.711274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:36:59.924109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:36:59.327374Z","time spent":"596.722223ms","remote":"127.0.0.1:46304","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-07-26T14:37:00.135179Z","caller":"traceutil/trace.go:171","msg":"trace[1446631256] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"206.767514ms","start":"2026-07-26T14:36:59.928384Z","end":"2026-07-26T14:37:00.135152Z","steps":["trace[1446631256] 'process raft request' (duration: 206.615522ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:00.17271Z","caller":"traceutil/trace.go:171","msg":"trace[1494783619] linearizableReadLoop","detail":"{readStateIndex:1499; appliedIndex:1497; }","duration":"220.335196ms","start":"2026-07-26T14:36:59.952354Z","end":"2026-07-26T14:37:00.172689Z","steps":["trace[1494783619] 'read index received' (duration: 182.647864ms)","trace[1494783619] 'applied index is now lower than readState.Index' (duration: 37.686222ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:00.172771Z","caller":"traceutil/trace.go:171","msg":"trace[434834066] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"244.243753ms","start":"2026-07-26T14:36:59.928505Z","end":"2026-07-26T14:37:00.172748Z","steps":["trace[434834066] 'process raft request' (duration: 216.676452ms)","trace[434834066] 'compare' (duration: 27.43572ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:37:00.172915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.557469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-26T14:37:00.172909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.840817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:00.172953Z","caller":"traceutil/trace.go:171","msg":"trace[1579329684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1458; }","duration":"220.644819ms","start":"2026-07-26T14:36:59.952299Z","end":"2026-07-26T14:37:00.172943Z","steps":["trace[1579329684] 'agreement among raft nodes before linearized reading' (duration: 220.500408ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:00.172965Z","caller":"traceutil/trace.go:171","msg":"trace[1963267034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1458; }","duration":"123.950648ms","start":"2026-07-26T14:37:00.049001Z","end":"2026-07-26T14:37:00.172952Z","steps":["trace[1963267034] 'agreement among raft nodes before linearized reading' (duration: 123.850416ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:03.392141Z","caller":"traceutil/trace.go:171","msg":"trace[765167795] linearizableReadLoop","detail":"{readStateIndex:1507; appliedIndex:1506; }","duration":"430.019869ms","start":"2026-07-26T14:37:02.962103Z","end":"2026-07-26T14:37:03.392123Z","steps":["trace[765167795] 'read index received' (duration: 429.791106ms)","trace[765167795] 'applied index is now lower than readState.Index' (duration: 227.943µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:03.392202Z","caller":"traceutil/trace.go:171","msg":"trace[1285926747] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"525.181928ms","start":"2026-07-26T14:37:02.866989Z","end":"2026-07-26T14:37:03.392171Z","steps":["trace[1285926747] 'process raft request' (duration: 524.947295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:03.39235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.225872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-4d7cf\" ","response":"range_response_count:1 size:7308"} {"level":"info","ts":"2026-07-26T14:37:03.392383Z","caller":"traceutil/trace.go:171","msg":"trace[1386585288] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-4d7cf; range_end:; response_count:1; response_revision:1466; }","duration":"430.297282ms","start":"2026-07-26T14:37:02.962078Z","end":"2026-07-26T14:37:03.392375Z","steps":["trace[1386585288] 'agreement among raft nodes before linearized reading' (duration: 430.12239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:03.39239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:02.866981Z","time spent":"525.330669ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:37:03.39241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:02.962067Z","time spent":"430.336112ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":7331,"request content":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-4d7cf\" "} {"level":"info","ts":"2026-07-26T14:37:03.554462Z","caller":"traceutil/trace.go:171","msg":"trace[1477008306] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"154.544777ms","start":"2026-07-26T14:37:03.399898Z","end":"2026-07-26T14:37:03.554442Z","steps":["trace[1477008306] 'process raft request' (duration: 154.434506ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:06.292332Z","caller":"traceutil/trace.go:171","msg":"trace[2017964973] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1528; }","duration":"367.06585ms","start":"2026-07-26T14:37:05.925247Z","end":"2026-07-26T14:37:06.292313Z","steps":["trace[2017964973] 'read index received' (duration: 366.836077ms)","trace[2017964973] 'applied index is now lower than readState.Index' (duration: 228.773µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:06.292384Z","caller":"traceutil/trace.go:171","msg":"trace[110008611] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"384.406806ms","start":"2026-07-26T14:37:05.907935Z","end":"2026-07-26T14:37:06.292341Z","steps":["trace[110008611] 'process raft request' (duration: 384.230644ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:06.292534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.276702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-26T14:37:06.292539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:05.907911Z","time spent":"384.539698ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:37:06.292582Z","caller":"traceutil/trace.go:171","msg":"trace[1385596968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1487; }","duration":"367.373194ms","start":"2026-07-26T14:37:05.925199Z","end":"2026-07-26T14:37:06.292572Z","steps":["trace[1385596968] 'agreement among raft nodes before linearized reading' (duration: 367.225582ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:06.292615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:05.92518Z","time spent":"367.427285ms","remote":"127.0.0.1:46304","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-07-26T14:37:06.292616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.709688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:06.292691Z","caller":"traceutil/trace.go:171","msg":"trace[296360089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1487; }","duration":"242.83732ms","start":"2026-07-26T14:37:06.049839Z","end":"2026-07-26T14:37:06.292676Z","steps":["trace[296360089] 'agreement among raft nodes before linearized reading' (duration: 242.692739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:06.292813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.729401ms","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-07-26T14:37:06.292854Z","caller":"traceutil/trace.go:171","msg":"trace[1466515965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1487; }","duration":"133.810052ms","start":"2026-07-26T14:37:06.159031Z","end":"2026-07-26T14:37:06.292842Z","steps":["trace[1466515965] 'agreement among raft nodes before linearized reading' (duration: 133.704391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:06.292897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.841719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-mbt7z\" ","response":"range_response_count:1 size:4236"} {"level":"info","ts":"2026-07-26T14:37:06.292949Z","caller":"traceutil/trace.go:171","msg":"trace[424859217] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-startupapicheck-mbt7z; range_end:; response_count:1; response_revision:1487; }","duration":"231.92775ms","start":"2026-07-26T14:37:06.061008Z","end":"2026-07-26T14:37:06.292935Z","steps":["trace[424859217] 'agreement among raft nodes before linearized reading' (duration: 231.781539ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:06.525246Z","caller":"traceutil/trace.go:171","msg":"trace[1945364462] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"228.735242ms","start":"2026-07-26T14:37:06.296476Z","end":"2026-07-26T14:37:06.525211Z","steps":["trace[1945364462] 'process raft request' (duration: 148.343615ms)","trace[1945364462] 'compare' (duration: 80.122824ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:06.527142Z","caller":"traceutil/trace.go:171","msg":"trace[788543626] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"230.474582ms","start":"2026-07-26T14:37:06.29664Z","end":"2026-07-26T14:37:06.527115Z","steps":["trace[788543626] 'process raft request' (duration: 228.450939ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:06.527624Z","caller":"traceutil/trace.go:171","msg":"trace[1240192756] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"230.040398ms","start":"2026-07-26T14:37:06.297543Z","end":"2026-07-26T14:37:06.527584Z","steps":["trace[1240192756] 'process raft request' (duration: 229.638753ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:06.527713Z","caller":"traceutil/trace.go:171","msg":"trace[1074930538] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"230.755476ms","start":"2026-07-26T14:37:06.296891Z","end":"2026-07-26T14:37:06.527647Z","steps":["trace[1074930538] 'process raft request' (duration: 230.141158ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:09.015508Z","caller":"traceutil/trace.go:171","msg":"trace[2028265551] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"225.48998ms","start":"2026-07-26T14:37:08.789993Z","end":"2026-07-26T14:37:09.015483Z","steps":["trace[2028265551] 'process raft request' (duration: 225.281107ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:26.839711Z","caller":"traceutil/trace.go:171","msg":"trace[79611440] transaction","detail":"{read_only:false; response_revision:1696; number_of_response:1; }","duration":"159.374032ms","start":"2026-07-26T14:37:26.680312Z","end":"2026-07-26T14:37:26.839686Z","steps":["trace[79611440] 'process raft request' (duration: 159.277251ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:26.840024Z","caller":"traceutil/trace.go:171","msg":"trace[370976041] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"159.708825ms","start":"2026-07-26T14:37:26.680302Z","end":"2026-07-26T14:37:26.840011Z","steps":["trace[370976041] 'process raft request' (duration: 103.842538ms)","trace[370976041] 'compare' (duration: 55.317741ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:26.84017Z","caller":"traceutil/trace.go:171","msg":"trace[925014334] transaction","detail":"{read_only:false; response_revision:1697; number_of_response:1; }","duration":"159.497723ms","start":"2026-07-26T14:37:26.680647Z","end":"2026-07-26T14:37:26.840145Z","steps":["trace[925014334] 'process raft request' (duration: 158.999247ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:27.312954Z","caller":"traceutil/trace.go:171","msg":"trace[1433682683] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1697; }","duration":"232.807179ms","start":"2026-07-26T14:37:27.080119Z","end":"2026-07-26T14:37:27.312927Z","steps":["trace[1433682683] 'process raft request' (duration: 232.705857ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:27.855461Z","caller":"traceutil/trace.go:171","msg":"trace[640894960] transaction","detail":"{read_only:false; response_revision:1698; number_of_response:1; }","duration":"532.936358ms","start":"2026-07-26T14:37:27.322503Z","end":"2026-07-26T14:37:27.855439Z","steps":["trace[640894960] 'process raft request' (duration: 532.813567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:27.855603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.322476Z","time spent":"533.057089ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12722,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:37:28.082533Z","caller":"traceutil/trace.go:171","msg":"trace[33598820] transaction","detail":"{read_only:false; response_revision:1699; number_of_response:1; }","duration":"747.861712ms","start":"2026-07-26T14:37:27.334654Z","end":"2026-07-26T14:37:28.082516Z","steps":["trace[33598820] 'process raft request' (duration: 747.64853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.082669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.334636Z","time spent":"747.958733ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:37:28.082766Z","caller":"traceutil/trace.go:171","msg":"trace[1087672044] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"675.272714ms","start":"2026-07-26T14:37:27.407486Z","end":"2026-07-26T14:37:28.082759Z","steps":["trace[1087672044] 'process raft request' (duration: 674.94492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.082794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.407465Z","time spent":"675.315624ms","remote":"127.0.0.1:46124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":141069,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-26T14:37:28.082787Z","caller":"traceutil/trace.go:171","msg":"trace[1095728107] linearizableReadLoop","detail":"{readStateIndex:1766; appliedIndex:1763; }","duration":"604.777029ms","start":"2026-07-26T14:37:27.477985Z","end":"2026-07-26T14:37:28.082762Z","steps":["trace[1095728107] 'read index received' (duration: 377.42285ms)","trace[1095728107] 'applied index is now lower than readState.Index' (duration: 227.353239ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:28.082881Z","caller":"traceutil/trace.go:171","msg":"trace[634300890] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"480.416877ms","start":"2026-07-26T14:37:27.60245Z","end":"2026-07-26T14:37:28.082867Z","steps":["trace[634300890] 'process raft request' (duration: 480.221555ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.082978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.602431Z","time spent":"480.491048ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:37:28.082978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.969771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-26T14:37:28.083018Z","caller":"traceutil/trace.go:171","msg":"trace[399696834] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1701; }","duration":"605.074421ms","start":"2026-07-26T14:37:27.47793Z","end":"2026-07-26T14:37:28.083005Z","steps":["trace[399696834] 'agreement among raft nodes before linearized reading' (duration: 604.96033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.083058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.477901Z","time spent":"605.145402ms","remote":"127.0.0.1:46390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":65,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-07-26T14:37:28.083185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.359286ms","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-07-26T14:37:28.083206Z","caller":"traceutil/trace.go:171","msg":"trace[1569784597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1701; }","duration":"537.416006ms","start":"2026-07-26T14:37:27.545783Z","end":"2026-07-26T14:37:28.083199Z","steps":["trace[1569784597] 'agreement among raft nodes before linearized reading' (duration: 537.333135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.083226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.545762Z","time spent":"537.459017ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-26T14:37:28.083391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.492577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-fb45r\" ","response":"range_response_count:1 size:12737"} {"level":"info","ts":"2026-07-26T14:37:28.083404Z","caller":"traceutil/trace.go:171","msg":"trace[868478238] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-fb45r; range_end:; response_count:1; response_revision:1701; }","duration":"224.535229ms","start":"2026-07-26T14:37:27.858865Z","end":"2026-07-26T14:37:28.0834Z","steps":["trace[868478238] 'agreement among raft nodes before linearized reading' (duration: 224.489278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.083484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.484801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:28.083496Z","caller":"traceutil/trace.go:171","msg":"trace[506347265] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1701; }","duration":"414.539212ms","start":"2026-07-26T14:37:27.668953Z","end":"2026-07-26T14:37:28.083492Z","steps":["trace[506347265] 'agreement among raft nodes before linearized reading' (duration: 414.517671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:28.083508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:27.668927Z","time spent":"414.577432ms","remote":"127.0.0.1:46174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-07-26T14:37:34.99376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.882194ms","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-07-26T14:37:34.993837Z","caller":"traceutil/trace.go:171","msg":"trace[1805470685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1856; }","duration":"121.966335ms","start":"2026-07-26T14:37:34.871855Z","end":"2026-07-26T14:37:34.993822Z","steps":["trace[1805470685] 'range keys from in-memory index tree' (duration: 121.757483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:34.993838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.691401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-26T14:37:34.993921Z","caller":"traceutil/trace.go:171","msg":"trace[1757825338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1856; }","duration":"120.792242ms","start":"2026-07-26T14:37:34.873108Z","end":"2026-07-26T14:37:34.993901Z","steps":["trace[1757825338] 'range keys from in-memory index tree' (duration: 120.530989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:34.994338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.51465ms","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-07-26T14:37:34.994379Z","caller":"traceutil/trace.go:171","msg":"trace[1563733591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1856; }","duration":"121.622442ms","start":"2026-07-26T14:37:34.872748Z","end":"2026-07-26T14:37:34.994371Z","steps":["trace[1563733591] 'range keys from in-memory index tree' (duration: 121.41788ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:51.87471Z","caller":"traceutil/trace.go:171","msg":"trace[200862997] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"248.748562ms","start":"2026-07-26T14:37:51.625937Z","end":"2026-07-26T14:37:51.874686Z","steps":["trace[200862997] 'process raft request' (duration: 248.616581ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:52.394115Z","caller":"traceutil/trace.go:171","msg":"trace[1657182045] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"584.504299ms","start":"2026-07-26T14:37:51.80958Z","end":"2026-07-26T14:37:52.394084Z","steps":["trace[1657182045] 'process raft request' (duration: 543.304491ms)","trace[1657182045] 'compare' (duration: 41.077717ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:37:52.394261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:51.809564Z","time spent":"584.62434ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:37:52.396756Z","caller":"traceutil/trace.go:171","msg":"trace[1400495072] linearizableReadLoop","detail":"{readStateIndex:2020; appliedIndex:2018; }","duration":"346.948299ms","start":"2026-07-26T14:37:52.049787Z","end":"2026-07-26T14:37:52.396735Z","steps":["trace[1400495072] 'read index received' (duration: 303.184103ms)","trace[1400495072] 'applied index is now lower than readState.Index' (duration: 43.763016ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:52.396832Z","caller":"traceutil/trace.go:171","msg":"trace[1482835507] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"492.459879ms","start":"2026-07-26T14:37:51.90433Z","end":"2026-07-26T14:37:52.39679Z","steps":["trace[1482835507] 'process raft request' (duration: 492.271297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:52.396889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.0778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:52.396884Z","caller":"traceutil/trace.go:171","msg":"trace[1275693376] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"230.387242ms","start":"2026-07-26T14:37:52.166469Z","end":"2026-07-26T14:37:52.396856Z","steps":["trace[1275693376] 'process raft request' (duration: 230.22741ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:52.396923Z","caller":"traceutil/trace.go:171","msg":"trace[40920961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1946; }","duration":"347.158671ms","start":"2026-07-26T14:37:52.049755Z","end":"2026-07-26T14:37:52.396914Z","steps":["trace[40920961] 'agreement among raft nodes before linearized reading' (duration: 347.08212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:52.396954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:52.049736Z","time spent":"347.210781ms","remote":"127.0.0.1:46048","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-07-26T14:37:52.397037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:51.904304Z","time spent":"492.618831ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:37:52.397132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.054749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-26T14:37:52.397195Z","caller":"traceutil/trace.go:171","msg":"trace[2025961431] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1946; }","duration":"195.15696ms","start":"2026-07-26T14:37:52.202021Z","end":"2026-07-26T14:37:52.397178Z","steps":["trace[2025961431] 'agreement among raft nodes before linearized reading' (duration: 194.943467ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:52.800398Z","caller":"traceutil/trace.go:171","msg":"trace[545629475] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2022; }","duration":"150.154781ms","start":"2026-07-26T14:37:52.650223Z","end":"2026-07-26T14:37:52.800378Z","steps":["trace[545629475] 'read index received' (duration: 149.964029ms)","trace[545629475] 'applied index is now lower than readState.Index' (duration: 189.982µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:52.800495Z","caller":"traceutil/trace.go:171","msg":"trace[1775037326] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"289.99289ms","start":"2026-07-26T14:37:52.510481Z","end":"2026-07-26T14:37:52.800474Z","steps":["trace[1775037326] 'process raft request' (duration: 289.774227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:52.800517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.273072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:52.800552Z","caller":"traceutil/trace.go:171","msg":"trace[282658411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1948; }","duration":"150.367393ms","start":"2026-07-26T14:37:52.650173Z","end":"2026-07-26T14:37:52.800541Z","steps":["trace[282658411] 'agreement among raft nodes before linearized reading' (duration: 150.287722ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:54.212555Z","caller":"traceutil/trace.go:171","msg":"trace[447974207] linearizableReadLoop","detail":"{readStateIndex:2028; appliedIndex:2027; }","duration":"163.659098ms","start":"2026-07-26T14:37:54.048871Z","end":"2026-07-26T14:37:54.21253Z","steps":["trace[447974207] 'read index received' (duration: 163.547187ms)","trace[447974207] 'applied index is now lower than readState.Index' (duration: 110.471µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:54.212599Z","caller":"traceutil/trace.go:171","msg":"trace[717381609] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"333.23302ms","start":"2026-07-26T14:37:53.87933Z","end":"2026-07-26T14:37:54.212563Z","steps":["trace[717381609] 'process raft request' (duration: 333.039008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:54.212692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.796979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:37:54.212734Z","caller":"traceutil/trace.go:171","msg":"trace[1455847202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1953; }","duration":"163.89572ms","start":"2026-07-26T14:37:54.048825Z","end":"2026-07-26T14:37:54.21272Z","steps":["trace[1455847202] 'agreement among raft nodes before linearized reading' (duration: 163.800439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:54.21277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:37:53.879312Z","time spent":"333.373311ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:37:54.623366Z","caller":"traceutil/trace.go:171","msg":"trace[328327062] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"221.044981ms","start":"2026-07-26T14:37:54.40228Z","end":"2026-07-26T14:37:54.623325Z","steps":["trace[328327062] 'process raft request' (duration: 220.904669ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:54.641849Z","caller":"traceutil/trace.go:171","msg":"trace[903827194] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"239.245969ms","start":"2026-07-26T14:37:54.402587Z","end":"2026-07-26T14:37:54.641833Z","steps":["trace[903827194] 'process raft request' (duration: 239.120057ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:54.642185Z","caller":"traceutil/trace.go:171","msg":"trace[444306119] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"218.350802ms","start":"2026-07-26T14:37:54.423794Z","end":"2026-07-26T14:37:54.642145Z","steps":["trace[444306119] 'process raft request' (duration: 218.001708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:54.642512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.210091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-26T14:37:54.642567Z","caller":"traceutil/trace.go:171","msg":"trace[1817699851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1956; }","duration":"184.319091ms","start":"2026-07-26T14:37:54.458236Z","end":"2026-07-26T14:37:54.642555Z","steps":["trace[1817699851] 'agreement among raft nodes before linearized reading' (duration: 184.011168ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:54.642067Z","caller":"traceutil/trace.go:171","msg":"trace[1975029650] linearizableReadLoop","detail":"{readStateIndex:2032; appliedIndex:2030; }","duration":"183.748556ms","start":"2026-07-26T14:37:54.458289Z","end":"2026-07-26T14:37:54.642037Z","steps":["trace[1975029650] 'read index received' (duration: 165.036493ms)","trace[1975029650] 'applied index is now lower than readState.Index' (duration: 18.710653ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:55.258878Z","caller":"traceutil/trace.go:171","msg":"trace[1178936423] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2035; }","duration":"100.32462ms","start":"2026-07-26T14:37:55.15853Z","end":"2026-07-26T14:37:55.258854Z","steps":["trace[1178936423] 'read index received' (duration: 100.193378ms)","trace[1178936423] 'applied index is now lower than readState.Index' (duration: 130.152µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:37:55.259001Z","caller":"traceutil/trace.go:171","msg":"trace[1626422721] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"118.430716ms","start":"2026-07-26T14:37:55.140534Z","end":"2026-07-26T14:37:55.258965Z","steps":["trace[1626422721] 'process raft request' (duration: 118.149983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:37:55.259101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.551592ms","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-07-26T14:37:55.259137Z","caller":"traceutil/trace.go:171","msg":"trace[68461785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1960; }","duration":"100.625123ms","start":"2026-07-26T14:37:55.158502Z","end":"2026-07-26T14:37:55.259127Z","steps":["trace[68461785] 'agreement among raft nodes before linearized reading' (duration: 100.489412ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:37:56.445066Z","caller":"traceutil/trace.go:171","msg":"trace[548174007] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"226.535681ms","start":"2026-07-26T14:37:56.218504Z","end":"2026-07-26T14:37:56.445039Z","steps":["trace[548174007] 'process raft request' (duration: 226.373479ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:20.794441Z","caller":"traceutil/trace.go:171","msg":"trace[682112968] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"114.55868ms","start":"2026-07-26T14:39:20.67986Z","end":"2026-07-26T14:39:20.794419Z","steps":["trace[682112968] 'process raft request' (duration: 114.402486ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:20.987327Z","caller":"traceutil/trace.go:171","msg":"trace[1114882762] transaction","detail":"{read_only:false; response_revision:2400; number_of_response:1; }","duration":"245.217359ms","start":"2026-07-26T14:39:20.742082Z","end":"2026-07-26T14:39:20.987299Z","steps":["trace[1114882762] 'process raft request' (duration: 220.099812ms)","trace[1114882762] 'compare' (duration: 24.938632ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:39:20.987438Z","caller":"traceutil/trace.go:171","msg":"trace[225658474] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"233.084181ms","start":"2026-07-26T14:39:20.754319Z","end":"2026-07-26T14:39:20.987403Z","steps":["trace[225658474] 'process raft request' (duration: 232.939267ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:21.236995Z","caller":"traceutil/trace.go:171","msg":"trace[1314660863] transaction","detail":"{read_only:false; response_revision:2402; number_of_response:1; }","duration":"193.328635ms","start":"2026-07-26T14:39:21.043639Z","end":"2026-07-26T14:39:21.236968Z","steps":["trace[1314660863] 'process raft request' (duration: 133.229173ms)","trace[1314660863] 'compare' (duration: 59.792684ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:39:21.237119Z","caller":"traceutil/trace.go:171","msg":"trace[932844404] transaction","detail":"{read_only:false; response_revision:2403; number_of_response:1; }","duration":"175.875593ms","start":"2026-07-26T14:39:21.061216Z","end":"2026-07-26T14:39:21.237091Z","steps":["trace[932844404] 'process raft request' (duration: 175.675338ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:21.585755Z","caller":"traceutil/trace.go:171","msg":"trace[1014155190] linearizableReadLoop","detail":"{readStateIndex:2497; appliedIndex:2496; }","duration":"385.362177ms","start":"2026-07-26T14:39:21.200351Z","end":"2026-07-26T14:39:21.585713Z","steps":["trace[1014155190] 'read index received' (duration: 356.790783ms)","trace[1014155190] 'applied index is now lower than readState.Index' (duration: 28.570184ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:39:21.585808Z","caller":"traceutil/trace.go:171","msg":"trace[333235728] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"391.83838ms","start":"2026-07-26T14:39:21.193932Z","end":"2026-07-26T14:39:21.58577Z","steps":["trace[333235728] 'process raft request' (duration: 363.38013ms)","trace[333235728] 'compare' (duration: 27.938207ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:39:21.585953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:39:21.193899Z","time spent":"391.978604ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:39:21.586091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.710685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-07-26T14:39:21.586125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.400889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-26T14:39:21.586164Z","caller":"traceutil/trace.go:171","msg":"trace[1773579104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2404; }","duration":"385.843729ms","start":"2026-07-26T14:39:21.200306Z","end":"2026-07-26T14:39:21.586149Z","steps":["trace[1773579104] 'agreement among raft nodes before linearized reading' (duration: 385.604083ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:21.586184Z","caller":"traceutil/trace.go:171","msg":"trace[97839412] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2404; }","duration":"263.498271ms","start":"2026-07-26T14:39:21.322668Z","end":"2026-07-26T14:39:21.586167Z","steps":["trace[97839412] 'agreement among raft nodes before linearized reading' (duration: 263.305296ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:39:21.58622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:39:21.200256Z","time spent":"385.953141ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-26T14:39:21.794126Z","caller":"traceutil/trace.go:171","msg":"trace[1170637882] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"203.493262ms","start":"2026-07-26T14:39:21.590606Z","end":"2026-07-26T14:39:21.794099Z","steps":["trace[1170637882] 'process raft request' (duration: 201.589623ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:21.794302Z","caller":"traceutil/trace.go:171","msg":"trace[1790667942] transaction","detail":"{read_only:false; response_revision:2406; number_of_response:1; }","duration":"201.699836ms","start":"2026-07-26T14:39:21.592577Z","end":"2026-07-26T14:39:21.794276Z","steps":["trace[1790667942] 'process raft request' (duration: 201.481271ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:35.765353Z","caller":"traceutil/trace.go:171","msg":"trace[1209727803] transaction","detail":"{read_only:false; response_revision:2474; number_of_response:1; }","duration":"129.945474ms","start":"2026-07-26T14:39:35.635377Z","end":"2026-07-26T14:39:35.765323Z","steps":["trace[1209727803] 'process raft request' (duration: 129.79446ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:37.222399Z","caller":"traceutil/trace.go:171","msg":"trace[707793634] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"170.41901ms","start":"2026-07-26T14:39:37.05196Z","end":"2026-07-26T14:39:37.222379Z","steps":["trace[707793634] 'process raft request' (duration: 170.279157ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:39:37.417067Z","caller":"traceutil/trace.go:171","msg":"trace[672549257] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"110.453415ms","start":"2026-07-26T14:39:37.306585Z","end":"2026-07-26T14:39:37.417039Z","steps":["trace[672549257] 'process raft request' (duration: 110.315301ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:42:50.762714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.763069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:42:50.762816Z","caller":"traceutil/trace.go:171","msg":"trace[168376247] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:3456; }","duration":"339.918973ms","start":"2026-07-26T14:42:50.422876Z","end":"2026-07-26T14:42:50.762795Z","steps":["trace[168376247] 'count revisions from in-memory index tree' (duration: 339.683877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:42:50.762862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:42:50.422858Z","time spent":"339.991925ms","remote":"127.0.0.1:37284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-07-26T14:42:50.764995Z","caller":"traceutil/trace.go:171","msg":"trace[1462762833] transaction","detail":"{read_only:false; response_revision:3457; number_of_response:1; }","duration":"312.843513ms","start":"2026-07-26T14:42:50.452115Z","end":"2026-07-26T14:42:50.764959Z","steps":["trace[1462762833] 'process raft request' (duration: 312.665939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:42:50.765202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:42:50.45209Z","time spent":"313.006728ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T14:44:18.713098Z","caller":"traceutil/trace.go:171","msg":"trace[433317393] transaction","detail":"{read_only:false; response_revision:4165; number_of_response:1; }","duration":"113.696188ms","start":"2026-07-26T14:44:18.599369Z","end":"2026-07-26T14:44:18.713065Z","steps":["trace[433317393] 'process raft request' (duration: 113.493463ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:44:50.550275Z","caller":"traceutil/trace.go:171","msg":"trace[1849183948] transaction","detail":"{read_only:false; response_revision:4349; number_of_response:1; }","duration":"103.655196ms","start":"2026-07-26T14:44:50.446585Z","end":"2026-07-26T14:44:50.55024Z","steps":["trace[1849183948] 'process raft request' (duration: 103.487631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:44:56.91343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.512082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:44:56.913572Z","caller":"traceutil/trace.go:171","msg":"trace[947746466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4381; }","duration":"157.715097ms","start":"2026-07-26T14:44:56.755826Z","end":"2026-07-26T14:44:56.913541Z","steps":["trace[947746466] 'range keys from in-memory index tree' (duration: 157.350859ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:44:57.605331Z","caller":"traceutil/trace.go:171","msg":"trace[1511415306] linearizableReadLoop","detail":"{readStateIndex:4555; appliedIndex:4554; }","duration":"304.582595ms","start":"2026-07-26T14:44:57.300717Z","end":"2026-07-26T14:44:57.605299Z","steps":["trace[1511415306] 'read index received' (duration: 304.37197ms)","trace[1511415306] 'applied index is now lower than readState.Index' (duration: 209.435µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:44:57.605389Z","caller":"traceutil/trace.go:171","msg":"trace[680843480] transaction","detail":"{read_only:false; response_revision:4382; number_of_response:1; }","duration":"325.794432ms","start":"2026-07-26T14:44:57.279555Z","end":"2026-07-26T14:44:57.605349Z","steps":["trace[680843480] 'process raft request' (duration: 325.553386ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:44:57.605559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:44:57.279527Z","time spent":"325.938796ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T14:44:57.605592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.860331ms","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-07-26T14:44:57.605698Z","caller":"traceutil/trace.go:171","msg":"trace[1119738317] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4382; }","duration":"305.008725ms","start":"2026-07-26T14:44:57.300664Z","end":"2026-07-26T14:44:57.605673Z","steps":["trace[1119738317] 'agreement among raft nodes before linearized reading' (duration: 304.750389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:44:57.605741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T14:44:57.30065Z","time spent":"305.082067ms","remote":"127.0.0.1:39334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-26T14:45:21.205853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2704} {"level":"info","ts":"2026-07-26T14:45:21.272144Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2704,"took":"64.989709ms","hash":4083577315,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":9732096,"current-db-size-in-use":"9.7 MB"} {"level":"info","ts":"2026-07-26T14:45:21.272245Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4083577315,"revision":2704,"compact-revision":-1} {"level":"warn","ts":"2026-07-26T14:45:44.70645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.87598ms","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-07-26T14:45:44.70652Z","caller":"traceutil/trace.go:171","msg":"trace[775059317] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:4748; }","duration":"267.982904ms","start":"2026-07-26T14:45:44.438521Z","end":"2026-07-26T14:45:44.706504Z","steps":["trace[775059317] 'range keys from in-memory index tree' (duration: 267.718617ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:45:44.706827Z","caller":"traceutil/trace.go:171","msg":"trace[1521756223] linearizableReadLoop","detail":"{readStateIndex:4934; appliedIndex:4933; }","duration":"109.914007ms","start":"2026-07-26T14:45:44.596907Z","end":"2026-07-26T14:45:44.706821Z","steps":["trace[1521756223] 'read index received' (duration: 109.147328ms)","trace[1521756223] 'applied index is now lower than readState.Index' (duration: 766.159µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T14:45:44.706985Z","caller":"traceutil/trace.go:171","msg":"trace[2101412324] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"120.596973ms","start":"2026-07-26T14:45:44.586381Z","end":"2026-07-26T14:45:44.706978Z","steps":["trace[2101412324] 'process raft request' (duration: 119.736952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T14:45:44.707085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.178404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T14:45:44.707103Z","caller":"traceutil/trace.go:171","msg":"trace[1696871687] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4749; }","duration":"110.235435ms","start":"2026-07-26T14:45:44.596861Z","end":"2026-07-26T14:45:44.707097Z","steps":["trace[1696871687] 'agreement among raft nodes before linearized reading' (duration: 110.199424ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:50:21.213404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4522} {"level":"info","ts":"2026-07-26T14:50:21.253565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4522,"took":"39.008029ms","hash":2110278141,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":12881920,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-26T14:50:21.253627Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2110278141,"revision":4522,"compact-revision":2704} {"level":"info","ts":"2026-07-26T14:55:02.31416Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5a9e84e0e0a90b63","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T14:55:02.319097Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-26T14:55:02.319188Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-07-26T14:55:09.958775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.097735ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-26T14:55:09.958889Z","caller":"traceutil/trace.go:171","msg":"trace[1239768537] linearizableReadLoop","detail":"{readStateIndex:10058; appliedIndex:10057; }","duration":"180.756132ms","start":"2026-07-26T14:55:09.778115Z","end":"2026-07-26T14:55:09.958871Z","steps":["trace[1239768537] 'read index received' (duration: 44.391µs)","trace[1239768537] 'applied index is now lower than readState.Index' (duration: 180.710171ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T14:55:09.959056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.933156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-spsvd\" ","response":"range_response_count:1 size:20565"} {"level":"info","ts":"2026-07-26T14:55:09.95912Z","caller":"traceutil/trace.go:171","msg":"trace[1184663913] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-spsvd; range_end:; response_count:1; response_revision:9729; }","duration":"181.039758ms","start":"2026-07-26T14:55:09.778065Z","end":"2026-07-26T14:55:09.959105Z","steps":["trace[1184663913] 'agreement among raft nodes before linearized reading' (duration: 180.867734ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T14:55:21.219076Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6497} {"level":"info","ts":"2026-07-26T14:55:21.262245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6497,"took":"41.557284ms","hash":504184518,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":23400448,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-26T14:55:21.262315Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":504184518,"revision":6497,"compact-revision":4522} {"level":"info","ts":"2026-07-26T15:00:21.22783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9867} {"level":"info","ts":"2026-07-26T15:00:21.304835Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9867,"took":"74.727311ms","hash":3599688608,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":21151744,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-07-26T15:00:21.304908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3599688608,"revision":9867,"compact-revision":6497} {"level":"info","ts":"2026-07-26T15:01:13.744271Z","caller":"traceutil/trace.go:171","msg":"trace[978905501] transaction","detail":"{read_only:false; response_revision:12555; number_of_response:1; }","duration":"201.323796ms","start":"2026-07-26T15:01:13.54287Z","end":"2026-07-26T15:01:13.744194Z","steps":["trace[978905501] 'process raft request' (duration: 201.130561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:01:14.634823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.490153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.222\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-07-26T15:01:14.634909Z","caller":"traceutil/trace.go:171","msg":"trace[1416800842] range","detail":"{range_begin:/registry/masterleases/162.253.55.222; range_end:; response_count:1; response_revision:12558; }","duration":"259.603776ms","start":"2026-07-26T15:01:14.375282Z","end":"2026-07-26T15:01:14.634886Z","steps":["trace[1416800842] 'range keys from in-memory index tree' (duration: 259.296159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:01:14.635157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.039247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-969pf\" ","response":"range_response_count:1 size:9712"} {"level":"info","ts":"2026-07-26T15:01:14.635267Z","caller":"traceutil/trace.go:171","msg":"trace[2059413864] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-969pf; range_end:; response_count:1; response_revision:12558; }","duration":"118.19408ms","start":"2026-07-26T15:01:14.517038Z","end":"2026-07-26T15:01:14.635232Z","steps":["trace[2059413864] 'range keys from in-memory index tree' (duration: 117.855972ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:01:14.952693Z","caller":"traceutil/trace.go:171","msg":"trace[1458242727] transaction","detail":"{read_only:false; response_revision:12559; number_of_response:1; }","duration":"315.851317ms","start":"2026-07-26T15:01:14.636814Z","end":"2026-07-26T15:01:14.952666Z","steps":["trace[1458242727] 'process raft request' (duration: 315.636762ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:01:14.95294Z","caller":"traceutil/trace.go:171","msg":"trace[567772735] transaction","detail":"{read_only:false; response_revision:12560; number_of_response:1; }","duration":"243.592986ms","start":"2026-07-26T15:01:14.709319Z","end":"2026-07-26T15:01:14.952912Z","steps":["trace[567772735] 'process raft request' (duration: 243.299719ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:01:14.952939Z","caller":"traceutil/trace.go:171","msg":"trace[134991058] linearizableReadLoop","detail":"{readStateIndex:12983; appliedIndex:12981; }","duration":"313.641263ms","start":"2026-07-26T15:01:14.639252Z","end":"2026-07-26T15:01:14.952893Z","steps":["trace[134991058] 'read index received' (duration: 154.413043ms)","trace[134991058] 'applied index is now lower than readState.Index' (duration: 159.22461ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:01:14.952949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:01:14.636793Z","time spent":"315.99417ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:01:14.953822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.556085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:80 size:798289"} {"level":"info","ts":"2026-07-26T15:01:14.953854Z","caller":"traceutil/trace.go:171","msg":"trace[955543988] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:80; response_revision:12560; }","duration":"314.602206ms","start":"2026-07-26T15:01:14.639245Z","end":"2026-07-26T15:01:14.953847Z","steps":["trace[955543988] 'agreement among raft nodes before linearized reading' (duration: 313.746646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:01:14.953876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:01:14.639207Z","time spent":"314.662948ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":80,"response size":798312,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-07-26T15:01:14.960462Z","caller":"traceutil/trace.go:171","msg":"trace[1130911290] transaction","detail":"{read_only:false; response_revision:12561; number_of_response:1; }","duration":"165.79736ms","start":"2026-07-26T15:01:14.794638Z","end":"2026-07-26T15:01:14.960436Z","steps":["trace[1130911290] 'process raft request' (duration: 165.607155ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:01:14.960516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.487795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-26T15:01:14.960578Z","caller":"traceutil/trace.go:171","msg":"trace[26968285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12561; }","duration":"113.589178ms","start":"2026-07-26T15:01:14.846974Z","end":"2026-07-26T15:01:14.960563Z","steps":["trace[26968285] 'agreement among raft nodes before linearized reading' (duration: 113.396213ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:05:21.234429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12167} {"level":"info","ts":"2026-07-26T15:05:21.311182Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12167,"took":"74.62903ms","hash":83555312,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":18038784,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-26T15:05:21.311238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":83555312,"revision":12167,"compact-revision":9867} {"level":"warn","ts":"2026-07-26T15:09:29.844753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":820675061724200229,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-26T15:09:30.345261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":820675061724200229,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-26T15:09:30.717657Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.723483297s","expected-duration":"1s"} {"level":"info","ts":"2026-07-26T15:09:30.718202Z","caller":"traceutil/trace.go:171","msg":"trace[1052511268] transaction","detail":"{read_only:false; response_revision:15313; number_of_response:1; }","duration":"1.724142083s","start":"2026-07-26T15:09:28.99403Z","end":"2026-07-26T15:09:30.718172Z","steps":["trace[1052511268] 'process raft request' (duration: 1.723956348s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.718388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:28.994004Z","time spent":"1.724292476s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T15:09:30.72414Z","caller":"traceutil/trace.go:171","msg":"trace[337104312] transaction","detail":"{read_only:false; response_revision:15314; number_of_response:1; }","duration":"1.405814186s","start":"2026-07-26T15:09:29.31828Z","end":"2026-07-26T15:09:30.724094Z","steps":["trace[337104312] 'process raft request' (duration: 1.405516459s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.724387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.318262Z","time spent":"1.40595148s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T15:09:30.727091Z","caller":"traceutil/trace.go:171","msg":"trace[1697098282] transaction","detail":"{read_only:false; response_revision:15315; number_of_response:1; }","duration":"816.312565ms","start":"2026-07-26T15:09:29.910756Z","end":"2026-07-26T15:09:30.727069Z","steps":["trace[1697098282] 'process raft request' (duration: 816.074909ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:09:30.727133Z","caller":"traceutil/trace.go:171","msg":"trace[364339280] transaction","detail":"{read_only:false; response_revision:15316; number_of_response:1; }","duration":"812.175114ms","start":"2026-07-26T15:09:29.91493Z","end":"2026-07-26T15:09:30.727105Z","steps":["trace[364339280] 'process raft request' (duration: 812.055271ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.727213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.91073Z","time spent":"816.424017ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:09:30.727342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.914914Z","time spent":"812.292466ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T15:09:30.727387Z","caller":"traceutil/trace.go:171","msg":"trace[903902329] linearizableReadLoop","detail":"{readStateIndex:15852; appliedIndex:15846; }","duration":"1.383598274s","start":"2026-07-26T15:09:29.343771Z","end":"2026-07-26T15:09:30.727369Z","steps":["trace[903902329] 'read index received' (duration: 1.374245186s)","trace[903902329] 'applied index is now lower than readState.Index' (duration: 9.351328ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:09:30.727442Z","caller":"traceutil/trace.go:171","msg":"trace[1180447185] transaction","detail":"{read_only:false; response_revision:15317; number_of_response:1; }","duration":"806.837014ms","start":"2026-07-26T15:09:29.920547Z","end":"2026-07-26T15:09:30.727384Z","steps":["trace[1180447185] 'process raft request' (duration: 806.507665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.727551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.920534Z","time spent":"806.963536ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:09:30.727569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38379825s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-26T15:09:30.728389Z","caller":"traceutil/trace.go:171","msg":"trace[843332525] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15318; }","duration":"1.384619659s","start":"2026-07-26T15:09:29.34373Z","end":"2026-07-26T15:09:30.72835Z","steps":["trace[843332525] 'agreement among raft nodes before linearized reading' (duration: 1.383715917s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.727826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383444651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-26T15:09:30.728466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.343713Z","time spent":"1.384738233s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-26T15:09:30.728514Z","caller":"traceutil/trace.go:171","msg":"trace[1640431553] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15318; }","duration":"1.384138098s","start":"2026-07-26T15:09:29.344358Z","end":"2026-07-26T15:09:30.728496Z","steps":["trace[1640431553] 'agreement among raft nodes before linearized reading' (duration: 1.383155624s)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:09:30.727425Z","caller":"traceutil/trace.go:171","msg":"trace[1515404073] transaction","detail":"{read_only:false; response_revision:15318; number_of_response:1; }","duration":"256.239132ms","start":"2026-07-26T15:09:30.471161Z","end":"2026-07-26T15:09:30.7274Z","steps":["trace[1515404073] 'process raft request' (duration: 256.126749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.728575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.344354Z","time spent":"1.384207259s","remote":"127.0.0.1:46304","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":"warn","ts":"2026-07-26T15:09:30.727871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379298439s","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-07-26T15:09:30.72868Z","caller":"traceutil/trace.go:171","msg":"trace[334926044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15318; }","duration":"1.38012926s","start":"2026-07-26T15:09:29.348535Z","end":"2026-07-26T15:09:30.728665Z","steps":["trace[334926044] 'agreement among raft nodes before linearized reading' (duration: 1.379054444s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.728719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.348526Z","time spent":"1.380183321s","remote":"127.0.0.1:46304","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-07-26T15:09:30.727876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343780013s","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-07-26T15:09:30.728765Z","caller":"traceutil/trace.go:171","msg":"trace[512535446] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15318; }","duration":"1.344680575s","start":"2026-07-26T15:09:29.384071Z","end":"2026-07-26T15:09:30.728752Z","steps":["trace[512535446] 'agreement among raft nodes before linearized reading' (duration: 1.343471575s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.728821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.384065Z","time spent":"1.344744797s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-26T15:09:30.727924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.343721112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-26T15:09:30.728915Z","caller":"traceutil/trace.go:171","msg":"trace[31834871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15318; }","duration":"1.344742127s","start":"2026-07-26T15:09:29.38416Z","end":"2026-07-26T15:09:30.728902Z","steps":["trace[31834871] 'agreement among raft nodes before linearized reading' (duration: 1.343358853s)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.728975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:29.384133Z","time spent":"1.344831469s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-26T15:09:30.728021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.093212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T15:09:30.729056Z","caller":"traceutil/trace.go:171","msg":"trace[555069340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15318; }","duration":"679.263841ms","start":"2026-07-26T15:09:30.049781Z","end":"2026-07-26T15:09:30.729044Z","steps":["trace[555069340] 'agreement among raft nodes before linearized reading' (duration: 677.799415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:09:30.729098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:09:30.049761Z","time spent":"679.327602ms","remote":"127.0.0.1:46048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-26T15:10:21.241145Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13994} {"level":"info","ts":"2026-07-26T15:10:21.311656Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13994,"took":"68.44049ms","hash":1669525631,"current-db-size-bytes":34422784,"current-db-size":"34 MB","current-db-size-in-use-bytes":15282176,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T15:10:21.31171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1669525631,"revision":13994,"compact-revision":12167}