{"level":"warn","ts":"2026-04-12T17:26:44.948897Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T17:26:44.948976Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.200: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.200:2380","--initial-cluster=instance=https://162.253.55.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.200: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-04-12T17:26:44.949037Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-12T17:26:44.949045Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-12T17:26:44.949062Z","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-04-12T17:26:44.94967Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"]} {"level":"info","ts":"2026-04-12T17:26:44.949736Z","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.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.200: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-04-12T17:26:44.95289Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.947234ms"} {"level":"info","ts":"2026-04-12T17:26:44.958594Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e10bb51ed7578852","cluster-id":"aa14459abd2161c3"} {"level":"info","ts":"2026-04-12T17:26:44.95867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=()"} {"level":"info","ts":"2026-04-12T17:26:44.95869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 0"} {"level":"info","ts":"2026-04-12T17:26:44.958701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e10bb51ed7578852 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-12T17:26:44.958711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became follower at term 1"} {"level":"info","ts":"2026-04-12T17:26:44.958741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"warn","ts":"2026-04-12T17:26:44.964613Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-12T17:26:44.968439Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-12T17:26:44.969695Z","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-04-12T17:26:44.972174Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e10bb51ed7578852","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-12T17:26:44.972377Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e10bb51ed7578852","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-12T17:26:44.972502Z","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-04-12T17:26:44.972624Z","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-04-12T17:26:44.972646Z","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-04-12T17:26:44.973131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 switched to configuration voters=(16216254027344087122)"} {"level":"info","ts":"2026-04-12T17:26:44.973265Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","added-peer-id":"e10bb51ed7578852","added-peer-peer-urls":["https://162.253.55.200:2380"]} {"level":"info","ts":"2026-04-12T17:26:44.975078Z","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-04-12T17:26:44.975317Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e10bb51ed7578852","initial-advertise-peer-urls":["https://162.253.55.200:2380"],"listen-peer-urls":["https://162.253.55.200:2380"],"advertise-client-urls":["https://162.253.55.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-12T17:26:44.975346Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-12T17:26:44.97545Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-12T17:26:44.975457Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.200:2380"} {"level":"info","ts":"2026-04-12T17:26:45.358908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 is starting a new election at term 1"} {"level":"info","ts":"2026-04-12T17:26:45.358963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-12T17:26:45.358984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgPreVoteResp from e10bb51ed7578852 at term 1"} {"level":"info","ts":"2026-04-12T17:26:45.359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became candidate at term 2"} {"level":"info","ts":"2026-04-12T17:26:45.359006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 received MsgVoteResp from e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-12T17:26:45.359019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e10bb51ed7578852 became leader at term 2"} {"level":"info","ts":"2026-04-12T17:26:45.359026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e10bb51ed7578852 elected leader e10bb51ed7578852 at term 2"} {"level":"info","ts":"2026-04-12T17:26:45.361229Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e10bb51ed7578852","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.200:2379]}","request-path":"/0/members/e10bb51ed7578852/attributes","cluster-id":"aa14459abd2161c3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-12T17:26:45.361285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T17:26:45.361274Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T17:26:45.361239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-12T17:26:45.361497Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-12T17:26:45.361573Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-12T17:26:45.363037Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa14459abd2161c3","local-member-id":"e10bb51ed7578852","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T17:26:45.363146Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T17:26:45.363181Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-12T17:26:45.363846Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.200:2379"} {"level":"info","ts":"2026-04-12T17:26:45.364902Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-12T17:26:48.261816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.128692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:26:48.262016Z","caller":"traceutil/trace.go:171","msg":"trace[365194821] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"179.955095ms","start":"2026-04-12T17:26:48.082027Z","end":"2026-04-12T17:26:48.261982Z","steps":["trace[365194821] 'process raft request' (duration: 54.165516ms)","trace[365194821] 'compare' (duration: 124.979739ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:27:01.449525Z","caller":"traceutil/trace.go:171","msg":"trace[1073113949] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"178.331224ms","start":"2026-04-12T17:27:01.271169Z","end":"2026-04-12T17:27:01.4495Z","steps":["trace[1073113949] 'process raft request' (duration: 178.17426ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:01.785781Z","caller":"traceutil/trace.go:171","msg":"trace[1053639502] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:426; }","duration":"505.828531ms","start":"2026-04-12T17:27:01.279914Z","end":"2026-04-12T17:27:01.785743Z","steps":["trace[1053639502] 'read index received' (duration: 169.426701ms)","trace[1053639502] 'applied index is now lower than readState.Index' (duration: 336.40056ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:27:01.785908Z","caller":"traceutil/trace.go:171","msg":"trace[1917433533] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"510.398476ms","start":"2026-04-12T17:27:01.275443Z","end":"2026-04-12T17:27:01.785841Z","steps":["trace[1917433533] 'process raft request' (duration: 510.113389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:01.786094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.1597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-12T17:27:01.78616Z","caller":"traceutil/trace.go:171","msg":"trace[1543905215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"506.297203ms","start":"2026-04-12T17:27:01.279847Z","end":"2026-04-12T17:27:01.786145Z","steps":["trace[1543905215] 'agreement among raft nodes before linearized reading' (duration: 506.098978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:01.78615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.532994ms","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-04-12T17:27:01.786201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:27:01.279821Z","time spent":"506.369796ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-12T17:27:01.786281Z","caller":"traceutil/trace.go:171","msg":"trace[1181739991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:413; }","duration":"185.732799ms","start":"2026-04-12T17:27:01.600519Z","end":"2026-04-12T17:27:01.786252Z","steps":["trace[1181739991] 'agreement among raft nodes before linearized reading' (duration: 185.467762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:01.78647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:27:01.275417Z","time spent":"510.624252ms","remote":"127.0.0.1:40982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:27:15.680384Z","caller":"traceutil/trace.go:171","msg":"trace[1723625271] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"122.198899ms","start":"2026-04-12T17:27:15.55815Z","end":"2026-04-12T17:27:15.680349Z","steps":["trace[1723625271] 'process raft request' (duration: 121.955793ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.680498Z","caller":"traceutil/trace.go:171","msg":"trace[1966606996] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"118.023775ms","start":"2026-04-12T17:27:15.562414Z","end":"2026-04-12T17:27:15.680438Z","steps":["trace[1966606996] 'process raft request' (duration: 117.850041ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.680524Z","caller":"traceutil/trace.go:171","msg":"trace[99255057] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"117.243495ms","start":"2026-04-12T17:27:15.563235Z","end":"2026-04-12T17:27:15.680479Z","steps":["trace[99255057] 'process raft request' (duration: 117.093851ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.680606Z","caller":"traceutil/trace.go:171","msg":"trace[713723403] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"106.203219ms","start":"2026-04-12T17:27:15.574346Z","end":"2026-04-12T17:27:15.680549Z","steps":["trace[713723403] 'process raft request' (duration: 106.052395ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.680783Z","caller":"traceutil/trace.go:171","msg":"trace[1041872764] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"105.573873ms","start":"2026-04-12T17:27:15.575184Z","end":"2026-04-12T17:27:15.680757Z","steps":["trace[1041872764] 'process raft request' (duration: 105.278726ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.685158Z","caller":"traceutil/trace.go:171","msg":"trace[410546545] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"103.165043ms","start":"2026-04-12T17:27:15.581975Z","end":"2026-04-12T17:27:15.68514Z","steps":["trace[410546545] 'process raft request' (duration: 102.898256ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:15.685373Z","caller":"traceutil/trace.go:171","msg":"trace[2021160297] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"105.088501ms","start":"2026-04-12T17:27:15.580262Z","end":"2026-04-12T17:27:15.685351Z","steps":["trace[2021160297] 'process raft request' (duration: 104.530307ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:21.749231Z","caller":"traceutil/trace.go:171","msg":"trace[797278402] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"134.886597ms","start":"2026-04-12T17:27:21.614319Z","end":"2026-04-12T17:27:21.749205Z","steps":["trace[797278402] 'read index received' (duration: 133.852241ms)","trace[797278402] 'applied index is now lower than readState.Index' (duration: 1.033176ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:27:21.749316Z","caller":"traceutil/trace.go:171","msg":"trace[2032995102] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"162.697583ms","start":"2026-04-12T17:27:21.586596Z","end":"2026-04-12T17:27:21.749293Z","steps":["trace[2032995102] 'process raft request' (duration: 161.969355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:21.74945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.110262ms","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-04-12T17:27:21.749505Z","caller":"traceutil/trace.go:171","msg":"trace[189344787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"135.216535ms","start":"2026-04-12T17:27:21.614273Z","end":"2026-04-12T17:27:21.74949Z","steps":["trace[189344787] 'agreement among raft nodes before linearized reading' (duration: 135.039171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:22.037424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.75615ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:27:22.037759Z","caller":"traceutil/trace.go:171","msg":"trace[315337118] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"284.220185ms","start":"2026-04-12T17:27:21.753483Z","end":"2026-04-12T17:27:22.037704Z","steps":["trace[315337118] 'process raft request' (duration: 106.035124ms)","trace[315337118] 'compare' (duration: 177.596366ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:27:22.037838Z","caller":"traceutil/trace.go:171","msg":"trace[136193688] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"232.753176ms","start":"2026-04-12T17:27:21.805057Z","end":"2026-04-12T17:27:22.03781Z","steps":["trace[136193688] 'process raft request' (duration: 232.49544ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:22.037822Z","caller":"traceutil/trace.go:171","msg":"trace[1104283886] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"170.470397ms","start":"2026-04-12T17:27:21.867293Z","end":"2026-04-12T17:27:22.037763Z","steps":["trace[1104283886] 'read index received' (duration: 136.837525ms)","trace[1104283886] 'applied index is now lower than readState.Index' (duration: 33.630762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:27:22.037946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.654332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:27:22.038041Z","caller":"traceutil/trace.go:171","msg":"trace[1263269722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"170.787536ms","start":"2026-04-12T17:27:21.867235Z","end":"2026-04-12T17:27:22.038023Z","steps":["trace[1263269722] 'agreement among raft nodes before linearized reading' (duration: 170.642732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:22.038309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.465195ms","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-04-12T17:27:22.038322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.094326ms","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-04-12T17:27:22.038352Z","caller":"traceutil/trace.go:171","msg":"trace[286122581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"108.561697ms","start":"2026-04-12T17:27:21.929778Z","end":"2026-04-12T17:27:22.03834Z","steps":["trace[286122581] 'agreement among raft nodes before linearized reading' (duration: 108.383983ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:22.038366Z","caller":"traceutil/trace.go:171","msg":"trace[778170213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"104.160018ms","start":"2026-04-12T17:27:21.934194Z","end":"2026-04-12T17:27:22.038354Z","steps":["trace[778170213] 'agreement among raft nodes before linearized reading' (duration: 103.980353ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:27:23.049636Z","caller":"traceutil/trace.go:171","msg":"trace[1828808268] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"162.790366ms","start":"2026-04-12T17:27:22.88676Z","end":"2026-04-12T17:27:23.049551Z","steps":["trace[1828808268] 'read index received' (duration: 156.282753ms)","trace[1828808268] 'applied index is now lower than readState.Index' (duration: 6.506512ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:27:23.049738Z","caller":"traceutil/trace.go:171","msg":"trace[2085512711] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"516.871468ms","start":"2026-04-12T17:27:22.532807Z","end":"2026-04-12T17:27:23.049678Z","steps":["trace[2085512711] 'process raft request' (duration: 511.790361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:23.049988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:27:22.532777Z","time spent":"517.079793ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:27:23.049997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.196005ms","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-04-12T17:27:23.050127Z","caller":"traceutil/trace.go:171","msg":"trace[381970775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"163.40308ms","start":"2026-04-12T17:27:22.8867Z","end":"2026-04-12T17:27:23.050103Z","steps":["trace[381970775] 'agreement among raft nodes before linearized reading' (duration: 163.040741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:37.927163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.554304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vzqtw\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-12T17:27:37.927338Z","caller":"traceutil/trace.go:171","msg":"trace[886719176] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vzqtw; range_end:; response_count:1; response_revision:780; }","duration":"303.807889ms","start":"2026-04-12T17:27:37.623499Z","end":"2026-04-12T17:27:37.927306Z","steps":["trace[886719176] 'range keys from in-memory index tree' (duration: 303.224445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:27:37.927412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:27:37.62348Z","time spent":"303.914102ms","remote":"127.0.0.1:40678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vzqtw\" "} {"level":"info","ts":"2026-04-12T17:28:26.353452Z","caller":"traceutil/trace.go:171","msg":"trace[1778354896] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"100.401595ms","start":"2026-04-12T17:28:26.253008Z","end":"2026-04-12T17:28:26.35341Z","steps":["trace[1778354896] 'process raft request' (duration: 100.260111ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:28:26.35353Z","caller":"traceutil/trace.go:171","msg":"trace[1423939297] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"100.505718ms","start":"2026-04-12T17:28:26.252988Z","end":"2026-04-12T17:28:26.353493Z","steps":["trace[1423939297] 'process raft request' (duration: 87.829883ms)","trace[1423939297] 'compare' (duration: 12.322386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:28:54.025985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.247019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:28:54.026128Z","caller":"traceutil/trace.go:171","msg":"trace[1242684434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1863; }","duration":"157.436583ms","start":"2026-04-12T17:28:53.868669Z","end":"2026-04-12T17:28:54.026106Z","steps":["trace[1242684434] 'range keys from in-memory index tree' (duration: 157.128716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:28:54.026118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.943089ms","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-04-12T17:28:54.02621Z","caller":"traceutil/trace.go:171","msg":"trace[1303093116] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"166.103803ms","start":"2026-04-12T17:28:53.860085Z","end":"2026-04-12T17:28:54.026189Z","steps":["trace[1303093116] 'range keys from in-memory index tree' (duration: 165.676792ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:38.865576Z","caller":"traceutil/trace.go:171","msg":"trace[248779137] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"126.835038ms","start":"2026-04-12T17:29:38.738715Z","end":"2026-04-12T17:29:38.86555Z","steps":["trace[248779137] 'process raft request' (duration: 126.681164ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:38.877938Z","caller":"traceutil/trace.go:171","msg":"trace[1450517696] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"126.333985ms","start":"2026-04-12T17:29:38.751577Z","end":"2026-04-12T17:29:38.877911Z","steps":["trace[1450517696] 'process raft request' (duration: 126.14398ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.052398Z","caller":"traceutil/trace.go:171","msg":"trace[1573119035] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"168.960536ms","start":"2026-04-12T17:29:44.883409Z","end":"2026-04-12T17:29:45.052369Z","steps":["trace[1573119035] 'process raft request' (duration: 168.840483ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.236895Z","caller":"traceutil/trace.go:171","msg":"trace[348107406] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"341.835098ms","start":"2026-04-12T17:29:44.895031Z","end":"2026-04-12T17:29:45.236866Z","steps":["trace[348107406] 'process raft request' (duration: 283.563208ms)","trace[348107406] 'compare' (duration: 58.096405ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:29:45.237086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:44.895009Z","time spent":"341.994301ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:29:45.237248Z","caller":"traceutil/trace.go:171","msg":"trace[2042862984] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"214.666181ms","start":"2026-04-12T17:29:45.02254Z","end":"2026-04-12T17:29:45.237206Z","steps":["trace[2042862984] 'process raft request' (duration: 214.283132ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.237308Z","caller":"traceutil/trace.go:171","msg":"trace[166303883] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"151.388832ms","start":"2026-04-12T17:29:45.085887Z","end":"2026-04-12T17:29:45.237276Z","steps":["trace[166303883] 'process raft request' (duration: 151.267399ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.237369Z","caller":"traceutil/trace.go:171","msg":"trace[1940053426] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"303.158961ms","start":"2026-04-12T17:29:44.934197Z","end":"2026-04-12T17:29:45.237356Z","steps":["trace[1940053426] 'read index received' (duration: 118.221519ms)","trace[1940053426] 'applied index is now lower than readState.Index' (duration: 184.935892ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:29:45.237532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.338877ms","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-04-12T17:29:45.237569Z","caller":"traceutil/trace.go:171","msg":"trace[1140554578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2191; }","duration":"303.404027ms","start":"2026-04-12T17:29:44.934157Z","end":"2026-04-12T17:29:45.237561Z","steps":["trace[1140554578] 'agreement among raft nodes before linearized reading' (duration: 303.269964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.237602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:44.934145Z","time spent":"303.451599ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-12T17:29:45.237572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.056431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:29:45.237655Z","caller":"traceutil/trace.go:171","msg":"trace[1531884292] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2191; }","duration":"160.196184ms","start":"2026-04-12T17:29:45.07744Z","end":"2026-04-12T17:29:45.237636Z","steps":["trace[1531884292] 'agreement among raft nodes before linearized reading' (duration: 160.054571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.237636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.923154ms","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-04-12T17:29:45.237742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.047743ms","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-04-12T17:29:45.237761Z","caller":"traceutil/trace.go:171","msg":"trace[1141657802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2191; }","duration":"293.066258ms","start":"2026-04-12T17:29:44.944677Z","end":"2026-04-12T17:29:45.237743Z","steps":["trace[1141657802] 'agreement among raft nodes before linearized reading' (duration: 292.811802ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.237808Z","caller":"traceutil/trace.go:171","msg":"trace[850460418] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"292.160026ms","start":"2026-04-12T17:29:44.945633Z","end":"2026-04-12T17:29:45.237793Z","steps":["trace[850460418] 'agreement among raft nodes before linearized reading' (duration: 291.936231ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:29:45.621975Z","caller":"traceutil/trace.go:171","msg":"trace[708419935] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"380.608075ms","start":"2026-04-12T17:29:45.241334Z","end":"2026-04-12T17:29:45.621942Z","steps":["trace[708419935] 'process raft request' (duration: 328.921105ms)","trace[708419935] 'compare' (duration: 51.348552ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:29:45.622151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:45.241318Z","time spent":"380.747339ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:29:45.622239Z","caller":"traceutil/trace.go:171","msg":"trace[1731672152] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"380.269687ms","start":"2026-04-12T17:29:45.241939Z","end":"2026-04-12T17:29:45.622208Z","steps":["trace[1731672152] 'process raft request' (duration: 379.912179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.622443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:45.241912Z","time spent":"380.42466ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:29:45.623406Z","caller":"traceutil/trace.go:171","msg":"trace[1128386113] linearizableReadLoop","detail":"{readStateIndex:2276; appliedIndex:2273; }","duration":"377.651223ms","start":"2026-04-12T17:29:45.245719Z","end":"2026-04-12T17:29:45.62337Z","steps":["trace[1128386113] 'read index received' (duration: 324.554019ms)","trace[1128386113] 'applied index is now lower than readState.Index' (duration: 53.095224ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:29:45.623564Z","caller":"traceutil/trace.go:171","msg":"trace[368986626] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"381.557558ms","start":"2026-04-12T17:29:45.241971Z","end":"2026-04-12T17:29:45.623529Z","steps":["trace[368986626] 'process raft request' (duration: 380.146144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.623806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.360241ms","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-04-12T17:29:45.623867Z","caller":"traceutil/trace.go:171","msg":"trace[1231448798] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2194; }","duration":"230.472974ms","start":"2026-04-12T17:29:45.393377Z","end":"2026-04-12T17:29:45.62385Z","steps":["trace[1231448798] 'agreement among raft nodes before linearized reading' (duration: 230.271479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.623856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.134025ms","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-04-12T17:29:45.623954Z","caller":"traceutil/trace.go:171","msg":"trace[1561371664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2194; }","duration":"378.276468ms","start":"2026-04-12T17:29:45.245638Z","end":"2026-04-12T17:29:45.623915Z","steps":["trace[1561371664] 'agreement among raft nodes before linearized reading' (duration: 378.031243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:29:45.624003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:45.245528Z","time spent":"378.467003ms","remote":"127.0.0.1:40786","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-04-12T17:29:45.624128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:29:45.241952Z","time spent":"381.761103ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:29:45.739314Z","caller":"traceutil/trace.go:171","msg":"trace[883899941] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"112.039639ms","start":"2026-04-12T17:29:45.627221Z","end":"2026-04-12T17:29:45.739261Z","steps":["trace[883899941] 'process raft request' (duration: 94.937545ms)","trace[883899941] 'compare' (duration: 16.986852ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:18.168459Z","caller":"traceutil/trace.go:171","msg":"trace[582849695] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"133.327925ms","start":"2026-04-12T17:30:18.035092Z","end":"2026-04-12T17:30:18.16842Z","steps":["trace[582849695] 'process raft request' (duration: 79.627606ms)","trace[582849695] 'compare' (duration: 53.542705ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:18.691094Z","caller":"traceutil/trace.go:171","msg":"trace[2106890734] transaction","detail":"{read_only:false; response_revision:2376; number_of_response:1; }","duration":"105.161603ms","start":"2026-04-12T17:30:18.585887Z","end":"2026-04-12T17:30:18.691048Z","steps":["trace[2106890734] 'process raft request' (duration: 36.939193ms)","trace[2106890734] 'compare' (duration: 68.038306ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:20.044545Z","caller":"traceutil/trace.go:171","msg":"trace[1002652981] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"114.782766ms","start":"2026-04-12T17:30:19.929725Z","end":"2026-04-12T17:30:20.044507Z","steps":["trace[1002652981] 'process raft request' (duration: 19.387088ms)","trace[1002652981] 'compare' (duration: 94.927686ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:21.989594Z","caller":"traceutil/trace.go:171","msg":"trace[1607228241] transaction","detail":"{read_only:false; response_revision:2392; number_of_response:1; }","duration":"116.477337ms","start":"2026-04-12T17:30:21.873089Z","end":"2026-04-12T17:30:21.989567Z","steps":["trace[1607228241] 'process raft request' (duration: 116.329283ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.040723Z","caller":"traceutil/trace.go:171","msg":"trace[2026205468] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"166.816404ms","start":"2026-04-12T17:30:21.873877Z","end":"2026-04-12T17:30:22.040693Z","steps":["trace[2026205468] 'process raft request' (duration: 166.618719ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.040954Z","caller":"traceutil/trace.go:171","msg":"trace[1225847901] transaction","detail":"{read_only:false; response_revision:2394; number_of_response:1; }","duration":"166.857276ms","start":"2026-04-12T17:30:21.874076Z","end":"2026-04-12T17:30:22.040933Z","steps":["trace[1225847901] 'process raft request' (duration: 166.565709ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.041576Z","caller":"traceutil/trace.go:171","msg":"trace[155383107] linearizableReadLoop","detail":"{readStateIndex:2487; appliedIndex:2481; }","duration":"125.870154ms","start":"2026-04-12T17:30:21.915692Z","end":"2026-04-12T17:30:22.041562Z","steps":["trace[155383107] 'read index received' (duration: 73.851296ms)","trace[155383107] 'applied index is now lower than readState.Index' (duration: 52.017848ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:22.041673Z","caller":"traceutil/trace.go:171","msg":"trace[1078346702] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"167.352337ms","start":"2026-04-12T17:30:21.87431Z","end":"2026-04-12T17:30:22.041663Z","steps":["trace[1078346702] 'process raft request' (duration: 167.143052ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.041918Z","caller":"traceutil/trace.go:171","msg":"trace[927868348] transaction","detail":"{read_only:false; response_revision:2397; number_of_response:1; }","duration":"159.313232ms","start":"2026-04-12T17:30:21.882595Z","end":"2026-04-12T17:30:22.041908Z","steps":["trace[927868348] 'process raft request' (duration: 158.915453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:22.042228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.516369ms","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-04-12T17:30:22.042278Z","caller":"traceutil/trace.go:171","msg":"trace[637774113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2397; }","duration":"126.612402ms","start":"2026-04-12T17:30:21.915655Z","end":"2026-04-12T17:30:22.042267Z","steps":["trace[637774113] 'agreement among raft nodes before linearized reading' (duration: 126.427698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:22.042609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.321295ms","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-04-12T17:30:22.042616Z","caller":"traceutil/trace.go:171","msg":"trace[599395477] transaction","detail":"{read_only:false; response_revision:2395; number_of_response:1; }","duration":"168.436194ms","start":"2026-04-12T17:30:21.874138Z","end":"2026-04-12T17:30:22.042574Z","steps":["trace[599395477] 'process raft request' (duration: 166.678231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:22.042784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.419485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-04-12T17:30:22.042834Z","caller":"traceutil/trace.go:171","msg":"trace[506268541] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2397; }","duration":"104.498267ms","start":"2026-04-12T17:30:21.938324Z","end":"2026-04-12T17:30:22.042822Z","steps":["trace[506268541] 'agreement among raft nodes before linearized reading' (duration: 104.374144ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.042665Z","caller":"traceutil/trace.go:171","msg":"trace[211480778] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2397; }","duration":"114.408257ms","start":"2026-04-12T17:30:21.928242Z","end":"2026-04-12T17:30:22.04265Z","steps":["trace[211480778] 'agreement among raft nodes before linearized reading' (duration: 114.262204ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:22.162531Z","caller":"traceutil/trace.go:171","msg":"trace[779219090] transaction","detail":"{read_only:false; response_revision:2400; number_of_response:1; }","duration":"103.087213ms","start":"2026-04-12T17:30:22.059413Z","end":"2026-04-12T17:30:22.1625Z","steps":["trace[779219090] 'process raft request' (duration: 37.582328ms)","trace[779219090] 'compare' (duration: 65.087445ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:26.923063Z","caller":"traceutil/trace.go:171","msg":"trace[1969439974] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"120.882744ms","start":"2026-04-12T17:30:26.802157Z","end":"2026-04-12T17:30:26.92304Z","steps":["trace[1969439974] 'process raft request' (duration: 40.696195ms)","trace[1969439974] 'compare' (duration: 79.774049ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:26.923524Z","caller":"traceutil/trace.go:171","msg":"trace[1357334347] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"104.801675ms","start":"2026-04-12T17:30:26.818715Z","end":"2026-04-12T17:30:26.923516Z","steps":["trace[1357334347] 'process raft request' (duration: 104.274522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:29.252738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.222373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:30:29.252841Z","caller":"traceutil/trace.go:171","msg":"trace[474450664] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2488; }","duration":"107.426928ms","start":"2026-04-12T17:30:29.145393Z","end":"2026-04-12T17:30:29.25282Z","steps":["trace[474450664] 'count revisions from in-memory index tree' (duration: 107.147071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:29.252923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.115029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-12T17:30:29.253059Z","caller":"traceutil/trace.go:171","msg":"trace[1932758811] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2488; }","duration":"116.258552ms","start":"2026-04-12T17:30:29.136781Z","end":"2026-04-12T17:30:29.25304Z","steps":["trace[1932758811] 'range keys from in-memory index tree' (duration: 115.500843ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:29.950421Z","caller":"traceutil/trace.go:171","msg":"trace[1993934276] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"108.72702ms","start":"2026-04-12T17:30:29.841639Z","end":"2026-04-12T17:30:29.950366Z","steps":["trace[1993934276] 'process raft request' (duration: 44.058266ms)","trace[1993934276] 'compare' (duration: 64.446478ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:29.950614Z","caller":"traceutil/trace.go:171","msg":"trace[1301004940] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"108.390422ms","start":"2026-04-12T17:30:29.842143Z","end":"2026-04-12T17:30:29.950534Z","steps":["trace[1301004940] 'process raft request' (duration: 108.266579ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:29.950614Z","caller":"traceutil/trace.go:171","msg":"trace[260197297] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"108.512304ms","start":"2026-04-12T17:30:29.842073Z","end":"2026-04-12T17:30:29.950586Z","steps":["trace[260197297] 'process raft request' (duration: 108.177166ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:30.12007Z","caller":"traceutil/trace.go:171","msg":"trace[100468621] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"101.096685ms","start":"2026-04-12T17:30:30.018948Z","end":"2026-04-12T17:30:30.120044Z","steps":["trace[100468621] 'process raft request' (duration: 49.433546ms)","trace[100468621] 'compare' (duration: 51.500115ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:30.260397Z","caller":"traceutil/trace.go:171","msg":"trace[1289561693] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"135.720113ms","start":"2026-04-12T17:30:30.124634Z","end":"2026-04-12T17:30:30.260354Z","steps":["trace[1289561693] 'process raft request' (duration: 103.155725ms)","trace[1289561693] 'compare' (duration: 32.298151ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:30.260463Z","caller":"traceutil/trace.go:171","msg":"trace[552664444] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"134.624916ms","start":"2026-04-12T17:30:30.125814Z","end":"2026-04-12T17:30:30.260439Z","steps":["trace[552664444] 'process raft request' (duration: 134.501313ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:30.260498Z","caller":"traceutil/trace.go:171","msg":"trace[932872804] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"135.056806ms","start":"2026-04-12T17:30:30.125386Z","end":"2026-04-12T17:30:30.260443Z","steps":["trace[932872804] 'process raft request' (duration: 134.855231ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:30.285836Z","caller":"traceutil/trace.go:171","msg":"trace[1993313713] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"109.854845ms","start":"2026-04-12T17:30:30.175962Z","end":"2026-04-12T17:30:30.285817Z","steps":["trace[1993313713] 'process raft request' (duration: 109.744573ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:30.285956Z","caller":"traceutil/trace.go:171","msg":"trace[269540506] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"110.208314ms","start":"2026-04-12T17:30:30.17573Z","end":"2026-04-12T17:30:30.285938Z","steps":["trace[269540506] 'process raft request' (duration: 109.862076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:32.338772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.224085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:30:32.338952Z","caller":"traceutil/trace.go:171","msg":"trace[1348398776] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"185.65154ms","start":"2026-04-12T17:30:32.153269Z","end":"2026-04-12T17:30:32.33892Z","steps":["trace[1348398776] 'process raft request' (duration: 80.170309ms)","trace[1348398776] 'compare' (duration: 105.075961ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:30:33.660407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.088148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:30:33.660523Z","caller":"traceutil/trace.go:171","msg":"trace[1595898121] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"158.897683ms","start":"2026-04-12T17:30:33.50161Z","end":"2026-04-12T17:30:33.660507Z","steps":["trace[1595898121] 'process raft request' (duration: 54.636792ms)","trace[1595898121] 'compare' (duration: 103.978354ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:33.723964Z","caller":"traceutil/trace.go:171","msg":"trace[391877849] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2561; }","duration":"220.053861ms","start":"2026-04-12T17:30:33.503849Z","end":"2026-04-12T17:30:33.723903Z","steps":["trace[391877849] 'process raft request' (duration: 219.930738ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:33.837763Z","caller":"traceutil/trace.go:171","msg":"trace[697512959] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"198.732876ms","start":"2026-04-12T17:30:33.639001Z","end":"2026-04-12T17:30:33.837734Z","steps":["trace[697512959] 'process raft request' (duration: 198.442679ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:33.838Z","caller":"traceutil/trace.go:171","msg":"trace[12464012] linearizableReadLoop","detail":"{readStateIndex:2659; appliedIndex:2657; }","duration":"172.777668ms","start":"2026-04-12T17:30:33.665197Z","end":"2026-04-12T17:30:33.837975Z","steps":["trace[12464012] 'read index received' (duration: 58.656348ms)","trace[12464012] 'applied index is now lower than readState.Index' (duration: 114.1204ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:33.838117Z","caller":"traceutil/trace.go:171","msg":"trace[14020571] transaction","detail":"{read_only:false; response_revision:2564; number_of_response:1; }","duration":"154.541657ms","start":"2026-04-12T17:30:33.683566Z","end":"2026-04-12T17:30:33.838108Z","steps":["trace[14020571] 'process raft request' (duration: 154.292831ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:33.838199Z","caller":"traceutil/trace.go:171","msg":"trace[1426788618] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"154.542618ms","start":"2026-04-12T17:30:33.683616Z","end":"2026-04-12T17:30:33.838159Z","steps":["trace[1426788618] 'process raft request' (duration: 154.320982ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:33.838273Z","caller":"traceutil/trace.go:171","msg":"trace[825227685] transaction","detail":"{read_only:false; response_revision:2563; number_of_response:1; }","duration":"172.568354ms","start":"2026-04-12T17:30:33.665674Z","end":"2026-04-12T17:30:33.838242Z","steps":["trace[825227685] 'process raft request' (duration: 171.904168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:33.838332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.125567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/valkey-server-wjplj\" ","response":"range_response_count:1 size:2454"} {"level":"info","ts":"2026-04-12T17:30:33.838366Z","caller":"traceutil/trace.go:171","msg":"trace[27272997] range","detail":"{range_begin:/registry/secrets/openstack/valkey-server-wjplj; range_end:; response_count:1; response_revision:2565; }","duration":"173.20642ms","start":"2026-04-12T17:30:33.665151Z","end":"2026-04-12T17:30:33.838358Z","steps":["trace[27272997] 'agreement among raft nodes before linearized reading' (duration: 173.067686ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:33.855247Z","caller":"traceutil/trace.go:171","msg":"trace[288233670] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"114.114429ms","start":"2026-04-12T17:30:33.741103Z","end":"2026-04-12T17:30:33.855217Z","steps":["trace[288233670] 'process raft request' (duration: 113.462743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:33.855664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.168329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/valkey-server-certs\" ","response":"range_response_count:1 size:5410"} {"level":"info","ts":"2026-04-12T17:30:33.855733Z","caller":"traceutil/trace.go:171","msg":"trace[630120094] range","detail":"{range_begin:/registry/secrets/openstack/valkey-server-certs; range_end:; response_count:1; response_revision:2567; }","duration":"188.260192ms","start":"2026-04-12T17:30:33.667456Z","end":"2026-04-12T17:30:33.855716Z","steps":["trace[630120094] 'agreement among raft nodes before linearized reading' (duration: 188.060307ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.316644Z","caller":"traceutil/trace.go:171","msg":"trace[319077331] transaction","detail":"{read_only:false; response_revision:2616; number_of_response:1; }","duration":"116.284263ms","start":"2026-04-12T17:30:38.200323Z","end":"2026-04-12T17:30:38.316607Z","steps":["trace[319077331] 'process raft request' (duration: 72.061133ms)","trace[319077331] 'compare' (duration: 43.987804ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:38.364483Z","caller":"traceutil/trace.go:171","msg":"trace[168057619] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"161.430584ms","start":"2026-04-12T17:30:38.203017Z","end":"2026-04-12T17:30:38.364447Z","steps":["trace[168057619] 'process raft request' (duration: 161.202338ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.57278Z","caller":"traceutil/trace.go:171","msg":"trace[107322002] transaction","detail":"{read_only:false; response_revision:2622; number_of_response:1; }","duration":"161.922656ms","start":"2026-04-12T17:30:38.410824Z","end":"2026-04-12T17:30:38.572747Z","steps":["trace[107322002] 'process raft request' (duration: 161.663ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.572959Z","caller":"traceutil/trace.go:171","msg":"trace[1072457428] transaction","detail":"{read_only:false; response_revision:2623; number_of_response:1; }","duration":"162.037999ms","start":"2026-04-12T17:30:38.410891Z","end":"2026-04-12T17:30:38.572929Z","steps":["trace[1072457428] 'process raft request' (duration: 161.774862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:38.573074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.00213ms","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-04-12T17:30:38.573172Z","caller":"traceutil/trace.go:171","msg":"trace[582420516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2623; }","duration":"153.148583ms","start":"2026-04-12T17:30:38.420005Z","end":"2026-04-12T17:30:38.573154Z","steps":["trace[582420516] 'agreement among raft nodes before linearized reading' (duration: 152.864026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:38.573193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.372682ms","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-04-12T17:30:38.573349Z","caller":"traceutil/trace.go:171","msg":"trace[55451896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2623; }","duration":"125.603528ms","start":"2026-04-12T17:30:38.447702Z","end":"2026-04-12T17:30:38.573306Z","steps":["trace[55451896] 'agreement among raft nodes before linearized reading' (duration: 125.119636ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.690864Z","caller":"traceutil/trace.go:171","msg":"trace[1120066699] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"107.178912ms","start":"2026-04-12T17:30:38.58363Z","end":"2026-04-12T17:30:38.690809Z","steps":["trace[1120066699] 'process raft request' (duration: 106.769082ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.690976Z","caller":"traceutil/trace.go:171","msg":"trace[1558922839] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"107.260114ms","start":"2026-04-12T17:30:38.583682Z","end":"2026-04-12T17:30:38.690943Z","steps":["trace[1558922839] 'process raft request' (duration: 106.850854ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.691549Z","caller":"traceutil/trace.go:171","msg":"trace[1892423129] transaction","detail":"{read_only:false; response_revision:2630; number_of_response:1; }","duration":"104.453636ms","start":"2026-04-12T17:30:38.587077Z","end":"2026-04-12T17:30:38.691531Z","steps":["trace[1892423129] 'process raft request' (duration: 103.524214ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.901705Z","caller":"traceutil/trace.go:171","msg":"trace[134342941] transaction","detail":"{read_only:false; response_revision:2634; number_of_response:1; }","duration":"184.548284ms","start":"2026-04-12T17:30:38.717129Z","end":"2026-04-12T17:30:38.901677Z","steps":["trace[134342941] 'process raft request' (duration: 184.504582ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.902119Z","caller":"traceutil/trace.go:171","msg":"trace[1942940016] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"205.92765ms","start":"2026-04-12T17:30:38.696147Z","end":"2026-04-12T17:30:38.902074Z","steps":["trace[1942940016] 'process raft request' (duration: 189.3992ms)","trace[1942940016] 'compare' (duration: 15.716641ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:38.902468Z","caller":"traceutil/trace.go:171","msg":"trace[361541499] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"196.920612ms","start":"2026-04-12T17:30:38.705534Z","end":"2026-04-12T17:30:38.902455Z","steps":["trace[361541499] 'process raft request' (duration: 196.025081ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:38.902624Z","caller":"traceutil/trace.go:171","msg":"trace[278610600] linearizableReadLoop","detail":"{readStateIndex:2732; appliedIndex:2730; }","duration":"189.468812ms","start":"2026-04-12T17:30:38.713146Z","end":"2026-04-12T17:30:38.902615Z","steps":["trace[278610600] 'read index received' (duration: 172.41514ms)","trace[278610600] 'applied index is now lower than readState.Index' (duration: 17.052762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:30:38.902988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.287796ms","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-04-12T17:30:38.90305Z","caller":"traceutil/trace.go:171","msg":"trace[724774119] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2634; }","duration":"191.413619ms","start":"2026-04-12T17:30:38.711621Z","end":"2026-04-12T17:30:38.903035Z","steps":["trace[724774119] 'agreement among raft nodes before linearized reading' (duration: 191.215654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:38.903293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.136774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-12T17:30:38.903349Z","caller":"traceutil/trace.go:171","msg":"trace[2075732023] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2634; }","duration":"189.202085ms","start":"2026-04-12T17:30:38.714132Z","end":"2026-04-12T17:30:38.903334Z","steps":["trace[2075732023] 'agreement among raft nodes before linearized reading' (duration: 189.101683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:38.904109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.097206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T17:30:38.904169Z","caller":"traceutil/trace.go:171","msg":"trace[1520410100] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2634; }","duration":"106.216118ms","start":"2026-04-12T17:30:38.797936Z","end":"2026-04-12T17:30:38.904152Z","steps":["trace[1520410100] 'agreement among raft nodes before linearized reading' (duration: 106.126916ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:39.175321Z","caller":"traceutil/trace.go:171","msg":"trace[318783061] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"208.319228ms","start":"2026-04-12T17:30:38.966968Z","end":"2026-04-12T17:30:39.175287Z","steps":["trace[318783061] 'process raft request' (duration: 151.067973ms)","trace[318783061] 'compare' (duration: 56.413614ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:39.17569Z","caller":"traceutil/trace.go:171","msg":"trace[1023856073] transaction","detail":"{read_only:false; response_revision:2638; number_of_response:1; }","duration":"208.186305ms","start":"2026-04-12T17:30:38.967488Z","end":"2026-04-12T17:30:39.175675Z","steps":["trace[1023856073] 'process raft request' (duration: 207.539219ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:39.176008Z","caller":"traceutil/trace.go:171","msg":"trace[1052903910] transaction","detail":"{read_only:false; response_revision:2639; number_of_response:1; }","duration":"206.246008ms","start":"2026-04-12T17:30:38.969746Z","end":"2026-04-12T17:30:39.175992Z","steps":["trace[1052903910] 'process raft request' (duration: 205.341676ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:39.319574Z","caller":"traceutil/trace.go:171","msg":"trace[112726154] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"112.431118ms","start":"2026-04-12T17:30:39.207111Z","end":"2026-04-12T17:30:39.319542Z","steps":["trace[112726154] 'process raft request' (duration: 71.315314ms)","trace[112726154] 'compare' (duration: 40.911409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:30:40.879021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.566004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-12T17:30:40.879049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.543288ms","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-04-12T17:30:40.879149Z","caller":"traceutil/trace.go:171","msg":"trace[725429753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2650; }","duration":"295.708082ms","start":"2026-04-12T17:30:40.583417Z","end":"2026-04-12T17:30:40.879125Z","steps":["trace[725429753] 'range keys from in-memory index tree' (duration: 295.325162ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:40.879165Z","caller":"traceutil/trace.go:171","msg":"trace[558030876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2650; }","duration":"270.733358ms","start":"2026-04-12T17:30:40.60841Z","end":"2026-04-12T17:30:40.879144Z","steps":["trace[558030876] 'range keys from in-memory index tree' (duration: 270.360639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:40.879023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.582614ms","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-04-12T17:30:40.879353Z","caller":"traceutil/trace.go:171","msg":"trace[236991046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2650; }","duration":"270.873461ms","start":"2026-04-12T17:30:40.608367Z","end":"2026-04-12T17:30:40.87924Z","steps":["trace[236991046] 'range keys from in-memory index tree' (duration: 270.366709ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:41.002302Z","caller":"traceutil/trace.go:171","msg":"trace[2061261520] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"118.853185ms","start":"2026-04-12T17:30:40.883418Z","end":"2026-04-12T17:30:41.002272Z","steps":["trace[2061261520] 'process raft request' (duration: 118.681551ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:41.006281Z","caller":"traceutil/trace.go:171","msg":"trace[841605097] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"122.624405ms","start":"2026-04-12T17:30:40.883618Z","end":"2026-04-12T17:30:41.006243Z","steps":["trace[841605097] 'process raft request' (duration: 122.42162ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:41.00659Z","caller":"traceutil/trace.go:171","msg":"trace[982642818] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"121.821116ms","start":"2026-04-12T17:30:40.884722Z","end":"2026-04-12T17:30:41.006543Z","steps":["trace[982642818] 'process raft request' (duration: 121.472467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:45.961597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.073145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:30:45.961732Z","caller":"traceutil/trace.go:171","msg":"trace[439318614] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"438.515382ms","start":"2026-04-12T17:30:45.523192Z","end":"2026-04-12T17:30:45.961708Z","steps":["trace[439318614] 'process raft request' (duration: 72.247782ms)","trace[439318614] 'compare' (duration: 365.84893ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:30:45.961839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:45.523147Z","time spent":"438.648165ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:30:46.472473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.123798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:30:46.4728Z","caller":"traceutil/trace.go:171","msg":"trace[2024201132] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"465.946929ms","start":"2026-04-12T17:30:46.006805Z","end":"2026-04-12T17:30:46.472752Z","steps":["trace[2024201132] 'process raft request' (duration: 101.408891ms)","trace[2024201132] 'compare' (duration: 363.76893ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:46.472861Z","caller":"traceutil/trace.go:171","msg":"trace[409295340] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"455.870718ms","start":"2026-04-12T17:30:46.016968Z","end":"2026-04-12T17:30:46.472839Z","steps":["trace[409295340] 'process raft request' (duration: 455.657002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:46.472951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.016949Z","time spent":"455.95603ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:30:46.47296Z","caller":"traceutil/trace.go:171","msg":"trace[1405429428] linearizableReadLoop","detail":"{readStateIndex:2785; appliedIndex:2782; }","duration":"370.371238ms","start":"2026-04-12T17:30:46.102554Z","end":"2026-04-12T17:30:46.472925Z","steps":["trace[1405429428] 'read index received' (duration: 5.611814ms)","trace[1405429428] 'applied index is now lower than readState.Index' (duration: 364.757314ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:46.472972Z","caller":"traceutil/trace.go:171","msg":"trace[1758207338] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"455.902678ms","start":"2026-04-12T17:30:46.017042Z","end":"2026-04-12T17:30:46.472945Z","steps":["trace[1758207338] 'process raft request' (duration: 455.705263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:46.473023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.006777Z","time spent":"466.123263ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:30:46.473106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.528022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T17:30:46.473154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.017014Z","time spent":"456.041802ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:30:46.473225Z","caller":"traceutil/trace.go:171","msg":"trace[753470095] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2685; }","duration":"370.712416ms","start":"2026-04-12T17:30:46.102489Z","end":"2026-04-12T17:30:46.473201Z","steps":["trace[753470095] 'agreement among raft nodes before linearized reading' (duration: 370.528292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:46.47328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.102464Z","time spent":"370.804959ms","remote":"127.0.0.1:32840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-04-12T17:30:47.292017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.011201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-12T17:30:47.292127Z","caller":"traceutil/trace.go:171","msg":"trace[1593050032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2685; }","duration":"116.240387ms","start":"2026-04-12T17:30:47.175861Z","end":"2026-04-12T17:30:47.292101Z","steps":["trace[1593050032] 'range keys from in-memory index tree' (duration: 115.717814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.292261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.275497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-12T17:30:47.292303Z","caller":"traceutil/trace.go:171","msg":"trace[549404391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2685; }","duration":"209.358018ms","start":"2026-04-12T17:30:47.082934Z","end":"2026-04-12T17:30:47.292292Z","steps":["trace[549404391] 'range keys from in-memory index tree' (duration: 209.084002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.292342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.3265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T17:30:47.29248Z","caller":"traceutil/trace.go:171","msg":"trace[1078262538] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2685; }","duration":"197.505495ms","start":"2026-04-12T17:30:47.094932Z","end":"2026-04-12T17:30:47.292438Z","steps":["trace[1078262538] 'count revisions from in-memory index tree' (duration: 197.206137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.292151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.296394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-04-12T17:30:47.292409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.344718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-12T17:30:47.292571Z","caller":"traceutil/trace.go:171","msg":"trace[154025559] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2685; }","duration":"319.770975ms","start":"2026-04-12T17:30:46.972768Z","end":"2026-04-12T17:30:47.292539Z","steps":["trace[154025559] 'range keys from in-memory index tree' (duration: 319.099929ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:47.292596Z","caller":"traceutil/trace.go:171","msg":"trace[1360576510] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2685; }","duration":"390.554302ms","start":"2026-04-12T17:30:46.902023Z","end":"2026-04-12T17:30:47.292578Z","steps":["trace[1360576510] 'range keys from in-memory index tree' (duration: 390.143932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.292652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.902012Z","time spent":"390.623093ms","remote":"127.0.0.1:40678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-12T17:30:47.292519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.325736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:30:47.292838Z","caller":"traceutil/trace.go:171","msg":"trace[489164724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2685; }","duration":"425.724996ms","start":"2026-04-12T17:30:46.867096Z","end":"2026-04-12T17:30:47.292821Z","steps":["trace[489164724] 'range keys from in-memory index tree' (duration: 425.250484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.292895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.867073Z","time spent":"425.807647ms","remote":"127.0.0.1:40464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-12T17:30:47.292652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:30:46.972748Z","time spent":"319.884548ms","remote":"127.0.0.1:40686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-12T17:30:47.498752Z","caller":"traceutil/trace.go:171","msg":"trace[221068772] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"200.004874ms","start":"2026-04-12T17:30:47.298704Z","end":"2026-04-12T17:30:47.498709Z","steps":["trace[221068772] 'process raft request' (duration: 168.695324ms)","trace[221068772] 'compare' (duration: 30.910381ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:47.498921Z","caller":"traceutil/trace.go:171","msg":"trace[1192416337] linearizableReadLoop","detail":"{readStateIndex:2788; appliedIndex:2785; }","duration":"199.193706ms","start":"2026-04-12T17:30:47.29969Z","end":"2026-04-12T17:30:47.498884Z","steps":["trace[1192416337] 'read index received' (duration: 8.083164ms)","trace[1192416337] 'applied index is now lower than readState.Index' (duration: 191.108251ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:30:47.498968Z","caller":"traceutil/trace.go:171","msg":"trace[910717923] transaction","detail":"{read_only:false; response_revision:2689; number_of_response:1; }","duration":"199.078703ms","start":"2026-04-12T17:30:47.299849Z","end":"2026-04-12T17:30:47.498928Z","steps":["trace[910717923] 'process raft request' (duration: 198.877578ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:47.498987Z","caller":"traceutil/trace.go:171","msg":"trace[73451145] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"198.219402ms","start":"2026-04-12T17:30:47.300715Z","end":"2026-04-12T17:30:47.498934Z","steps":["trace[73451145] 'process raft request' (duration: 198.075948ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:30:47.498994Z","caller":"traceutil/trace.go:171","msg":"trace[1331362885] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"200.433874ms","start":"2026-04-12T17:30:47.298525Z","end":"2026-04-12T17:30:47.498959Z","steps":["trace[1331362885] 'process raft request' (duration: 200.099366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.49925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.529733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-04-12T17:30:47.499336Z","caller":"traceutil/trace.go:171","msg":"trace[923849747] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2690; }","duration":"199.649616ms","start":"2026-04-12T17:30:47.299665Z","end":"2026-04-12T17:30:47.499315Z","steps":["trace[923849747] 'agreement among raft nodes before linearized reading' (duration: 199.39816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:30:47.504199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.782755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:30:47.504365Z","caller":"traceutil/trace.go:171","msg":"trace[563369500] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2691; }","duration":"141.024781ms","start":"2026-04-12T17:30:47.363329Z","end":"2026-04-12T17:30:47.504354Z","steps":["trace[563369500] 'agreement among raft nodes before linearized reading' (duration: 140.780875ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:31:20.745551Z","caller":"traceutil/trace.go:171","msg":"trace[430657269] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"112.394544ms","start":"2026-04-12T17:31:20.633119Z","end":"2026-04-12T17:31:20.745513Z","steps":["trace[430657269] 'process raft request' (duration: 112.186079ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:31:20.750644Z","caller":"traceutil/trace.go:171","msg":"trace[1804638801] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"101.116284ms","start":"2026-04-12T17:31:20.64949Z","end":"2026-04-12T17:31:20.750606Z","steps":["trace[1804638801] 'process raft request' (duration: 100.861608ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:34:59.21849Z","caller":"traceutil/trace.go:171","msg":"trace[967692655] transaction","detail":"{read_only:false; response_revision:4330; number_of_response:1; }","duration":"102.1853ms","start":"2026-04-12T17:34:59.116275Z","end":"2026-04-12T17:34:59.21846Z","steps":["trace[967692655] 'process raft request' (duration: 102.019256ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:15.215879Z","caller":"traceutil/trace.go:171","msg":"trace[302090002] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"203.138579ms","start":"2026-04-12T17:35:15.0127Z","end":"2026-04-12T17:35:15.215838Z","steps":["trace[302090002] 'process raft request' (duration: 149.685123ms)","trace[302090002] 'compare' (duration: 53.22657ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:15.237248Z","caller":"traceutil/trace.go:171","msg":"trace[1834395156] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"124.45938ms","start":"2026-04-12T17:35:15.112768Z","end":"2026-04-12T17:35:15.237228Z","steps":["trace[1834395156] 'process raft request' (duration: 124.415339ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:15.237385Z","caller":"traceutil/trace.go:171","msg":"trace[1013551821] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"147.573612ms","start":"2026-04-12T17:35:15.089778Z","end":"2026-04-12T17:35:15.237352Z","steps":["trace[1013551821] 'process raft request' (duration: 147.351327ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:15.237438Z","caller":"traceutil/trace.go:171","msg":"trace[472940299] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"174.563997ms","start":"2026-04-12T17:35:15.062829Z","end":"2026-04-12T17:35:15.237393Z","steps":["trace[472940299] 'process raft request' (duration: 174.189658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.639898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.009997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:35:21.640405Z","caller":"traceutil/trace.go:171","msg":"trace[617944790] linearizableReadLoop","detail":"{readStateIndex:5116; appliedIndex:5115; }","duration":"577.77714ms","start":"2026-04-12T17:35:21.062614Z","end":"2026-04-12T17:35:21.640391Z","steps":["trace[617944790] 'read index received' (duration: 278.113968ms)","trace[617944790] 'applied index is now lower than readState.Index' (duration: 299.661862ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:35:21.64053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.920793ms","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-04-12T17:35:21.640549Z","caller":"traceutil/trace.go:171","msg":"trace[1507096735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4935; }","duration":"577.965525ms","start":"2026-04-12T17:35:21.062577Z","end":"2026-04-12T17:35:21.640542Z","steps":["trace[1507096735] 'agreement among raft nodes before linearized reading' (duration: 577.872003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.640567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.062563Z","time spent":"577.999755ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-12T17:35:21.640472Z","caller":"traceutil/trace.go:171","msg":"trace[728863139] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"598.631428ms","start":"2026-04-12T17:35:21.041785Z","end":"2026-04-12T17:35:21.640417Z","steps":["trace[728863139] 'process raft request' (duration: 298.869253ms)","trace[728863139] 'compare' (duration: 298.788362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:35:21.640724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.041755Z","time spent":"598.861334ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1920,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:21.683862Z","caller":"traceutil/trace.go:171","msg":"trace[344637581] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"409.122465ms","start":"2026-04-12T17:35:21.274697Z","end":"2026-04-12T17:35:21.68382Z","steps":["trace[344637581] 'process raft request' (duration: 408.858249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.683904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.60167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:35:21.684009Z","caller":"traceutil/trace.go:171","msg":"trace[1165585023] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4936; }","duration":"229.752884ms","start":"2026-04-12T17:35:21.454243Z","end":"2026-04-12T17:35:21.683996Z","steps":["trace[1165585023] 'agreement among raft nodes before linearized reading' (duration: 229.57482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.684023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.967356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-12T17:35:21.684103Z","caller":"traceutil/trace.go:171","msg":"trace[1193877885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4936; }","duration":"312.092669ms","start":"2026-04-12T17:35:21.371983Z","end":"2026-04-12T17:35:21.684075Z","steps":["trace[1193877885] 'agreement among raft nodes before linearized reading' (duration: 311.799872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.684067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.274651Z","time spent":"409.34671ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:35:21.684163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.371961Z","time spent":"312.196021ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-12T17:35:21.684163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.531521ms","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-04-12T17:35:21.684226Z","caller":"traceutil/trace.go:171","msg":"trace[880996370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4936; }","duration":"351.617242ms","start":"2026-04-12T17:35:21.332586Z","end":"2026-04-12T17:35:21.684203Z","steps":["trace[880996370] 'agreement among raft nodes before linearized reading' (duration: 351.426368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.68424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.562764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2b0e9ce-2abf-467e-bfa5-a1bcb84a93ad\" ","response":"range_response_count:1 size:4066"} {"level":"warn","ts":"2026-04-12T17:35:21.684262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.332569Z","time spent":"351.685054ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-12T17:35:21.684307Z","caller":"traceutil/trace.go:171","msg":"trace[186834833] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f2b0e9ce-2abf-467e-bfa5-a1bcb84a93ad; range_end:; response_count:1; response_revision:4936; }","duration":"600.654186ms","start":"2026-04-12T17:35:21.083631Z","end":"2026-04-12T17:35:21.684285Z","steps":["trace[186834833] 'agreement among raft nodes before linearized reading' (duration: 600.471122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.684289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.358276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-12T17:35:21.684354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.083621Z","time spent":"600.724077ms","remote":"127.0.0.1:40678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4090,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2b0e9ce-2abf-467e-bfa5-a1bcb84a93ad\" "} {"level":"info","ts":"2026-04-12T17:35:21.684386Z","caller":"traceutil/trace.go:171","msg":"trace[184369474] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4936; }","duration":"338.488259ms","start":"2026-04-12T17:35:21.345875Z","end":"2026-04-12T17:35:21.684363Z","steps":["trace[184369474] 'agreement among raft nodes before linearized reading' (duration: 337.911135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:21.684458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.345869Z","time spent":"338.568101ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-12T17:35:22.01553Z","caller":"traceutil/trace.go:171","msg":"trace[195169755] linearizableReadLoop","detail":"{readStateIndex:5119; appliedIndex:5117; }","duration":"331.749778ms","start":"2026-04-12T17:35:21.683746Z","end":"2026-04-12T17:35:22.015496Z","steps":["trace[195169755] 'read index received' (duration: 331.449981ms)","trace[195169755] 'applied index is now lower than readState.Index' (duration: 297.877µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:22.015629Z","caller":"traceutil/trace.go:171","msg":"trace[1943778639] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"371.609609ms","start":"2026-04-12T17:35:21.643978Z","end":"2026-04-12T17:35:22.015588Z","steps":["trace[1943778639] 'process raft request' (duration: 371.449745ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:22.015705Z","caller":"traceutil/trace.go:171","msg":"trace[674316844] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"375.212906ms","start":"2026-04-12T17:35:21.640471Z","end":"2026-04-12T17:35:22.015684Z","steps":["trace[674316844] 'process raft request' (duration: 374.752905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.015808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.402418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2f04e196-ff0c-4269-b3dd-38c58b931f6e\" ","response":"range_response_count:1 size:1450"} {"level":"warn","ts":"2026-04-12T17:35:22.015829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.640447Z","time spent":"375.307937ms","remote":"127.0.0.1:40678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:35:22.015886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.643964Z","time spent":"371.784473ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:22.015902Z","caller":"traceutil/trace.go:171","msg":"trace[2062121753] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2f04e196-ff0c-4269-b3dd-38c58b931f6e; range_end:; response_count:1; response_revision:4938; }","duration":"372.532971ms","start":"2026-04-12T17:35:21.64335Z","end":"2026-04-12T17:35:22.015883Z","steps":["trace[2062121753] 'agreement among raft nodes before linearized reading' (duration: 372.305106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.016049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.643334Z","time spent":"372.697425ms","remote":"127.0.0.1:40642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1474,"request content":"key:\"/registry/persistentvolumes/pvc-2f04e196-ff0c-4269-b3dd-38c58b931f6e\" "} {"level":"warn","ts":"2026-04-12T17:35:22.016161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.568078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:22 size:517416"} {"level":"info","ts":"2026-04-12T17:35:22.016219Z","caller":"traceutil/trace.go:171","msg":"trace[1311571558] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:22; response_revision:4938; }","duration":"332.646929ms","start":"2026-04-12T17:35:21.683556Z","end":"2026-04-12T17:35:22.016203Z","steps":["trace[1311571558] 'agreement among raft nodes before linearized reading' (duration: 332.076375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.016261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.683547Z","time spent":"332.701901ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":22,"response size":517440,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-04-12T17:35:22.142572Z","caller":"traceutil/trace.go:171","msg":"trace[1245639804] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"454.835126ms","start":"2026-04-12T17:35:21.687712Z","end":"2026-04-12T17:35:22.142547Z","steps":["trace[1245639804] 'process raft request' (duration: 454.632361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.142701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.687689Z","time spent":"454.945309ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:22.142572Z","caller":"traceutil/trace.go:171","msg":"trace[456470203] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"454.679512ms","start":"2026-04-12T17:35:21.68787Z","end":"2026-04-12T17:35:22.14255Z","steps":["trace[456470203] 'process raft request' (duration: 454.62258ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:22.142759Z","caller":"traceutil/trace.go:171","msg":"trace[504731113] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"454.62575ms","start":"2026-04-12T17:35:21.688126Z","end":"2026-04-12T17:35:22.142751Z","steps":["trace[504731113] 'process raft request' (duration: 454.397345ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:22.142935Z","caller":"traceutil/trace.go:171","msg":"trace[969480672] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"391.796791ms","start":"2026-04-12T17:35:21.75112Z","end":"2026-04-12T17:35:22.142916Z","steps":["trace[969480672] 'process raft request' (duration: 391.599307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.143019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.751097Z","time spent":"391.889483ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:35:22.143024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.688119Z","time spent":"454.788945ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:35:22.143013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.687858Z","time spent":"454.973429ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:22.143141Z","caller":"traceutil/trace.go:171","msg":"trace[453043923] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"383.198786ms","start":"2026-04-12T17:35:21.759929Z","end":"2026-04-12T17:35:22.143128Z","steps":["trace[453043923] 'process raft request' (duration: 383.092654ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:22.143129Z","caller":"traceutil/trace.go:171","msg":"trace[739361386] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"388.575865ms","start":"2026-04-12T17:35:21.754521Z","end":"2026-04-12T17:35:22.143096Z","steps":["trace[739361386] 'process raft request' (duration: 388.36733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.143214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.759915Z","time spent":"383.263038ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:35:22.143253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.946744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-12T17:35:22.143302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.672192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T17:35:22.143342Z","caller":"traceutil/trace.go:171","msg":"trace[987610193] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:4944; }","duration":"162.748044ms","start":"2026-04-12T17:35:21.980581Z","end":"2026-04-12T17:35:22.143329Z","steps":["trace[987610193] 'agreement among raft nodes before linearized reading' (duration: 162.687263ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:22.143334Z","caller":"traceutil/trace.go:171","msg":"trace[844513573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4944; }","duration":"278.059707ms","start":"2026-04-12T17:35:21.865258Z","end":"2026-04-12T17:35:22.143318Z","steps":["trace[844513573] 'agreement among raft nodes before linearized reading' (duration: 277.917643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.143276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:21.754499Z","time spent":"388.698667ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:22.143124Z","caller":"traceutil/trace.go:171","msg":"trace[2039741811] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5119; }","duration":"127.472723ms","start":"2026-04-12T17:35:22.015622Z","end":"2026-04-12T17:35:22.143095Z","steps":["trace[2039741811] 'read index received' (duration: 126.695394ms)","trace[2039741811] 'applied index is now lower than readState.Index' (duration: 775.589µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:22.19433Z","caller":"traceutil/trace.go:171","msg":"trace[1379339472] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"173.920471ms","start":"2026-04-12T17:35:22.020381Z","end":"2026-04-12T17:35:22.194301Z","steps":["trace[1379339472] 'process raft request' (duration: 173.772237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:22.194662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.218866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-04-12T17:35:22.194783Z","caller":"traceutil/trace.go:171","msg":"trace[1243129020] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4945; }","duration":"171.406221ms","start":"2026-04-12T17:35:22.023349Z","end":"2026-04-12T17:35:22.194755Z","steps":["trace[1243129020] 'agreement among raft nodes before linearized reading' (duration: 170.96999ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.2625Z","caller":"traceutil/trace.go:171","msg":"trace[2104584311] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"188.481849ms","start":"2026-04-12T17:35:24.073856Z","end":"2026-04-12T17:35:24.262338Z","steps":["trace[2104584311] 'process raft request' (duration: 95.024118ms)","trace[2104584311] 'compare' (duration: 93.193415ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:24.265032Z","caller":"traceutil/trace.go:171","msg":"trace[1437955962] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"191.026319ms","start":"2026-04-12T17:35:24.073973Z","end":"2026-04-12T17:35:24.264999Z","steps":["trace[1437955962] 'process raft request' (duration: 190.787844ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265079Z","caller":"traceutil/trace.go:171","msg":"trace[52834483] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"191.004809ms","start":"2026-04-12T17:35:24.074046Z","end":"2026-04-12T17:35:24.265051Z","steps":["trace[52834483] 'process raft request' (duration: 190.874176ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265199Z","caller":"traceutil/trace.go:171","msg":"trace[494158008] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"189.338309ms","start":"2026-04-12T17:35:24.075848Z","end":"2026-04-12T17:35:24.265186Z","steps":["trace[494158008] 'process raft request' (duration: 189.107993ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265285Z","caller":"traceutil/trace.go:171","msg":"trace[667590074] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"189.153985ms","start":"2026-04-12T17:35:24.076104Z","end":"2026-04-12T17:35:24.265258Z","steps":["trace[667590074] 'process raft request' (duration: 188.996351ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265355Z","caller":"traceutil/trace.go:171","msg":"trace[872539516] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"189.37834ms","start":"2026-04-12T17:35:24.0759Z","end":"2026-04-12T17:35:24.265278Z","steps":["trace[872539516] 'process raft request' (duration: 189.129194ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265391Z","caller":"traceutil/trace.go:171","msg":"trace[1556960629] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5202; }","duration":"141.917287ms","start":"2026-04-12T17:35:24.123446Z","end":"2026-04-12T17:35:24.265364Z","steps":["trace[1556960629] 'read index received' (duration: 45.521966ms)","trace[1556960629] 'applied index is now lower than readState.Index' (duration: 96.394371ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:24.265514Z","caller":"traceutil/trace.go:171","msg":"trace[1800736490] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"117.584746ms","start":"2026-04-12T17:35:24.147916Z","end":"2026-04-12T17:35:24.265501Z","steps":["trace[1800736490] 'process raft request' (duration: 117.370441ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265611Z","caller":"traceutil/trace.go:171","msg":"trace[2083145367] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"188.661373ms","start":"2026-04-12T17:35:24.076933Z","end":"2026-04-12T17:35:24.265594Z","steps":["trace[2083145367] 'process raft request' (duration: 188.274073ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265645Z","caller":"traceutil/trace.go:171","msg":"trace[1028311030] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"117.770291ms","start":"2026-04-12T17:35:24.147862Z","end":"2026-04-12T17:35:24.265632Z","steps":["trace[1028311030] 'process raft request' (duration: 117.386311ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.265815Z","caller":"traceutil/trace.go:171","msg":"trace[2109796185] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"115.873396ms","start":"2026-04-12T17:35:24.149894Z","end":"2026-04-12T17:35:24.265768Z","steps":["trace[2109796185] 'process raft request' (duration: 115.428725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:24.265973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.521151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-12T17:35:24.266033Z","caller":"traceutil/trace.go:171","msg":"trace[729428800] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5026; }","duration":"142.632494ms","start":"2026-04-12T17:35:24.12338Z","end":"2026-04-12T17:35:24.266013Z","steps":["trace[729428800] 'agreement among raft nodes before linearized reading' (duration: 142.436659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:24.266046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.402712ms","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-04-12T17:35:24.265978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.561786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-12T17:35:24.266075Z","caller":"traceutil/trace.go:171","msg":"trace[667644520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5026; }","duration":"117.443503ms","start":"2026-04-12T17:35:24.148622Z","end":"2026-04-12T17:35:24.266066Z","steps":["trace[667644520] 'agreement among raft nodes before linearized reading' (duration: 117.380261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:24.266071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.115976ms","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-04-12T17:35:24.266117Z","caller":"traceutil/trace.go:171","msg":"trace[1988160272] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5026; }","duration":"117.173737ms","start":"2026-04-12T17:35:24.148931Z","end":"2026-04-12T17:35:24.266104Z","steps":["trace[1988160272] 'agreement among raft nodes before linearized reading' (duration: 116.999183ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:24.266111Z","caller":"traceutil/trace.go:171","msg":"trace[490765256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5026; }","duration":"117.749591ms","start":"2026-04-12T17:35:24.148348Z","end":"2026-04-12T17:35:24.266097Z","steps":["trace[490765256] 'agreement among raft nodes before linearized reading' (duration: 117.477604ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:26.745673Z","caller":"traceutil/trace.go:171","msg":"trace[111815649] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5126; }","duration":"157.783636ms","start":"2026-04-12T17:35:26.587858Z","end":"2026-04-12T17:35:26.745642Z","steps":["trace[111815649] 'process raft request' (duration: 157.666413ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:28.475792Z","caller":"traceutil/trace.go:171","msg":"trace[590841442] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"192.223048ms","start":"2026-04-12T17:35:28.283538Z","end":"2026-04-12T17:35:28.475761Z","steps":["trace[590841442] 'process raft request' (duration: 171.386331ms)","trace[590841442] 'compare' (duration: 20.599012ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:28.476033Z","caller":"traceutil/trace.go:171","msg":"trace[571847700] linearizableReadLoop","detail":"{readStateIndex:5343; appliedIndex:5340; }","duration":"182.990767ms","start":"2026-04-12T17:35:28.293011Z","end":"2026-04-12T17:35:28.476002Z","steps":["trace[571847700] 'read index received' (duration: 39.83958ms)","trace[571847700] 'applied index is now lower than readState.Index' (duration: 143.149887ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:28.476171Z","caller":"traceutil/trace.go:171","msg":"trace[1201514211] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"192.388892ms","start":"2026-04-12T17:35:28.283742Z","end":"2026-04-12T17:35:28.476131Z","steps":["trace[1201514211] 'process raft request' (duration: 191.974502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:28.476335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.304305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-12T17:35:28.47636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.137127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-27gxh\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-12T17:35:28.476366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.21322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-12T17:35:28.476422Z","caller":"traceutil/trace.go:171","msg":"trace[2114278703] range","detail":"{range_begin:/registry/pods/openstack/keepalived-27gxh; range_end:; response_count:1; response_revision:5154; }","duration":"169.225089ms","start":"2026-04-12T17:35:28.307182Z","end":"2026-04-12T17:35:28.476407Z","steps":["trace[2114278703] 'agreement among raft nodes before linearized reading' (duration: 169.032374ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:28.476411Z","caller":"traceutil/trace.go:171","msg":"trace[942758473] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5154; }","duration":"183.421128ms","start":"2026-04-12T17:35:28.292972Z","end":"2026-04-12T17:35:28.476393Z","steps":["trace[942758473] 'agreement among raft nodes before linearized reading' (duration: 183.205212ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:28.47644Z","caller":"traceutil/trace.go:171","msg":"trace[1108529772] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5154; }","duration":"177.315252ms","start":"2026-04-12T17:35:28.299104Z","end":"2026-04-12T17:35:28.47642Z","steps":["trace[1108529772] 'agreement among raft nodes before linearized reading' (duration: 177.104917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:28.476336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.271968ms","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-04-12T17:35:28.476499Z","caller":"traceutil/trace.go:171","msg":"trace[1352544666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5154; }","duration":"176.473813ms","start":"2026-04-12T17:35:28.300009Z","end":"2026-04-12T17:35:28.476482Z","steps":["trace[1352544666] 'agreement among raft nodes before linearized reading' (duration: 176.227267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:28.476859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.021641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777469"} {"level":"info","ts":"2026-04-12T17:35:28.476935Z","caller":"traceutil/trace.go:171","msg":"trace[1577988552] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5154; }","duration":"163.141564ms","start":"2026-04-12T17:35:28.313775Z","end":"2026-04-12T17:35:28.476917Z","steps":["trace[1577988552] 'agreement among raft nodes before linearized reading' (duration: 162.580791ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:45.504836Z","caller":"traceutil/trace.go:171","msg":"trace[1242379293] linearizableReadLoop","detail":"{readStateIndex:5698; appliedIndex:5697; }","duration":"126.599072ms","start":"2026-04-12T17:35:45.378207Z","end":"2026-04-12T17:35:45.504806Z","steps":["trace[1242379293] 'read index received' (duration: 126.362826ms)","trace[1242379293] 'applied index is now lower than readState.Index' (duration: 234.736µs)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:45.504962Z","caller":"traceutil/trace.go:171","msg":"trace[791964161] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"206.391046ms","start":"2026-04-12T17:35:45.298536Z","end":"2026-04-12T17:35:45.504927Z","steps":["trace[791964161] 'process raft request' (duration: 206.091189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:45.505174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.90963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-12T17:35:45.505255Z","caller":"traceutil/trace.go:171","msg":"trace[1345744619] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5499; }","duration":"127.076313ms","start":"2026-04-12T17:35:45.378157Z","end":"2026-04-12T17:35:45.505233Z","steps":["trace[1345744619] 'agreement among raft nodes before linearized reading' (duration: 126.816177ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:45.663756Z","caller":"traceutil/trace.go:171","msg":"trace[1292053219] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"153.644957ms","start":"2026-04-12T17:35:45.510079Z","end":"2026-04-12T17:35:45.663724Z","steps":["trace[1292053219] 'process raft request' (duration: 109.35636ms)","trace[1292053219] 'compare' (duration: 44.129723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:35:47.249665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.025955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-12T17:35:47.24976Z","caller":"traceutil/trace.go:171","msg":"trace[567808780] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:5516; }","duration":"138.147888ms","start":"2026-04-12T17:35:47.111594Z","end":"2026-04-12T17:35:47.249742Z","steps":["trace[567808780] 'count revisions from in-memory index tree' (duration: 137.938802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.342871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:58.008465Z","time spent":"334.392341ms","remote":"127.0.0.1:47206","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-12T17:35:58.342929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.351714ms","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-04-12T17:35:58.343213Z","caller":"traceutil/trace.go:171","msg":"trace[1584795691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5690; }","duration":"123.643781ms","start":"2026-04-12T17:35:58.219536Z","end":"2026-04-12T17:35:58.34318Z","steps":["trace[1584795691] 'range keys from in-memory index tree' (duration: 123.143239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.612737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-12T17:35:58.763312Z","caller":"traceutil/trace.go:171","msg":"trace[936603111] transaction","detail":"{read_only:false; response_revision:5694; number_of_response:1; }","duration":"123.911358ms","start":"2026-04-12T17:35:58.639372Z","end":"2026-04-12T17:35:58.763283Z","steps":["trace[936603111] 'process raft request' (duration: 123.848856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.763525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.699255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-12T17:35:58.763323Z","caller":"traceutil/trace.go:171","msg":"trace[732928003] transaction","detail":"{read_only:false; response_revision:5692; number_of_response:1; }","duration":"313.288128ms","start":"2026-04-12T17:35:58.449965Z","end":"2026-04-12T17:35:58.763253Z","steps":["trace[732928003] 'process raft request' (duration: 195.323702ms)","trace[732928003] 'compare' (duration: 117.450054ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:58.763604Z","caller":"traceutil/trace.go:171","msg":"trace[744392821] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5694; }","duration":"258.819377ms","start":"2026-04-12T17:35:58.504765Z","end":"2026-04-12T17:35:58.763584Z","steps":["trace[744392821] 'agreement among raft nodes before linearized reading' (duration: 258.55655ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:58.763315Z","caller":"traceutil/trace.go:171","msg":"trace[1320396560] linearizableReadLoop","detail":"{readStateIndex:5896; appliedIndex:5895; }","duration":"258.461339ms","start":"2026-04-12T17:35:58.504799Z","end":"2026-04-12T17:35:58.76326Z","steps":["trace[1320396560] 'read index received' (duration: 140.504304ms)","trace[1320396560] 'applied index is now lower than readState.Index' (duration: 117.953955ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:58.763506Z","caller":"traceutil/trace.go:171","msg":"trace[6508012] transaction","detail":"{read_only:false; response_revision:5693; number_of_response:1; }","duration":"137.4503ms","start":"2026-04-12T17:35:58.625998Z","end":"2026-04-12T17:35:58.763448Z","steps":["trace[6508012] 'process raft request' (duration: 137.136813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.76391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.42376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-12T17:35:58.763969Z","caller":"traceutil/trace.go:171","msg":"trace[1256962640] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5694; }","duration":"256.534783ms","start":"2026-04-12T17:35:58.507425Z","end":"2026-04-12T17:35:58.76396Z","steps":["trace[1256962640] 'agreement among raft nodes before linearized reading' (duration: 256.40779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.764182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.46622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.200\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-12T17:35:58.764208Z","caller":"traceutil/trace.go:171","msg":"trace[1246052471] range","detail":"{range_begin:/registry/masterleases/162.253.55.200; range_end:; response_count:1; response_revision:5694; }","duration":"178.49489ms","start":"2026-04-12T17:35:58.585705Z","end":"2026-04-12T17:35:58.7642Z","steps":["trace[1246052471] 'agreement among raft nodes before linearized reading' (duration: 178.406358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.764223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.158834ms","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-04-12T17:35:58.764291Z","caller":"traceutil/trace.go:171","msg":"trace[1449400524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5694; }","duration":"101.267447ms","start":"2026-04-12T17:35:58.663003Z","end":"2026-04-12T17:35:58.76427Z","steps":["trace[1449400524] 'agreement among raft nodes before linearized reading' (duration: 101.059822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.764678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:35:58.449926Z","time spent":"313.707868ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:35:58.977842Z","caller":"traceutil/trace.go:171","msg":"trace[177278582] transaction","detail":"{read_only:false; response_revision:5695; number_of_response:1; }","duration":"209.248864ms","start":"2026-04-12T17:35:58.76854Z","end":"2026-04-12T17:35:58.977789Z","steps":["trace[177278582] 'process raft request' (duration: 143.377712ms)","trace[177278582] 'compare' (duration: 65.462023ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:58.977973Z","caller":"traceutil/trace.go:171","msg":"trace[1221737316] transaction","detail":"{read_only:false; response_revision:5696; number_of_response:1; }","duration":"208.785183ms","start":"2026-04-12T17:35:58.769172Z","end":"2026-04-12T17:35:58.977957Z","steps":["trace[1221737316] 'process raft request' (duration: 208.543228ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:58.978292Z","caller":"traceutil/trace.go:171","msg":"trace[2066372225] transaction","detail":"{read_only:false; response_revision:5697; number_of_response:1; }","duration":"208.205849ms","start":"2026-04-12T17:35:58.77005Z","end":"2026-04-12T17:35:58.978255Z","steps":["trace[2066372225] 'process raft request' (duration: 207.847701ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:58.978397Z","caller":"traceutil/trace.go:171","msg":"trace[1320834766] transaction","detail":"{read_only:false; response_revision:5699; number_of_response:1; }","duration":"174.625868ms","start":"2026-04-12T17:35:58.803743Z","end":"2026-04-12T17:35:58.978369Z","steps":["trace[1320834766] 'process raft request' (duration: 174.564687ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:58.978612Z","caller":"traceutil/trace.go:171","msg":"trace[387128855] transaction","detail":"{read_only:false; response_revision:5698; number_of_response:1; }","duration":"208.106298ms","start":"2026-04-12T17:35:58.770489Z","end":"2026-04-12T17:35:58.978595Z","steps":["trace[387128855] 'process raft request' (duration: 207.641726ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:58.978791Z","caller":"traceutil/trace.go:171","msg":"trace[1610578317] linearizableReadLoop","detail":"{readStateIndex:5903; appliedIndex:5899; }","duration":"176.598275ms","start":"2026-04-12T17:35:58.802172Z","end":"2026-04-12T17:35:58.978771Z","steps":["trace[1610578317] 'read index received' (duration: 109.713088ms)","trace[1610578317] 'applied index is now lower than readState.Index' (duration: 66.883167ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:35:58.97896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.556578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-12T17:35:58.979012Z","caller":"traceutil/trace.go:171","msg":"trace[835691833] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5699; }","duration":"208.64266ms","start":"2026-04-12T17:35:58.770357Z","end":"2026-04-12T17:35:58.979Z","steps":["trace[835691833] 'agreement among raft nodes before linearized reading' (duration: 208.433775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:35:58.979266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.649064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81893"} {"level":"info","ts":"2026-04-12T17:35:58.979393Z","caller":"traceutil/trace.go:171","msg":"trace[2097449855] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5699; }","duration":"209.88187ms","start":"2026-04-12T17:35:58.769489Z","end":"2026-04-12T17:35:58.979371Z","steps":["trace[2097449855] 'agreement among raft nodes before linearized reading' (duration: 209.408709ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:35:59.611318Z","caller":"traceutil/trace.go:171","msg":"trace[86207731] linearizableReadLoop","detail":"{readStateIndex:5907; appliedIndex:5906; }","duration":"148.272548ms","start":"2026-04-12T17:35:59.463009Z","end":"2026-04-12T17:35:59.611281Z","steps":["trace[86207731] 'read index received' (duration: 114.317228ms)","trace[86207731] 'applied index is now lower than readState.Index' (duration: 33.95371ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:35:59.611395Z","caller":"traceutil/trace.go:171","msg":"trace[1807810328] transaction","detail":"{read_only:false; response_revision:5702; number_of_response:1; }","duration":"154.999169ms","start":"2026-04-12T17:35:59.456349Z","end":"2026-04-12T17:35:59.611348Z","steps":["trace[1807810328] 'process raft request' (duration: 121.115ms)","trace[1807810328] 'compare' (duration: 33.643723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:35:59.611619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.575515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-12T17:35:59.611689Z","caller":"traceutil/trace.go:171","msg":"trace[1721340958] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5702; }","duration":"148.663188ms","start":"2026-04-12T17:35:59.463004Z","end":"2026-04-12T17:35:59.611667Z","steps":["trace[1721340958] 'agreement among raft nodes before linearized reading' (duration: 148.420962ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:36:45.385491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-04-12T17:36:45.48468Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"97.808451ms","hash":154505369,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":31080448,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-12T17:36:45.484814Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":154505369,"revision":3025,"compact-revision":-1} {"level":"info","ts":"2026-04-12T17:36:47.051902Z","caller":"traceutil/trace.go:171","msg":"trace[1255047703] transaction","detail":"{read_only:false; response_revision:6081; number_of_response:1; }","duration":"122.002028ms","start":"2026-04-12T17:36:46.929867Z","end":"2026-04-12T17:36:47.051869Z","steps":["trace[1255047703] 'process raft request' (duration: 121.879895ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:36:59.208931Z","caller":"traceutil/trace.go:171","msg":"trace[607239178] transaction","detail":"{read_only:false; response_revision:6172; number_of_response:1; }","duration":"131.489973ms","start":"2026-04-12T17:36:59.077409Z","end":"2026-04-12T17:36:59.208899Z","steps":["trace[607239178] 'process raft request' (duration: 78.290336ms)","trace[607239178] 'compare' (duration: 53.027243ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:36:59.209419Z","caller":"traceutil/trace.go:171","msg":"trace[1571142257] transaction","detail":"{read_only:false; response_revision:6173; number_of_response:1; }","duration":"120.691366ms","start":"2026-04-12T17:36:59.088694Z","end":"2026-04-12T17:36:59.209385Z","steps":["trace[1571142257] 'process raft request' (duration: 120.161333ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:41:45.408598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6074} {"level":"info","ts":"2026-04-12T17:41:45.516888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6074,"took":"106.609644ms","hash":4094197959,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":21831680,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-12T17:41:45.516977Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4094197959,"revision":6074,"compact-revision":3025} {"level":"info","ts":"2026-04-12T17:42:01.109985Z","caller":"traceutil/trace.go:171","msg":"trace[1302626443] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"651.858964ms","start":"2026-04-12T17:42:00.458095Z","end":"2026-04-12T17:42:01.109954Z","steps":["trace[1302626443] 'process raft request' (duration: 651.591068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.110169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:00.458065Z","time spent":"652.017208ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:42:01.112392Z","caller":"traceutil/trace.go:171","msg":"trace[691346082] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"634.84414ms","start":"2026-04-12T17:42:00.477527Z","end":"2026-04-12T17:42:01.112371Z","steps":["trace[691346082] 'process raft request' (duration: 634.655915ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:01.112375Z","caller":"traceutil/trace.go:171","msg":"trace[154761805] linearizableReadLoop","detail":"{readStateIndex:8696; appliedIndex:8693; }","duration":"336.849366ms","start":"2026-04-12T17:42:00.775497Z","end":"2026-04-12T17:42:01.112347Z","steps":["trace[154761805] 'read index received' (duration: 334.257055ms)","trace[154761805] 'applied index is now lower than readState.Index' (duration: 2.591081ms)"],"step_count":2} {"level":"warn","ts":"2026-04-12T17:42:01.112534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:00.47751Z","time spent":"634.935093ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:42:01.112515Z","caller":"traceutil/trace.go:171","msg":"trace[566498371] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"634.161144ms","start":"2026-04-12T17:42:00.47831Z","end":"2026-04-12T17:42:01.112471Z","steps":["trace[566498371] 'process raft request' (duration: 633.98988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.112581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.077091ms","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-04-12T17:42:01.112624Z","caller":"traceutil/trace.go:171","msg":"trace[100921422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8403; }","duration":"337.168815ms","start":"2026-04-12T17:42:00.775446Z","end":"2026-04-12T17:42:01.112615Z","steps":["trace[100921422] 'agreement among raft nodes before linearized reading' (duration: 336.97887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.112657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:00.775421Z","time spent":"337.225735ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-12T17:42:01.112646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:00.478279Z","time spent":"634.310527ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:42:01.112708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.089619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-12T17:42:01.112731Z","caller":"traceutil/trace.go:171","msg":"trace[940157945] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8403; }","duration":"238.1345ms","start":"2026-04-12T17:42:00.874589Z","end":"2026-04-12T17:42:01.112724Z","steps":["trace[940157945] 'agreement among raft nodes before linearized reading' (duration: 238.057798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.112744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.570041ms","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-04-12T17:42:01.112811Z","caller":"traceutil/trace.go:171","msg":"trace[504770660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8403; }","duration":"270.663343ms","start":"2026-04-12T17:42:00.842111Z","end":"2026-04-12T17:42:01.112774Z","steps":["trace[504770660] 'agreement among raft nodes before linearized reading' (duration: 270.51731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.112862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.992331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-12T17:42:01.11291Z","caller":"traceutil/trace.go:171","msg":"trace[790908551] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8403; }","duration":"165.085873ms","start":"2026-04-12T17:42:00.947811Z","end":"2026-04-12T17:42:01.112897Z","steps":["trace[790908551] 'agreement among raft nodes before linearized reading' (duration: 164.93085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:01.112873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.13131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:42:01.112983Z","caller":"traceutil/trace.go:171","msg":"trace[1967472660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8403; }","duration":"246.295404ms","start":"2026-04-12T17:42:00.866662Z","end":"2026-04-12T17:42:01.112958Z","steps":["trace[1967472660] 'agreement among raft nodes before linearized reading' (duration: 246.038558ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:13.361121Z","caller":"traceutil/trace.go:171","msg":"trace[573228153] transaction","detail":"{read_only:false; response_revision:8462; number_of_response:1; }","duration":"207.318499ms","start":"2026-04-12T17:42:13.153779Z","end":"2026-04-12T17:42:13.361098Z","steps":["trace[573228153] 'process raft request' (duration: 207.133604ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:13.414688Z","caller":"traceutil/trace.go:171","msg":"trace[1944576052] linearizableReadLoop","detail":"{readStateIndex:8759; appliedIndex:8756; }","duration":"226.30356ms","start":"2026-04-12T17:42:13.18836Z","end":"2026-04-12T17:42:13.414664Z","steps":["trace[1944576052] 'read index received' (duration: 172.589613ms)","trace[1944576052] 'applied index is now lower than readState.Index' (duration: 53.712827ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:42:13.414811Z","caller":"traceutil/trace.go:171","msg":"trace[1249899458] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"252.340429ms","start":"2026-04-12T17:42:13.162453Z","end":"2026-04-12T17:42:13.414794Z","steps":["trace[1249899458] 'process raft request' (duration: 209.587373ms)","trace[1249899458] 'compare' (duration: 42.386978ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:42:13.415091Z","caller":"traceutil/trace.go:171","msg":"trace[1852536899] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"245.929047ms","start":"2026-04-12T17:42:13.169135Z","end":"2026-04-12T17:42:13.415064Z","steps":["trace[1852536899] 'process raft request' (duration: 245.441955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:13.415362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.970607ms","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":"warn","ts":"2026-04-12T17:42:13.415373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.007758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-27gxh\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-12T17:42:13.415419Z","caller":"traceutil/trace.go:171","msg":"trace[356977180] range","detail":"{range_begin:/registry/pods/openstack/keepalived-27gxh; range_end:; response_count:1; response_revision:8465; }","duration":"206.080959ms","start":"2026-04-12T17:42:13.209329Z","end":"2026-04-12T17:42:13.415409Z","steps":["trace[356977180] 'agreement among raft nodes before linearized reading' (duration: 205.944006ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:13.415419Z","caller":"traceutil/trace.go:171","msg":"trace[2137221127] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8465; }","duration":"222.067059ms","start":"2026-04-12T17:42:13.193339Z","end":"2026-04-12T17:42:13.415406Z","steps":["trace[2137221127] 'agreement among raft nodes before linearized reading' (duration: 221.842803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:13.41546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.092469ms","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-04-12T17:42:13.41553Z","caller":"traceutil/trace.go:171","msg":"trace[1204416325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8465; }","duration":"227.195951ms","start":"2026-04-12T17:42:13.188317Z","end":"2026-04-12T17:42:13.415513Z","steps":["trace[1204416325] 'agreement among raft nodes before linearized reading' (duration: 226.71129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:13.415602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.943932ms","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-04-12T17:42:13.415724Z","caller":"traceutil/trace.go:171","msg":"trace[1024198715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8465; }","duration":"213.2484ms","start":"2026-04-12T17:42:13.202457Z","end":"2026-04-12T17:42:13.415706Z","steps":["trace[1024198715] 'agreement among raft nodes before linearized reading' (duration: 212.83586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:13.41611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.743134ms","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-04-12T17:42:13.416167Z","caller":"traceutil/trace.go:171","msg":"trace[401037495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8464; }","duration":"227.843437ms","start":"2026-04-12T17:42:13.188308Z","end":"2026-04-12T17:42:13.416151Z","steps":["trace[401037495] 'agreement among raft nodes before linearized reading' (duration: 226.622378ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:45.649483Z","caller":"traceutil/trace.go:171","msg":"trace[363569877] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"172.579703ms","start":"2026-04-12T17:42:45.476882Z","end":"2026-04-12T17:42:45.649462Z","steps":["trace[363569877] 'process raft request' (duration: 172.44399ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:45.850504Z","caller":"traceutil/trace.go:171","msg":"trace[1650157127] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8994; }","duration":"216.342623ms","start":"2026-04-12T17:42:45.634138Z","end":"2026-04-12T17:42:45.850481Z","steps":["trace[1650157127] 'read index received' (duration: 15.255463ms)","trace[1650157127] 'applied index is now lower than readState.Index' (duration: 201.08635ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:42:45.850716Z","caller":"traceutil/trace.go:171","msg":"trace[755273572] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"313.508093ms","start":"2026-04-12T17:42:45.537174Z","end":"2026-04-12T17:42:45.850682Z","steps":["trace[755273572] 'process raft request' (duration: 313.269507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.850875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:45.537146Z","time spent":"313.647296ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-12T17:42:45.850879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.728042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-12T17:42:45.850909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.693857ms","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-04-12T17:42:45.850931Z","caller":"traceutil/trace.go:171","msg":"trace[336473821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8694; }","duration":"216.826685ms","start":"2026-04-12T17:42:45.63409Z","end":"2026-04-12T17:42:45.850917Z","steps":["trace[336473821] 'agreement among raft nodes before linearized reading' (duration: 216.64357ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:45.850984Z","caller":"traceutil/trace.go:171","msg":"trace[1399153128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8694; }","duration":"212.8417ms","start":"2026-04-12T17:42:45.638125Z","end":"2026-04-12T17:42:45.850966Z","steps":["trace[1399153128] 'agreement among raft nodes before linearized reading' (duration: 212.598494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.851015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.526096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-27gxh\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-12T17:42:45.851058Z","caller":"traceutil/trace.go:171","msg":"trace[892102177] range","detail":"{range_begin:/registry/pods/openstack/keepalived-27gxh; range_end:; response_count:1; response_revision:8694; }","duration":"205.581527ms","start":"2026-04-12T17:42:45.645465Z","end":"2026-04-12T17:42:45.851047Z","steps":["trace[892102177] 'agreement among raft nodes before linearized reading' (duration: 205.481724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.85112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.448636ms","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-04-12T17:42:45.851156Z","caller":"traceutil/trace.go:171","msg":"trace[139900306] transaction","detail":"{read_only:false; response_revision:8692; number_of_response:1; }","duration":"323.041709ms","start":"2026-04-12T17:42:45.528107Z","end":"2026-04-12T17:42:45.851149Z","steps":["trace[139900306] 'process raft request' (duration: 322.124617ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:45.851164Z","caller":"traceutil/trace.go:171","msg":"trace[755210411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8694; }","duration":"211.515108ms","start":"2026-04-12T17:42:45.639638Z","end":"2026-04-12T17:42:45.851153Z","steps":["trace[755210411] 'agreement among raft nodes before linearized reading' (duration: 211.419866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.851119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.231178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-12T17:42:45.85113Z","caller":"traceutil/trace.go:171","msg":"trace[351417411] transaction","detail":"{read_only:false; response_revision:8693; number_of_response:1; }","duration":"318.341647ms","start":"2026-04-12T17:42:45.532777Z","end":"2026-04-12T17:42:45.851119Z","steps":["trace[351417411] 'process raft request' (duration: 317.62971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.851252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:45.528074Z","time spent":"323.112161ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:42:45.851257Z","caller":"traceutil/trace.go:171","msg":"trace[1596626979] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8694; }","duration":"210.420882ms","start":"2026-04-12T17:42:45.640808Z","end":"2026-04-12T17:42:45.851229Z","steps":["trace[1596626979] 'agreement among raft nodes before linearized reading' (duration: 210.027733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:45.851289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-12T17:42:45.532762Z","time spent":"318.505481ms","remote":"127.0.0.1:40786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-12T17:42:46.070671Z","caller":"traceutil/trace.go:171","msg":"trace[840676637] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"212.035651ms","start":"2026-04-12T17:42:45.858608Z","end":"2026-04-12T17:42:46.070644Z","steps":["trace[840676637] 'process raft request' (duration: 211.9828ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:46.071023Z","caller":"traceutil/trace.go:171","msg":"trace[361388195] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"212.41873ms","start":"2026-04-12T17:42:45.858587Z","end":"2026-04-12T17:42:46.071006Z","steps":["trace[361388195] 'process raft request' (duration: 211.851896ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:46.084764Z","caller":"traceutil/trace.go:171","msg":"trace[844709651] linearizableReadLoop","detail":"{readStateIndex:9002; appliedIndex:8998; }","duration":"219.919668ms","start":"2026-04-12T17:42:45.864821Z","end":"2026-04-12T17:42:46.084741Z","steps":["trace[844709651] 'read index received' (duration: 205.71326ms)","trace[844709651] 'applied index is now lower than readState.Index' (duration: 14.205488ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:42:46.084832Z","caller":"traceutil/trace.go:171","msg":"trace[1839932142] transaction","detail":"{read_only:false; response_revision:8698; number_of_response:1; }","duration":"223.932293ms","start":"2026-04-12T17:42:45.860868Z","end":"2026-04-12T17:42:46.0848Z","steps":["trace[1839932142] 'process raft request' (duration: 223.837451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-12T17:42:46.084925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.091352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-12T17:42:46.084955Z","caller":"traceutil/trace.go:171","msg":"trace[448113415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8698; }","duration":"220.182914ms","start":"2026-04-12T17:42:45.864764Z","end":"2026-04-12T17:42:46.084947Z","steps":["trace[448113415] 'agreement among raft nodes before linearized reading' (duration: 220.062061ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:46.085084Z","caller":"traceutil/trace.go:171","msg":"trace[1848673840] transaction","detail":"{read_only:false; response_revision:8697; number_of_response:1; }","duration":"225.781907ms","start":"2026-04-12T17:42:45.859278Z","end":"2026-04-12T17:42:46.08506Z","steps":["trace[1848673840] 'process raft request' (duration: 225.288596ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:56.062994Z","caller":"traceutil/trace.go:171","msg":"trace[2146936724] transaction","detail":"{read_only:false; response_revision:8794; number_of_response:1; }","duration":"117.045592ms","start":"2026-04-12T17:42:55.945919Z","end":"2026-04-12T17:42:56.062965Z","steps":["trace[2146936724] 'process raft request' (duration: 116.863038ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:42:56.350547Z","caller":"traceutil/trace.go:171","msg":"trace[771286215] transaction","detail":"{read_only:false; response_revision:8797; number_of_response:1; }","duration":"173.685579ms","start":"2026-04-12T17:42:56.176832Z","end":"2026-04-12T17:42:56.350517Z","steps":["trace[771286215] 'process raft request' (duration: 115.030084ms)","trace[771286215] 'compare' (duration: 58.415009ms)"],"step_count":2} {"level":"info","ts":"2026-04-12T17:42:56.350665Z","caller":"traceutil/trace.go:171","msg":"trace[1555657442] transaction","detail":"{read_only:false; response_revision:8798; number_of_response:1; }","duration":"173.31943ms","start":"2026-04-12T17:42:56.177309Z","end":"2026-04-12T17:42:56.350629Z","steps":["trace[1555657442] 'process raft request' (duration: 173.146696ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:43:29.404224Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024df.wal"} {"level":"info","ts":"2026-04-12T17:44:00.617668Z","caller":"traceutil/trace.go:171","msg":"trace[319670267] transaction","detail":"{read_only:false; response_revision:9472; number_of_response:1; }","duration":"129.765625ms","start":"2026-04-12T17:44:00.487861Z","end":"2026-04-12T17:44:00.617627Z","steps":["trace[319670267] 'process raft request' (duration: 129.511828ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:44:13.37788Z","caller":"traceutil/trace.go:171","msg":"trace[682107893] transaction","detail":"{read_only:false; response_revision:9545; number_of_response:1; }","duration":"248.768213ms","start":"2026-04-12T17:44:13.129089Z","end":"2026-04-12T17:44:13.377857Z","steps":["trace[682107893] 'process raft request' (duration: 248.608369ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:44:27.824388Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e10bb51ed7578852","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-12T17:44:27.82926Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-12T17:44:27.829383Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-12T17:46:33.172073Z","caller":"traceutil/trace.go:171","msg":"trace[1992141420] transaction","detail":"{read_only:false; response_revision:10609; number_of_response:1; }","duration":"103.173208ms","start":"2026-04-12T17:46:33.068874Z","end":"2026-04-12T17:46:33.172047Z","steps":["trace[1992141420] 'process raft request' (duration: 102.43177ms)"],"step_count":1} {"level":"info","ts":"2026-04-12T17:46:45.426653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8186} {"level":"info","ts":"2026-04-12T17:46:45.505516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8186,"took":"76.70923ms","hash":711658406,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":29163520,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-12T17:46:45.505613Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":711658406,"revision":8186,"compact-revision":6074} {"level":"info","ts":"2026-04-12T17:51:45.433097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10706} {"level":"info","ts":"2026-04-12T17:51:45.515476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10706,"took":"79.925222ms","hash":3692371906,"current-db-size-bytes":57606144,"current-db-size":"58 MB","current-db-size-in-use-bytes":21987328,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-12T17:51:45.515535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3692371906,"revision":10706,"compact-revision":8186}