{"level":"warn","ts":"2026-09-19T06:02:47.810373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T06:02:47.810478Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.25: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.25:2380","--initial-cluster=instance=https://162.253.55.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-19T06:02:47.810565Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-19T06:02:47.810578Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-09-19T06:02:47.8106Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T06:02:47.811251Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"]} {"level":"info","ts":"2026-09-19T06:02:47.811327Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-19T06:02:47.817228Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.687937ms"} {"level":"info","ts":"2026-09-19T06:02:47.826635Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"afeb1bf8b692f9e8","cluster-id":"6bfcc13baae99738"} {"level":"info","ts":"2026-09-19T06:02:47.826729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T06:02:47.826749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 0"} {"level":"info","ts":"2026-09-19T06:02:47.82678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft afeb1bf8b692f9e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T06:02:47.826803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became follower at term 1"} {"level":"info","ts":"2026-09-19T06:02:47.826885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"warn","ts":"2026-09-19T06:02:47.837049Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T06:02:47.838615Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T06:02:47.83991Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-19T06:02:47.842128Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"afeb1bf8b692f9e8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T06:02:47.845799Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"afeb1bf8b692f9e8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T06:02:47.845886Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T06:02:47.845987Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T06:02:47.846013Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-19T06:02:47.846349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 switched to configuration voters=(12676256331193317864)"} {"level":"info","ts":"2026-09-19T06:02:47.846537Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","added-peer-id":"afeb1bf8b692f9e8","added-peer-peer-urls":["https://162.253.55.25:2380"]} {"level":"info","ts":"2026-09-19T06:02:47.849309Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-19T06:02:47.849491Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-09-19T06:02:47.849565Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.25:2380"} {"level":"info","ts":"2026-09-19T06:02:47.849714Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"afeb1bf8b692f9e8","initial-advertise-peer-urls":["https://162.253.55.25:2380"],"listen-peer-urls":["https://162.253.55.25:2380"],"advertise-client-urls":["https://162.253.55.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T06:02:47.849776Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T06:02:48.028096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T06:02:48.028153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T06:02:48.028174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgPreVoteResp from afeb1bf8b692f9e8 at term 1"} {"level":"info","ts":"2026-09-19T06:02:48.028197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became candidate at term 2"} {"level":"info","ts":"2026-09-19T06:02:48.028204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 received MsgVoteResp from afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-09-19T06:02:48.028212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"afeb1bf8b692f9e8 became leader at term 2"} {"level":"info","ts":"2026-09-19T06:02:48.028219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: afeb1bf8b692f9e8 elected leader afeb1bf8b692f9e8 at term 2"} {"level":"info","ts":"2026-09-19T06:02:48.028965Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:02:48.029621Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"afeb1bf8b692f9e8","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.25:2379]}","request-path":"/0/members/afeb1bf8b692f9e8/attributes","cluster-id":"6bfcc13baae99738","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T06:02:48.029773Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:02:48.030365Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6bfcc13baae99738","local-member-id":"afeb1bf8b692f9e8","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:02:48.03037Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:02:48.030479Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:02:48.030501Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:02:48.031963Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.25:2379"} {"level":"info","ts":"2026-09-19T06:02:48.032658Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T06:02:48.03271Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T06:02:48.03271Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T06:02:52.3372Z","caller":"traceutil/trace.go:171","msg":"trace[1000581159] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"289.224093ms","start":"2026-09-19T06:02:52.0479Z","end":"2026-09-19T06:02:52.337124Z","steps":["trace[1000581159] 'process raft request' (duration: 224.894212ms)","trace[1000581159] 'compare' (duration: 63.919689ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:52.337312Z","caller":"traceutil/trace.go:171","msg":"trace[203291545] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"288.972962ms","start":"2026-09-19T06:02:52.048312Z","end":"2026-09-19T06:02:52.337285Z","steps":["trace[203291545] 'process raft request' (duration: 288.56297ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:52.339492Z","caller":"traceutil/trace.go:171","msg":"trace[1383117713] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"286.685868ms","start":"2026-09-19T06:02:52.052786Z","end":"2026-09-19T06:02:52.339472Z","steps":["trace[1383117713] 'process raft request' (duration: 286.440556ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:52.339484Z","caller":"traceutil/trace.go:171","msg":"trace[862398430] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"171.055327ms","start":"2026-09-19T06:02:52.168398Z","end":"2026-09-19T06:02:52.339454Z","steps":["trace[862398430] 'process raft request' (duration: 170.947596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:52.339786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.556186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:02:52.339927Z","caller":"traceutil/trace.go:171","msg":"trace[2066308223] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:0; response_revision:210; }","duration":"281.721237ms","start":"2026-09-19T06:02:52.058186Z","end":"2026-09-19T06:02:52.339907Z","steps":["trace[2066308223] 'agreement among raft nodes before linearized reading' (duration: 281.442695ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:52.339749Z","caller":"traceutil/trace.go:171","msg":"trace[855913791] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:212; }","duration":"281.206713ms","start":"2026-09-19T06:02:52.058193Z","end":"2026-09-19T06:02:52.3394Z","steps":["trace[855913791] 'read index received' (duration: 214.612738ms)","trace[855913791] 'applied index is now lower than readState.Index' (duration: 66.592725ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:56.376827Z","caller":"traceutil/trace.go:171","msg":"trace[416142997] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"132.705033ms","start":"2026-09-19T06:02:56.244085Z","end":"2026-09-19T06:02:56.37679Z","steps":["trace[416142997] 'process raft request' (duration: 132.481141ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:56.644032Z","caller":"traceutil/trace.go:171","msg":"trace[71758400] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"259.313548ms","start":"2026-09-19T06:02:56.384695Z","end":"2026-09-19T06:02:56.644008Z","steps":["trace[71758400] 'read index received' (duration: 165.859836ms)","trace[71758400] 'applied index is now lower than readState.Index' (duration: 93.452782ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:56.644136Z","caller":"traceutil/trace.go:171","msg":"trace[780200861] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"261.22619ms","start":"2026-09-19T06:02:56.382902Z","end":"2026-09-19T06:02:56.644129Z","steps":["trace[780200861] 'process raft request' (duration: 167.665007ms)","trace[780200861] 'compare' (duration: 93.338342ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:02:56.644236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.53808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-19T06:02:56.644255Z","caller":"traceutil/trace.go:171","msg":"trace[1742137167] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"259.59564ms","start":"2026-09-19T06:02:56.384652Z","end":"2026-09-19T06:02:56.644248Z","steps":["trace[1742137167] 'agreement among raft nodes before linearized reading' (duration: 259.542349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:56.6444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.057682ms","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-09-19T06:02:56.644453Z","caller":"traceutil/trace.go:171","msg":"trace[784110916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:297; }","duration":"250.128722ms","start":"2026-09-19T06:02:56.394311Z","end":"2026-09-19T06:02:56.64444Z","steps":["trace[784110916] 'agreement among raft nodes before linearized reading' (duration: 250.041911ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:56.850979Z","caller":"traceutil/trace.go:171","msg":"trace[1802614012] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"202.327059ms","start":"2026-09-19T06:02:56.648631Z","end":"2026-09-19T06:02:56.850959Z","steps":["trace[1802614012] 'process raft request' (duration: 202.273158ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:56.851106Z","caller":"traceutil/trace.go:171","msg":"trace[864260668] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"202.905122ms","start":"2026-09-19T06:02:56.648171Z","end":"2026-09-19T06:02:56.851076Z","steps":["trace[864260668] 'process raft request' (duration: 177.284096ms)","trace[864260668] 'compare' (duration: 25.311845ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:57.101653Z","caller":"traceutil/trace.go:171","msg":"trace[194096771] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:311; }","duration":"201.909705ms","start":"2026-09-19T06:02:56.899717Z","end":"2026-09-19T06:02:57.101627Z","steps":["trace[194096771] 'read index received' (duration: 200.717817ms)","trace[194096771] 'applied index is now lower than readState.Index' (duration: 1.190678ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:57.101733Z","caller":"traceutil/trace.go:171","msg":"trace[1503439194] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"211.873115ms","start":"2026-09-19T06:02:56.889801Z","end":"2026-09-19T06:02:57.101674Z","steps":["trace[1503439194] 'process raft request' (duration: 210.600017ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.101942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.016265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-09-19T06:02:57.102025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.763561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-09-19T06:02:57.102077Z","caller":"traceutil/trace.go:171","msg":"trace[1747238488] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:300; }","duration":"150.878961ms","start":"2026-09-19T06:02:56.951185Z","end":"2026-09-19T06:02:57.102064Z","steps":["trace[1747238488] 'agreement among raft nodes before linearized reading' (duration: 150.74393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.102212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.171381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-19T06:02:57.102257Z","caller":"traceutil/trace.go:171","msg":"trace[250255965] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:300; }","duration":"198.230101ms","start":"2026-09-19T06:02:56.904016Z","end":"2026-09-19T06:02:57.102247Z","steps":["trace[250255965] 'agreement among raft nodes before linearized reading' (duration: 198.147231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.102269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.067326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-09-19T06:02:57.102235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.93161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-19T06:02:57.102342Z","caller":"traceutil/trace.go:171","msg":"trace[2115899879] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:300; }","duration":"199.156447ms","start":"2026-09-19T06:02:56.903164Z","end":"2026-09-19T06:02:57.10232Z","steps":["trace[2115899879] 'agreement among raft nodes before linearized reading' (duration: 199.050846ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.102357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.162835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-19T06:02:57.102386Z","caller":"traceutil/trace.go:171","msg":"trace[330755227] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:300; }","duration":"192.197175ms","start":"2026-09-19T06:02:56.91018Z","end":"2026-09-19T06:02:57.102377Z","steps":["trace[330755227] 'agreement among raft nodes before linearized reading' (duration: 192.152655ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:57.10236Z","caller":"traceutil/trace.go:171","msg":"trace[2070164664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:300; }","duration":"185.266032ms","start":"2026-09-19T06:02:56.917067Z","end":"2026-09-19T06:02:57.102333Z","steps":["trace[2070164664] 'agreement among raft nodes before linearized reading' (duration: 184.850749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.102473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.950833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-19T06:02:57.102525Z","caller":"traceutil/trace.go:171","msg":"trace[774328134] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:300; }","duration":"200.005233ms","start":"2026-09-19T06:02:56.902504Z","end":"2026-09-19T06:02:57.102509Z","steps":["trace[774328134] 'agreement among raft nodes before linearized reading' (duration: 199.931862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.102791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.036931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-09-19T06:02:57.102927Z","caller":"traceutil/trace.go:171","msg":"trace[1404877038] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:300; }","duration":"203.208282ms","start":"2026-09-19T06:02:56.899697Z","end":"2026-09-19T06:02:57.102906Z","steps":["trace[1404877038] 'agreement among raft nodes before linearized reading' (duration: 202.065935ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:57.103041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.320036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-19T06:02:57.10312Z","caller":"traceutil/trace.go:171","msg":"trace[977698901] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:300; }","duration":"153.431687ms","start":"2026-09-19T06:02:56.949662Z","end":"2026-09-19T06:02:57.103093Z","steps":["trace[977698901] 'agreement among raft nodes before linearized reading' (duration: 153.236826ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:57.104592Z","caller":"traceutil/trace.go:171","msg":"trace[783826413] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:300; }","duration":"202.128826ms","start":"2026-09-19T06:02:56.899847Z","end":"2026-09-19T06:02:57.101976Z","steps":["trace[783826413] 'agreement among raft nodes before linearized reading' (duration: 201.979605ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:31.09251Z","caller":"traceutil/trace.go:171","msg":"trace[311809721] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"239.379004ms","start":"2026-09-19T06:03:30.8531Z","end":"2026-09-19T06:03:31.092479Z","steps":["trace[311809721] 'process raft request' (duration: 191.029545ms)","trace[311809721] 'compare' (duration: 48.126408ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:31.09331Z","caller":"traceutil/trace.go:171","msg":"trace[1868496684] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"197.445411ms","start":"2026-09-19T06:03:30.895846Z","end":"2026-09-19T06:03:31.093291Z","steps":["trace[1868496684] 'process raft request' (duration: 197.32984ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:31.0933Z","caller":"traceutil/trace.go:171","msg":"trace[1416929194] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"235.213011ms","start":"2026-09-19T06:03:30.858067Z","end":"2026-09-19T06:03:31.09328Z","steps":["trace[1416929194] 'process raft request' (duration: 234.99123ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:31.426878Z","caller":"traceutil/trace.go:171","msg":"trace[1918330550] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"116.018067ms","start":"2026-09-19T06:03:31.310806Z","end":"2026-09-19T06:03:31.426824Z","steps":["trace[1918330550] 'process raft request' (duration: 74.750887ms)","trace[1918330550] 'compare' (duration: 40.912498ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:31.605868Z","caller":"traceutil/trace.go:171","msg":"trace[604823342] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"108.499284ms","start":"2026-09-19T06:03:31.497345Z","end":"2026-09-19T06:03:31.605844Z","steps":["trace[604823342] 'process raft request' (duration: 67.306325ms)","trace[604823342] 'compare' (duration: 40.587686ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:31.964966Z","caller":"traceutil/trace.go:171","msg":"trace[1639247423] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"113.340792ms","start":"2026-09-19T06:03:31.851603Z","end":"2026-09-19T06:03:31.964943Z","steps":["trace[1639247423] 'process raft request' (duration: 93.18378ms)","trace[1639247423] 'compare' (duration: 20.046121ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:32.932725Z","caller":"traceutil/trace.go:171","msg":"trace[531892170] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"259.465133ms","start":"2026-09-19T06:03:32.673227Z","end":"2026-09-19T06:03:32.932692Z","steps":["trace[531892170] 'read index received' (duration: 258.807989ms)","trace[531892170] 'applied index is now lower than readState.Index' (duration: 655.654µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:32.932772Z","caller":"traceutil/trace.go:171","msg":"trace[386276750] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"322.442813ms","start":"2026-09-19T06:03:32.610314Z","end":"2026-09-19T06:03:32.932757Z","steps":["trace[386276750] 'process raft request' (duration: 321.779949ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:32.932929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.678094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-09-19T06:03:32.932985Z","caller":"traceutil/trace.go:171","msg":"trace[1257155443] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:574; }","duration":"259.758894ms","start":"2026-09-19T06:03:32.6732Z","end":"2026-09-19T06:03:32.932958Z","steps":["trace[1257155443] 'agreement among raft nodes before linearized reading' (duration: 259.603713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:32.933818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:03:32.610294Z","time spent":"322.708854ms","remote":"127.0.0.1:58834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:03:32.991427Z","caller":"traceutil/trace.go:171","msg":"trace[1400936579] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"288.784256ms","start":"2026-09-19T06:03:32.702621Z","end":"2026-09-19T06:03:32.991405Z","steps":["trace[1400936579] 'process raft request' (duration: 288.548195ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:32.991755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.617827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-19T06:03:32.9918Z","caller":"traceutil/trace.go:171","msg":"trace[1911141805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"130.704317ms","start":"2026-09-19T06:03:32.861082Z","end":"2026-09-19T06:03:32.991786Z","steps":["trace[1911141805] 'agreement among raft nodes before linearized reading' (duration: 130.572606ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:37.926267Z","caller":"traceutil/trace.go:171","msg":"trace[356921023] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"118.788366ms","start":"2026-09-19T06:03:37.807457Z","end":"2026-09-19T06:03:37.926245Z","steps":["trace[356921023] 'process raft request' (duration: 118.305934ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:38.113819Z","caller":"traceutil/trace.go:171","msg":"trace[1772022535] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:629; }","duration":"104.915318ms","start":"2026-09-19T06:03:38.008879Z","end":"2026-09-19T06:03:38.113795Z","steps":["trace[1772022535] 'read index received' (duration: 72.771831ms)","trace[1772022535] 'applied index is now lower than readState.Index' (duration: 32.142497ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:38.113895Z","caller":"traceutil/trace.go:171","msg":"trace[1355275071] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"109.025732ms","start":"2026-09-19T06:03:38.004846Z","end":"2026-09-19T06:03:38.113871Z","steps":["trace[1355275071] 'process raft request' (duration: 108.896261ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:38.114124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.22031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:03:38.114157Z","caller":"traceutil/trace.go:171","msg":"trace[1809412196] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"111.352444ms","start":"2026-09-19T06:03:38.002761Z","end":"2026-09-19T06:03:38.114114Z","steps":["trace[1809412196] 'process raft request' (duration: 78.964705ms)","trace[1809412196] 'compare' (duration: 31.896046ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:38.114183Z","caller":"traceutil/trace.go:171","msg":"trace[638443888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"105.29549ms","start":"2026-09-19T06:03:38.008869Z","end":"2026-09-19T06:03:38.114164Z","steps":["trace[638443888] 'agreement among raft nodes before linearized reading' (duration: 105.058499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:38.679691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.939974ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:03:38.679804Z","caller":"traceutil/trace.go:171","msg":"trace[2007631013] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:608; }","duration":"407.067695ms","start":"2026-09-19T06:03:38.272719Z","end":"2026-09-19T06:03:38.679787Z","steps":["trace[2007631013] 'range keys from in-memory index tree' (duration: 406.907454ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:38.680484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.780122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:03:38.680671Z","caller":"traceutil/trace.go:171","msg":"trace[2023272334] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"472.015414ms","start":"2026-09-19T06:03:38.208621Z","end":"2026-09-19T06:03:38.680636Z","steps":["trace[2023272334] 'process raft request' (duration: 329.440537ms)","trace[2023272334] 'compare' (duration: 141.601451ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:03:38.682954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:03:38.208591Z","time spent":"474.234396ms","remote":"127.0.0.1:59026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:03:38.689597Z","caller":"traceutil/trace.go:171","msg":"trace[727802369] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"191.573307ms","start":"2026-09-19T06:03:38.49798Z","end":"2026-09-19T06:03:38.689554Z","steps":["trace[727802369] 'process raft request' (duration: 187.918307ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:55.411583Z","caller":"traceutil/trace.go:171","msg":"trace[579440209] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"314.571687ms","start":"2026-09-19T06:03:55.096985Z","end":"2026-09-19T06:03:55.411557Z","steps":["trace[579440209] 'read index received' (duration: 314.301965ms)","trace[579440209] 'applied index is now lower than readState.Index' (duration: 268.482µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:55.41164Z","caller":"traceutil/trace.go:171","msg":"trace[1203589555] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"344.416137ms","start":"2026-09-19T06:03:55.067169Z","end":"2026-09-19T06:03:55.411585Z","steps":["trace[1203589555] 'process raft request' (duration: 344.228659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:55.411815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:03:55.067142Z","time spent":"344.586745ms","remote":"127.0.0.1:58932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:03:55.41191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.910522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-19T06:03:55.411954Z","caller":"traceutil/trace.go:171","msg":"trace[1994971848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:777; }","duration":"315.024327ms","start":"2026-09-19T06:03:55.096918Z","end":"2026-09-19T06:03:55.411942Z","steps":["trace[1994971848] 'agreement among raft nodes before linearized reading' (duration: 314.776186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:55.411989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:03:55.09689Z","time spent":"315.09147ms","remote":"127.0.0.1:59026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-19T06:03:55.412112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.17188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-19T06:03:55.413847Z","caller":"traceutil/trace.go:171","msg":"trace[2109442415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:777; }","duration":"194.431392ms","start":"2026-09-19T06:03:55.217796Z","end":"2026-09-19T06:03:55.412228Z","steps":["trace[2109442415] 'agreement among raft nodes before linearized reading' (duration: 193.985602ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:04.960217Z","caller":"traceutil/trace.go:171","msg":"trace[62663820] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"107.434693ms","start":"2026-09-19T06:04:04.852712Z","end":"2026-09-19T06:04:04.960147Z","steps":["trace[62663820] 'process raft request' (duration: 95.078225ms)","trace[62663820] 'compare' (duration: 11.924521ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:04.960231Z","caller":"traceutil/trace.go:171","msg":"trace[2084176572] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"107.452663ms","start":"2026-09-19T06:04:04.852751Z","end":"2026-09-19T06:04:04.960203Z","steps":["trace[2084176572] 'process raft request' (duration: 107.225054ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.002615Z","caller":"traceutil/trace.go:171","msg":"trace[878311398] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:904; }","duration":"124.23972ms","start":"2026-09-19T06:04:04.878343Z","end":"2026-09-19T06:04:05.002583Z","steps":["trace[878311398] 'read index received' (duration: 69.486692ms)","trace[878311398] 'applied index is now lower than readState.Index' (duration: 54.751568ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:05.002726Z","caller":"traceutil/trace.go:171","msg":"trace[27401409] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"132.267964ms","start":"2026-09-19T06:04:04.870415Z","end":"2026-09-19T06:04:05.002683Z","steps":["trace[27401409] 'process raft request' (duration: 132.001354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:04:05.002985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.610465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-19T06:04:05.003058Z","caller":"traceutil/trace.go:171","msg":"trace[1889998430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:878; }","duration":"124.706039ms","start":"2026-09-19T06:04:04.878338Z","end":"2026-09-19T06:04:05.003044Z","steps":["trace[1889998430] 'agreement among raft nodes before linearized reading' (duration: 124.395946ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.137641Z","caller":"traceutil/trace.go:171","msg":"trace[747105452] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"127.738182ms","start":"2026-09-19T06:04:05.009862Z","end":"2026-09-19T06:04:05.137601Z","steps":["trace[747105452] 'process raft request' (duration: 113.89754ms)","trace[747105452] 'compare' (duration: 13.648544ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:05.138004Z","caller":"traceutil/trace.go:171","msg":"trace[834693555] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"125.66792ms","start":"2026-09-19T06:04:05.012297Z","end":"2026-09-19T06:04:05.137965Z","steps":["trace[834693555] 'process raft request' (duration: 125.230202ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.138198Z","caller":"traceutil/trace.go:171","msg":"trace[1253951302] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"125.049054ms","start":"2026-09-19T06:04:05.013138Z","end":"2026-09-19T06:04:05.138187Z","steps":["trace[1253951302] 'process raft request' (duration: 124.787994ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.138353Z","caller":"traceutil/trace.go:171","msg":"trace[817777249] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"123.361838ms","start":"2026-09-19T06:04:05.01498Z","end":"2026-09-19T06:04:05.138342Z","steps":["trace[817777249] 'process raft request' (duration: 123.115118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:04:05.138655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.186001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-vs8pr\" ","response":"range_response_count:1 size:4868"} {"level":"info","ts":"2026-09-19T06:04:05.138711Z","caller":"traceutil/trace.go:171","msg":"trace[2100176297] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-vs8pr; range_end:; response_count:1; response_revision:883; }","duration":"115.300106ms","start":"2026-09-19T06:04:05.023396Z","end":"2026-09-19T06:04:05.138696Z","steps":["trace[2100176297] 'agreement among raft nodes before linearized reading' (duration: 115.119929ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.138318Z","caller":"traceutil/trace.go:171","msg":"trace[186330072] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:909; }","duration":"114.849468ms","start":"2026-09-19T06:04:05.023449Z","end":"2026-09-19T06:04:05.138299Z","steps":["trace[186330072] 'read index received' (duration: 100.34419ms)","trace[186330072] 'applied index is now lower than readState.Index' (duration: 14.504148ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:05.17651Z","caller":"traceutil/trace.go:171","msg":"trace[665394528] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"149.390106ms","start":"2026-09-19T06:04:05.027095Z","end":"2026-09-19T06:04:05.176486Z","steps":["trace[665394528] 'process raft request' (duration: 149.25271ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.176576Z","caller":"traceutil/trace.go:171","msg":"trace[922401311] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"152.581913ms","start":"2026-09-19T06:04:05.023966Z","end":"2026-09-19T06:04:05.176548Z","steps":["trace[922401311] 'process raft request' (duration: 152.25938ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.248023Z","caller":"traceutil/trace.go:171","msg":"trace[204756002] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"107.039067ms","start":"2026-09-19T06:04:05.140937Z","end":"2026-09-19T06:04:05.247976Z","steps":["trace[204756002] 'process raft request' (duration: 102.379401ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:10.484062Z","caller":"traceutil/trace.go:171","msg":"trace[1201272726] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"109.289091ms","start":"2026-09-19T06:04:10.374722Z","end":"2026-09-19T06:04:10.484011Z","steps":["trace[1201272726] 'process raft request' (duration: 109.062033ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:27.537713Z","caller":"traceutil/trace.go:171","msg":"trace[1344274294] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"184.548058ms","start":"2026-09-19T06:04:27.353123Z","end":"2026-09-19T06:04:27.537671Z","steps":["trace[1344274294] 'process raft request' (duration: 184.305311ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:27.537681Z","caller":"traceutil/trace.go:171","msg":"trace[1320495261] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1218; }","duration":"151.495037ms","start":"2026-09-19T06:04:27.386145Z","end":"2026-09-19T06:04:27.53764Z","steps":["trace[1320495261] 'read index received' (duration: 151.174527ms)","trace[1320495261] 'applied index is now lower than readState.Index' (duration: 318.78µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:04:27.537846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.683253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:04:27.537938Z","caller":"traceutil/trace.go:171","msg":"trace[1852030445] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1184; }","duration":"151.823997ms","start":"2026-09-19T06:04:27.386092Z","end":"2026-09-19T06:04:27.537916Z","steps":["trace[1852030445] 'agreement among raft nodes before linearized reading' (duration: 151.673812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:17.378184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.904071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:05:17.378493Z","caller":"traceutil/trace.go:171","msg":"trace[1535050216] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"491.887477ms","start":"2026-09-19T06:05:16.886556Z","end":"2026-09-19T06:05:17.378444Z","steps":["trace[1535050216] 'process raft request' (duration: 299.598489ms)","trace[1535050216] 'compare' (duration: 191.764948ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:17.378796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:05:16.886544Z","time spent":"492.108713ms","remote":"127.0.0.1:59026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:05:17.378716Z","caller":"traceutil/trace.go:171","msg":"trace[284889768] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"362.920067ms","start":"2026-09-19T06:05:17.015768Z","end":"2026-09-19T06:05:17.378688Z","steps":["trace[284889768] 'read index received' (duration: 170.256432ms)","trace[284889768] 'applied index is now lower than readState.Index' (duration: 192.660665ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:17.379026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.259484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:17.379127Z","caller":"traceutil/trace.go:171","msg":"trace[1964610789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1867; }","duration":"363.371536ms","start":"2026-09-19T06:05:17.015709Z","end":"2026-09-19T06:05:17.37908Z","steps":["trace[1964610789] 'agreement among raft nodes before linearized reading' (duration: 363.239233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:17.379184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:05:17.01567Z","time spent":"363.501529ms","remote":"127.0.0.1:58800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-19T06:05:17.379389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.999932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14dd48fa-03bf-44c1-b681-db11b4c13f25\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-19T06:05:17.379453Z","caller":"traceutil/trace.go:171","msg":"trace[1199411033] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-14dd48fa-03bf-44c1-b681-db11b4c13f25; range_end:; response_count:1; response_revision:1867; }","duration":"245.109974ms","start":"2026-09-19T06:05:17.134324Z","end":"2026-09-19T06:05:17.379434Z","steps":["trace[1199411033] 'agreement among raft nodes before linearized reading' (duration: 244.698346ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:56.448278Z","caller":"traceutil/trace.go:171","msg":"trace[697521196] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"111.55466ms","start":"2026-09-19T06:05:56.336685Z","end":"2026-09-19T06:05:56.44824Z","steps":["trace[697521196] 'process raft request' (duration: 102.716974ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:56.936675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.296837ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-19T06:05:56.937107Z","caller":"traceutil/trace.go:171","msg":"trace[269567847] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2213; }","duration":"264.696595ms","start":"2026-09-19T06:05:56.672385Z","end":"2026-09-19T06:05:56.937081Z","steps":["trace[269567847] 'read index received' (duration: 3.974571ms)","trace[269567847] 'applied index is now lower than readState.Index' (duration: 260.719634ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:56.937369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.943839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:56.937495Z","caller":"traceutil/trace.go:171","msg":"trace[660923798] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2132; }","duration":"265.095782ms","start":"2026-09-19T06:05:56.672344Z","end":"2026-09-19T06:05:56.93744Z","steps":["trace[660923798] 'agreement among raft nodes before linearized reading' (duration: 264.898279ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:06:56.463042Z","caller":"traceutil/trace.go:171","msg":"trace[1592064104] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"107.127006ms","start":"2026-09-19T06:06:56.355891Z","end":"2026-09-19T06:06:56.463018Z","steps":["trace[1592064104] 'process raft request' (duration: 107.020685ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:06:57.056127Z","caller":"traceutil/trace.go:171","msg":"trace[684687047] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"251.950894ms","start":"2026-09-19T06:06:56.804155Z","end":"2026-09-19T06:06:57.056106Z","steps":["trace[684687047] 'process raft request' (duration: 251.775822ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:28.719743Z","caller":"traceutil/trace.go:171","msg":"trace[214564296] linearizableReadLoop","detail":"{readStateIndex:2835; appliedIndex:2834; }","duration":"119.609185ms","start":"2026-09-19T06:07:28.600109Z","end":"2026-09-19T06:07:28.719719Z","steps":["trace[214564296] 'read index received' (duration: 119.352322ms)","trace[214564296] 'applied index is now lower than readState.Index' (duration: 256.003µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:28.719862Z","caller":"traceutil/trace.go:171","msg":"trace[1237453531] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"135.124783ms","start":"2026-09-19T06:07:28.584699Z","end":"2026-09-19T06:07:28.719824Z","steps":["trace[1237453531] 'process raft request' (duration: 134.87814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:28.720097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.96448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-19T06:07:28.720157Z","caller":"traceutil/trace.go:171","msg":"trace[550397271] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2733; }","duration":"120.07433ms","start":"2026-09-19T06:07:28.600067Z","end":"2026-09-19T06:07:28.720141Z","steps":["trace[550397271] 'agreement among raft nodes before linearized reading' (duration: 119.891948ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:34.244344Z","caller":"traceutil/trace.go:171","msg":"trace[261413864] linearizableReadLoop","detail":"{readStateIndex:2865; appliedIndex:2864; }","duration":"188.041441ms","start":"2026-09-19T06:07:34.056278Z","end":"2026-09-19T06:07:34.244319Z","steps":["trace[261413864] 'read index received' (duration: 183.080064ms)","trace[261413864] 'applied index is now lower than readState.Index' (duration: 4.960267ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:34.244612Z","caller":"traceutil/trace.go:171","msg":"trace[1053021826] transaction","detail":"{read_only:false; response_revision:2762; number_of_response:1; }","duration":"195.207322ms","start":"2026-09-19T06:07:34.049392Z","end":"2026-09-19T06:07:34.244599Z","steps":["trace[1053021826] 'process raft request' (duration: 190.024353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:34.244808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.747696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:07:34.244841Z","caller":"traceutil/trace.go:171","msg":"trace[876194766] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2762; }","duration":"222.822437ms","start":"2026-09-19T06:07:34.022007Z","end":"2026-09-19T06:07:34.244829Z","steps":["trace[876194766] 'agreement among raft nodes before linearized reading' (duration: 222.749596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:34.244993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.840588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:34.245051Z","caller":"traceutil/trace.go:171","msg":"trace[1848509460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2762; }","duration":"187.90935ms","start":"2026-09-19T06:07:34.057108Z","end":"2026-09-19T06:07:34.245017Z","steps":["trace[1848509460] 'agreement among raft nodes before linearized reading' (duration: 187.862679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:34.245634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.743255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-19T06:07:34.246206Z","caller":"traceutil/trace.go:171","msg":"trace[198524287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2762; }","duration":"128.901947ms","start":"2026-09-19T06:07:34.116839Z","end":"2026-09-19T06:07:34.245741Z","steps":["trace[198524287] 'agreement among raft nodes before linearized reading' (duration: 128.497812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:11:55.086039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.456825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:11:55.086731Z","caller":"traceutil/trace.go:171","msg":"trace[980318671] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"304.769825ms","start":"2026-09-19T06:11:54.781938Z","end":"2026-09-19T06:11:55.086708Z","steps":["trace[980318671] 'process raft request' (duration: 59.550554ms)","trace[980318671] 'compare' (duration: 243.622507ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:11:55.08678Z","caller":"traceutil/trace.go:171","msg":"trace[2078746811] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4928; }","duration":"222.300981ms","start":"2026-09-19T06:11:54.864444Z","end":"2026-09-19T06:11:55.086745Z","steps":["trace[2078746811] 'read index received' (duration: 75.532µs)","trace[2078746811] 'applied index is now lower than readState.Index' (duration: 222.222199ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:11:55.086838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:11:54.781918Z","time spent":"304.863867ms","remote":"127.0.0.1:59026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:11:55.08717Z","caller":"traceutil/trace.go:171","msg":"trace[985770797] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"151.616969ms","start":"2026-09-19T06:11:54.935539Z","end":"2026-09-19T06:11:55.087156Z","steps":["trace[985770797] 'process raft request' (duration: 150.631928ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:11:55.087403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.941074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:21 size:499096"} {"level":"info","ts":"2026-09-19T06:11:55.087442Z","caller":"traceutil/trace.go:171","msg":"trace[1840351121] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:21; response_revision:4750; }","duration":"223.036487ms","start":"2026-09-19T06:11:54.864394Z","end":"2026-09-19T06:11:55.087431Z","steps":["trace[1840351121] 'agreement among raft nodes before linearized reading' (duration: 222.512045ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.503022Z","caller":"traceutil/trace.go:171","msg":"trace[310943787] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"132.995619ms","start":"2026-09-19T06:11:58.370007Z","end":"2026-09-19T06:11:58.503003Z","steps":["trace[310943787] 'process raft request' (duration: 114.309753ms)","trace[310943787] 'compare' (duration: 18.444881ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:11:58.503074Z","caller":"traceutil/trace.go:171","msg":"trace[719514204] linearizableReadLoop","detail":"{readStateIndex:5002; appliedIndex:5000; }","duration":"119.461442ms","start":"2026-09-19T06:11:58.383588Z","end":"2026-09-19T06:11:58.503049Z","steps":["trace[719514204] 'read index received' (duration: 100.702875ms)","trace[719514204] 'applied index is now lower than readState.Index' (duration: 18.757427ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:11:58.503327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.399778ms","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-09-19T06:11:58.503357Z","caller":"traceutil/trace.go:171","msg":"trace[1534556969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4819; }","duration":"125.458099ms","start":"2026-09-19T06:11:58.377892Z","end":"2026-09-19T06:11:58.50335Z","steps":["trace[1534556969] 'agreement among raft nodes before linearized reading' (duration: 125.335997ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.503456Z","caller":"traceutil/trace.go:171","msg":"trace[1357715285] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"130.511077ms","start":"2026-09-19T06:11:58.372936Z","end":"2026-09-19T06:11:58.503447Z","steps":["trace[1357715285] 'process raft request' (duration: 129.905844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:11:58.510844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.824275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-19T06:11:58.510883Z","caller":"traceutil/trace.go:171","msg":"trace[1890744076] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4819; }","duration":"123.869116ms","start":"2026-09-19T06:11:58.387004Z","end":"2026-09-19T06:11:58.510873Z","steps":["trace[1890744076] 'agreement among raft nodes before linearized reading' (duration: 123.764113ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.627302Z","caller":"traceutil/trace.go:171","msg":"trace[764580570] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"116.688903ms","start":"2026-09-19T06:11:58.510586Z","end":"2026-09-19T06:11:58.627275Z","steps":["trace[764580570] 'process raft request' (duration: 114.16565ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.634806Z","caller":"traceutil/trace.go:171","msg":"trace[2051960091] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"123.236952ms","start":"2026-09-19T06:11:58.511548Z","end":"2026-09-19T06:11:58.634785Z","steps":["trace[2051960091] 'process raft request' (duration: 123.072129ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.63491Z","caller":"traceutil/trace.go:171","msg":"trace[336385695] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"123.284843ms","start":"2026-09-19T06:11:58.511603Z","end":"2026-09-19T06:11:58.634888Z","steps":["trace[336385695] 'process raft request' (duration: 123.14228ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635177Z","caller":"traceutil/trace.go:171","msg":"trace[1164591643] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"116.727284ms","start":"2026-09-19T06:11:58.518433Z","end":"2026-09-19T06:11:58.635161Z","steps":["trace[1164591643] 'process raft request' (duration: 116.431608ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635412Z","caller":"traceutil/trace.go:171","msg":"trace[789602181] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"111.294019ms","start":"2026-09-19T06:11:58.524106Z","end":"2026-09-19T06:11:58.6354Z","steps":["trace[789602181] 'process raft request' (duration: 111.012083ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635182Z","caller":"traceutil/trace.go:171","msg":"trace[447768479] linearizableReadLoop","detail":"{readStateIndex:5007; appliedIndex:5002; }","duration":"121.930414ms","start":"2026-09-19T06:11:58.513237Z","end":"2026-09-19T06:11:58.635168Z","steps":["trace[447768479] 'read index received' (duration: 111.524294ms)","trace[447768479] 'applied index is now lower than readState.Index' (duration: 10.40534ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:11:58.635543Z","caller":"traceutil/trace.go:171","msg":"trace[921600229] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"115.120039ms","start":"2026-09-19T06:11:58.520386Z","end":"2026-09-19T06:11:58.635506Z","steps":["trace[921600229] 'process raft request' (duration: 114.519457ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635526Z","caller":"traceutil/trace.go:171","msg":"trace[2078998283] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"123.689702ms","start":"2026-09-19T06:11:58.511797Z","end":"2026-09-19T06:11:58.635487Z","steps":["trace[2078998283] 'process raft request' (duration: 123.036238ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635667Z","caller":"traceutil/trace.go:171","msg":"trace[1565578263] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"124.026379ms","start":"2026-09-19T06:11:58.511634Z","end":"2026-09-19T06:11:58.63566Z","steps":["trace[1565578263] 'process raft request' (duration: 123.16621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:11:58.635904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.645619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14496"} {"level":"info","ts":"2026-09-19T06:11:58.636077Z","caller":"traceutil/trace.go:171","msg":"trace[450719404] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4828; }","duration":"122.828283ms","start":"2026-09-19T06:11:58.513235Z","end":"2026-09-19T06:11:58.636063Z","steps":["trace[450719404] 'agreement among raft nodes before linearized reading' (duration: 121.975795ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:58.635323Z","caller":"traceutil/trace.go:171","msg":"trace[152017765] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"112.476634ms","start":"2026-09-19T06:11:58.522833Z","end":"2026-09-19T06:11:58.635309Z","steps":["trace[152017765] 'process raft request' (duration: 112.105326ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:11:58.639074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.699306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:11:58.639131Z","caller":"traceutil/trace.go:171","msg":"trace[1346628753] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4828; }","duration":"118.787338ms","start":"2026-09-19T06:11:58.52033Z","end":"2026-09-19T06:11:58.639118Z","steps":["trace[1346628753] 'agreement among raft nodes before linearized reading' (duration: 118.698066ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.235233Z","caller":"traceutil/trace.go:171","msg":"trace[813050951] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"112.769054ms","start":"2026-09-19T06:12:05.122435Z","end":"2026-09-19T06:12:05.235204Z","steps":["trace[813050951] 'process raft request' (duration: 112.6027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:05.261995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.839243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-19T06:12:05.26205Z","caller":"traceutil/trace.go:171","msg":"trace[1488445606] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4903; }","duration":"121.921214ms","start":"2026-09-19T06:12:05.140117Z","end":"2026-09-19T06:12:05.262038Z","steps":["trace[1488445606] 'agreement among raft nodes before linearized reading' (duration: 121.754751ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.446182Z","caller":"traceutil/trace.go:171","msg":"trace[662205032] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5090; }","duration":"181.373436ms","start":"2026-09-19T06:12:05.264769Z","end":"2026-09-19T06:12:05.446142Z","steps":["trace[662205032] 'read index received' (duration: 170.426598ms)","trace[662205032] 'applied index is now lower than readState.Index' (duration: 10.945428ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:12:05.446249Z","caller":"traceutil/trace.go:171","msg":"trace[2084098057] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"207.159053ms","start":"2026-09-19T06:12:05.239056Z","end":"2026-09-19T06:12:05.446215Z","steps":["trace[2084098057] 'process raft request' (duration: 196.013921ms)","trace[2084098057] 'compare' (duration: 10.793615ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:12:05.44645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.635671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5cb268ce-fa18-4624-8574-cc9d3b001322\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-19T06:12:05.446753Z","caller":"traceutil/trace.go:171","msg":"trace[1344322510] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5cb268ce-fa18-4624-8574-cc9d3b001322; range_end:; response_count:1; response_revision:4904; }","duration":"181.991468ms","start":"2026-09-19T06:12:05.264743Z","end":"2026-09-19T06:12:05.446734Z","steps":["trace[1344322510] 'agreement among raft nodes before linearized reading' (duration: 181.545689ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.524131Z","caller":"traceutil/trace.go:171","msg":"trace[1810511726] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"257.124896ms","start":"2026-09-19T06:12:05.266984Z","end":"2026-09-19T06:12:05.524109Z","steps":["trace[1810511726] 'process raft request' (duration: 256.608975ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.524346Z","caller":"traceutil/trace.go:171","msg":"trace[288877576] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"256.547435ms","start":"2026-09-19T06:12:05.267789Z","end":"2026-09-19T06:12:05.524336Z","steps":["trace[288877576] 'process raft request' (duration: 255.921022ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.524803Z","caller":"traceutil/trace.go:171","msg":"trace[1020493646] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"254.328238ms","start":"2026-09-19T06:12:05.27046Z","end":"2026-09-19T06:12:05.524788Z","steps":["trace[1020493646] 'process raft request' (duration: 253.289926ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.524913Z","caller":"traceutil/trace.go:171","msg":"trace[1192480749] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"212.73052ms","start":"2026-09-19T06:12:05.31215Z","end":"2026-09-19T06:12:05.52488Z","steps":["trace[1192480749] 'process raft request' (duration: 211.666778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:05.524946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.453294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-9f4999dfb-vm8vt.18d6a417d5376e54\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-09-19T06:12:05.525205Z","caller":"traceutil/trace.go:171","msg":"trace[1822593980] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-9f4999dfb-vm8vt.18d6a417d5376e54; range_end:; response_count:1; response_revision:4908; }","duration":"259.575238ms","start":"2026-09-19T06:12:05.265431Z","end":"2026-09-19T06:12:05.525006Z","steps":["trace[1822593980] 'agreement among raft nodes before linearized reading' (duration: 259.317102ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:05.808339Z","caller":"traceutil/trace.go:171","msg":"trace[325778574] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"145.407045ms","start":"2026-09-19T06:12:05.662903Z","end":"2026-09-19T06:12:05.80831Z","steps":["trace[325778574] 'process raft request' (duration: 138.040081ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:06.063341Z","caller":"traceutil/trace.go:171","msg":"trace[563183948] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"101.859832ms","start":"2026-09-19T06:12:05.961447Z","end":"2026-09-19T06:12:06.063307Z","steps":["trace[563183948] 'process raft request' (duration: 99.444932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:09.567813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.304843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2207610d-6269-4c42-b799-ac2f4d3d9f41\" ","response":"range_response_count:1 size:3951"} {"level":"info","ts":"2026-09-19T06:12:09.567891Z","caller":"traceutil/trace.go:171","msg":"trace[1129426483] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2207610d-6269-4c42-b799-ac2f4d3d9f41; range_end:; response_count:1; response_revision:5017; }","duration":"140.426976ms","start":"2026-09-19T06:12:09.427443Z","end":"2026-09-19T06:12:09.56787Z","steps":["trace[1129426483] 'range keys from in-memory index tree' (duration: 140.13233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:09.567976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.329282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-19T06:12:09.568064Z","caller":"traceutil/trace.go:171","msg":"trace[2001380397] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5017; }","duration":"108.468424ms","start":"2026-09-19T06:12:09.459575Z","end":"2026-09-19T06:12:09.568044Z","steps":["trace[2001380397] 'range keys from in-memory index tree' (duration: 108.167419ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:17.579664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.775365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-09-19T06:12:17.579771Z","caller":"traceutil/trace.go:171","msg":"trace[608272751] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5135; }","duration":"196.969619ms","start":"2026-09-19T06:12:17.38278Z","end":"2026-09-19T06:12:17.57975Z","steps":["trace[608272751] 'range keys from in-memory index tree' (duration: 196.547321ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:12:17.57994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.841289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-19T06:12:17.580038Z","caller":"traceutil/trace.go:171","msg":"trace[1521394242] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5135; }","duration":"120.982222ms","start":"2026-09-19T06:12:17.459031Z","end":"2026-09-19T06:12:17.580013Z","steps":["trace[1521394242] 'range keys from in-memory index tree' (duration: 120.591924ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:12:48.233101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-09-19T06:12:48.317975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"83.543676ms","hash":2022311428,"current-db-size-bytes":53194752,"current-db-size":"53 MB","current-db-size-in-use-bytes":28409856,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T06:12:48.318244Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2022311428,"revision":2836,"compact-revision":-1} {"level":"info","ts":"2026-09-19T06:14:14.451758Z","caller":"traceutil/trace.go:171","msg":"trace[1575156637] transaction","detail":"{read_only:false; response_revision:6004; number_of_response:1; }","duration":"111.951567ms","start":"2026-09-19T06:14:14.339784Z","end":"2026-09-19T06:14:14.451735Z","steps":["trace[1575156637] 'process raft request' (duration: 111.903766ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:14:14.451794Z","caller":"traceutil/trace.go:171","msg":"trace[1673635223] transaction","detail":"{read_only:false; response_revision:6003; number_of_response:1; }","duration":"111.987808ms","start":"2026-09-19T06:14:14.339776Z","end":"2026-09-19T06:14:14.451764Z","steps":["trace[1673635223] 'process raft request' (duration: 111.774684ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:16:24.463161Z","caller":"traceutil/trace.go:171","msg":"trace[1867061303] transaction","detail":"{read_only:false; response_revision:6918; number_of_response:1; }","duration":"145.243906ms","start":"2026-09-19T06:16:24.317898Z","end":"2026-09-19T06:16:24.463142Z","steps":["trace[1867061303] 'process raft request' (duration: 145.134904ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:17:48.241473Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5416} {"level":"info","ts":"2026-09-19T06:17:48.325901Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5416,"took":"83.235774ms","hash":1504261973,"current-db-size-bytes":53194752,"current-db-size":"53 MB","current-db-size-in-use-bytes":18702336,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T06:17:48.325978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1504261973,"revision":5416,"compact-revision":2836} {"level":"info","ts":"2026-09-19T06:18:30.626601Z","caller":"traceutil/trace.go:171","msg":"trace[1654194354] transaction","detail":"{read_only:false; response_revision:7584; number_of_response:1; }","duration":"149.187249ms","start":"2026-09-19T06:18:30.477397Z","end":"2026-09-19T06:18:30.626584Z","steps":["trace[1654194354] 'process raft request' (duration: 149.048814ms)"],"step_count":1}