{"level":"warn","ts":"2026-09-19T16:56:48.875624Z","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-19T16:56:48.875736Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.96: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.96:2380","--initial-cluster=instance=https://162.253.55.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.96: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-19T16:56:48.87581Z","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-19T16:56:48.875817Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.96:2380"]}
{"level":"info","ts":"2026-09-19T16:56:48.875834Z","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-19T16:56:48.876471Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"]}
{"level":"info","ts":"2026-09-19T16:56:48.876547Z","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.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.96: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-19T16:56:48.882558Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.795393ms"}
{"level":"info","ts":"2026-09-19T16:56:48.894082Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"64a80de7883e6886","cluster-id":"8160e60c0578d165"}
{"level":"info","ts":"2026-09-19T16:56:48.894475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-19T16:56:48.89454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 0"}
{"level":"info","ts":"2026-09-19T16:56:48.894571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 64a80de7883e6886 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-19T16:56:48.894604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 1"}
{"level":"info","ts":"2026-09-19T16:56:48.894693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"}
{"level":"warn","ts":"2026-09-19T16:56:48.904209Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-19T16:56:48.90853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-19T16:56:48.910622Z","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-19T16:56:48.914147Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"64a80de7883e6886","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-19T16:56:48.914348Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"64a80de7883e6886","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-19T16:56:48.914471Z","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-19T16:56:48.919523Z","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-19T16:56:48.919547Z","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-19T16:56:48.920614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"}
{"level":"info","ts":"2026-09-19T16:56:48.920708Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","added-peer-id":"64a80de7883e6886","added-peer-peer-urls":["https://162.253.55.96:2380"]}
{"level":"info","ts":"2026-09-19T16:56:48.922516Z","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-19T16:56:48.922762Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"64a80de7883e6886","initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-19T16:56:48.922787Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-19T16:56:48.923271Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.96:2380"}
{"level":"info","ts":"2026-09-19T16:56:48.923285Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.96:2380"}
{"level":"info","ts":"2026-09-19T16:56:49.195551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-19T16:56:49.19566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-19T16:56:49.195705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgPreVoteResp from 64a80de7883e6886 at term 1"}
{"level":"info","ts":"2026-09-19T16:56:49.19573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became candidate at term 2"}
{"level":"info","ts":"2026-09-19T16:56:49.195742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgVoteResp from 64a80de7883e6886 at term 2"}
{"level":"info","ts":"2026-09-19T16:56:49.19576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became leader at term 2"}
{"level":"info","ts":"2026-09-19T16:56:49.195775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 64a80de7883e6886 elected leader 64a80de7883e6886 at term 2"}
{"level":"info","ts":"2026-09-19T16:56:49.19826Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-19T16:56:49.199362Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"64a80de7883e6886","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.96:2379]}","request-path":"/0/members/64a80de7883e6886/attributes","cluster-id":"8160e60c0578d165","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-19T16:56:49.199401Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-19T16:56:49.199575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-19T16:56:49.199838Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-19T16:56:49.200002Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-19T16:56:49.1999Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-19T16:56:49.200237Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-19T16:56:49.200418Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-19T16:56:49.207321Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.96:2379"}
{"level":"info","ts":"2026-09-19T16:56:49.215511Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-19T16:56:51.246528Z","caller":"traceutil/trace.go:171","msg":"trace[827054924] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"149.072716ms","start":"2026-09-19T16:56:51.097434Z","end":"2026-09-19T16:56:51.246507Z","steps":["trace[827054924] 'process raft request'  (duration: 144.86809ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:56:54.246386Z","caller":"traceutil/trace.go:171","msg":"trace[1450920888] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"130.19004ms","start":"2026-09-19T16:56:54.116108Z","end":"2026-09-19T16:56:54.246298Z","steps":["trace[1450920888] 'process raft request'  (duration: 129.930042ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:56:54.534578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.59321ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7531884150121300034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-19T16:56:54.534767Z","caller":"traceutil/trace.go:171","msg":"trace[1056366995] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"284.140712ms","start":"2026-09-19T16:56:54.250601Z","end":"2026-09-19T16:56:54.534742Z","steps":["trace[1056366995] 'process raft request'  (duration: 99.864802ms)","trace[1056366995] 'compare'  (duration: 183.439605ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:56:54.534812Z","caller":"traceutil/trace.go:171","msg":"trace[1251836339] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"281.543554ms","start":"2026-09-19T16:56:54.253196Z","end":"2026-09-19T16:56:54.53474Z","steps":["trace[1251836339] 'process raft request'  (duration: 281.491183ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:56:54.788937Z","caller":"traceutil/trace.go:171","msg":"trace[1753972997] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"249.808774ms","start":"2026-09-19T16:56:54.539099Z","end":"2026-09-19T16:56:54.788908Z","steps":["trace[1753972997] 'process raft request'  (duration: 191.019272ms)","trace[1753972997] 'compare'  (duration: 58.529154ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:56:54.789926Z","caller":"traceutil/trace.go:171","msg":"trace[1236421145] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:262; }","duration":"236.133254ms","start":"2026-09-19T16:56:54.55378Z","end":"2026-09-19T16:56:54.789913Z","steps":["trace[1236421145] 'read index received'  (duration: 176.432395ms)","trace[1236421145] 'applied index is now lower than readState.Index'  (duration: 59.696559ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T16:56:54.79006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.257637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-19T16:56:54.79012Z","caller":"traceutil/trace.go:171","msg":"trace[759467557] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:0; response_revision:259; }","duration":"236.377012ms","start":"2026-09-19T16:56:54.553733Z","end":"2026-09-19T16:56:54.79011Z","steps":["trace[759467557] 'agreement among raft nodes before linearized reading'  (duration: 236.232097ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:56:54.790163Z","caller":"traceutil/trace.go:171","msg":"trace[1754656438] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"250.995079ms","start":"2026-09-19T16:56:54.539131Z","end":"2026-09-19T16:56:54.790126Z","steps":["trace[1754656438] 'process raft request'  (duration: 250.628928ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:56:54.790302Z","caller":"traceutil/trace.go:171","msg":"trace[602394824] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"247.609107ms","start":"2026-09-19T16:56:54.542657Z","end":"2026-09-19T16:56:54.790266Z","steps":["trace[602394824] 'process raft request'  (duration: 247.194715ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:03.300455Z","caller":"traceutil/trace.go:171","msg":"trace[1821241983] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"116.213961ms","start":"2026-09-19T16:57:03.184207Z","end":"2026-09-19T16:57:03.300421Z","steps":["trace[1821241983] 'process raft request'  (duration: 115.953363ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:49.354934Z","caller":"traceutil/trace.go:171","msg":"trace[2076666600] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"165.563443ms","start":"2026-09-19T16:57:49.189307Z","end":"2026-09-19T16:57:49.35487Z","steps":["trace[2076666600] 'process raft request'  (duration: 153.240757ms)","trace[2076666600] 'compare'  (duration: 10.783339ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:57:49.360535Z","caller":"traceutil/trace.go:171","msg":"trace[1330395252] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"162.418818ms","start":"2026-09-19T16:57:49.198049Z","end":"2026-09-19T16:57:49.360468Z","steps":["trace[1330395252] 'process raft request'  (duration: 156.615681ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:49.361489Z","caller":"traceutil/trace.go:171","msg":"trace[1051708126] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:683; }","duration":"128.374118ms","start":"2026-09-19T16:57:49.233094Z","end":"2026-09-19T16:57:49.361469Z","steps":["trace[1051708126] 'read index received'  (duration: 109.469162ms)","trace[1051708126] 'applied index is now lower than readState.Index'  (duration: 18.904066ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T16:57:49.365177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.064851ms","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-19T16:57:49.365605Z","caller":"traceutil/trace.go:171","msg":"trace[1761840203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:660; }","duration":"132.544316ms","start":"2026-09-19T16:57:49.233047Z","end":"2026-09-19T16:57:49.365591Z","steps":["trace[1761840203] 'agreement among raft nodes before linearized reading'  (duration: 132.02758ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:52.956426Z","caller":"traceutil/trace.go:171","msg":"trace[922188841] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"178.620466ms","start":"2026-09-19T16:57:52.777782Z","end":"2026-09-19T16:57:52.956402Z","steps":["trace[922188841] 'process raft request'  (duration: 178.141656ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:52.959845Z","caller":"traceutil/trace.go:171","msg":"trace[1116679916] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"151.654338ms","start":"2026-09-19T16:57:52.80816Z","end":"2026-09-19T16:57:52.959814Z","steps":["trace[1116679916] 'process raft request'  (duration: 151.380062ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:55.686245Z","caller":"traceutil/trace.go:171","msg":"trace[508939735] linearizableReadLoop","detail":"{readStateIndex:766; appliedIndex:765; }","duration":"237.478587ms","start":"2026-09-19T16:57:55.448725Z","end":"2026-09-19T16:57:55.686203Z","steps":["trace[508939735] 'read index received'  (duration: 174.414728ms)","trace[508939735] 'applied index is now lower than readState.Index'  (duration: 63.062189ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:57:55.686449Z","caller":"traceutil/trace.go:171","msg":"trace[1914310051] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"238.300404ms","start":"2026-09-19T16:57:55.448107Z","end":"2026-09-19T16:57:55.686407Z","steps":["trace[1914310051] 'process raft request'  (duration: 175.101443ms)","trace[1914310051] 'compare'  (duration: 62.565127ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T16:57:55.686547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.776823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-09-19T16:57:55.686595Z","caller":"traceutil/trace.go:171","msg":"trace[347536494] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:737; }","duration":"237.902836ms","start":"2026-09-19T16:57:55.448675Z","end":"2026-09-19T16:57:55.686578Z","steps":["trace[347536494] 'agreement among raft nodes before linearized reading'  (duration: 237.762103ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:56.046033Z","caller":"traceutil/trace.go:171","msg":"trace[32128861] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"159.061542ms","start":"2026-09-19T16:57:55.886914Z","end":"2026-09-19T16:57:56.045976Z","steps":["trace[32128861] 'process raft request'  (duration: 144.060927ms)","trace[32128861] 'compare'  (duration: 14.834411ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:57:56.67896Z","caller":"traceutil/trace.go:171","msg":"trace[279197705] linearizableReadLoop","detail":"{readStateIndex:774; appliedIndex:773; }","duration":"160.12893ms","start":"2026-09-19T16:57:56.518805Z","end":"2026-09-19T16:57:56.678934Z","steps":["trace[279197705] 'read index received'  (duration: 159.906805ms)","trace[279197705] 'applied index is now lower than readState.Index'  (duration: 220.775µs)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:57:56.679044Z","caller":"traceutil/trace.go:171","msg":"trace[1839759888] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"216.746972ms","start":"2026-09-19T16:57:56.462249Z","end":"2026-09-19T16:57:56.678996Z","steps":["trace[1839759888] 'process raft request'  (duration: 216.517007ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:57:56.679095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.259383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-19T16:57:56.679287Z","caller":"traceutil/trace.go:171","msg":"trace[34382374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:745; }","duration":"160.509739ms","start":"2026-09-19T16:57:56.518765Z","end":"2026-09-19T16:57:56.679275Z","steps":["trace[34382374] 'agreement among raft nodes before linearized reading'  (duration: 160.267483ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:57:56.682004Z","caller":"traceutil/trace.go:171","msg":"trace[35232843] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"142.63082ms","start":"2026-09-19T16:57:56.539357Z","end":"2026-09-19T16:57:56.681987Z","steps":["trace[35232843] 'process raft request'  (duration: 142.366274ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:58:43.276097Z","caller":"traceutil/trace.go:171","msg":"trace[161447709] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"281.20467ms","start":"2026-09-19T16:58:42.994862Z","end":"2026-09-19T16:58:43.276066Z","steps":["trace[161447709] 'process raft request'  (duration: 281.014285ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:58:47.975361Z","caller":"traceutil/trace.go:171","msg":"trace[355726208] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"146.741706ms","start":"2026-09-19T16:58:47.828587Z","end":"2026-09-19T16:58:47.975329Z","steps":["trace[355726208] 'process raft request'  (duration: 146.448259ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:58:59.900331Z","caller":"traceutil/trace.go:171","msg":"trace[2094307550] linearizableReadLoop","detail":"{readStateIndex:1451; appliedIndex:1450; }","duration":"131.684865ms","start":"2026-09-19T16:58:59.768628Z","end":"2026-09-19T16:58:59.900312Z","steps":["trace[2094307550] 'read index received'  (duration: 131.577172ms)","trace[2094307550] 'applied index is now lower than readState.Index'  (duration: 106.583µs)"],"step_count":2}
{"level":"info","ts":"2026-09-19T16:58:59.900405Z","caller":"traceutil/trace.go:171","msg":"trace[412942915] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"132.905488ms","start":"2026-09-19T16:58:59.767473Z","end":"2026-09-19T16:58:59.900378Z","steps":["trace[412942915] 'process raft request'  (duration: 132.711463ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:58:59.900535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.88564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-78fh4\" ","response":"range_response_count:1 size:4196"}
{"level":"info","ts":"2026-09-19T16:58:59.900589Z","caller":"traceutil/trace.go:171","msg":"trace[1422070738] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-78fh4; range_end:; response_count:1; response_revision:1402; }","duration":"131.977633ms","start":"2026-09-19T16:58:59.768594Z","end":"2026-09-19T16:58:59.900572Z","steps":["trace[1422070738] 'agreement among raft nodes before linearized reading'  (duration: 131.828639ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:58:59.900713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.623798ms","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-19T16:58:59.900807Z","caller":"traceutil/trace.go:171","msg":"trace[1812659521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1402; }","duration":"123.792793ms","start":"2026-09-19T16:58:59.77699Z","end":"2026-09-19T16:58:59.900783Z","steps":["trace[1812659521] 'agreement among raft nodes before linearized reading'  (duration: 123.507265ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:08.037899Z","caller":"traceutil/trace.go:171","msg":"trace[235677465] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"113.006951ms","start":"2026-09-19T16:59:07.924791Z","end":"2026-09-19T16:59:08.037798Z","steps":["trace[235677465] 'process raft request'  (duration: 112.62371ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:08.15193Z","caller":"traceutil/trace.go:171","msg":"trace[1329138517] transaction","detail":"{read_only:false; response_revision:1531; number_of_response:1; }","duration":"109.638121ms","start":"2026-09-19T16:59:08.042264Z","end":"2026-09-19T16:59:08.151902Z","steps":["trace[1329138517] 'process raft request'  (duration: 95.232078ms)","trace[1329138517] 'compare'  (duration: 14.29934ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T16:59:33.736971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.893382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-19T16:59:33.737067Z","caller":"traceutil/trace.go:171","msg":"trace[1962386645] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1949; }","duration":"259.079768ms","start":"2026-09-19T16:59:33.477969Z","end":"2026-09-19T16:59:33.737049Z","steps":["trace[1962386645] 'count revisions from in-memory index tree'  (duration: 258.748028ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:59:33.737334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.572623ms","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-09-19T16:59:33.737356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.877326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-09-19T16:59:33.737424Z","caller":"traceutil/trace.go:171","msg":"trace[571867423] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1949; }","duration":"384.955759ms","start":"2026-09-19T16:59:33.352451Z","end":"2026-09-19T16:59:33.737407Z","steps":["trace[571867423] 'range keys from in-memory index tree'  (duration: 384.66744ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:33.737429Z","caller":"traceutil/trace.go:171","msg":"trace[178468195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1949; }","duration":"212.754507ms","start":"2026-09-19T16:59:33.524644Z","end":"2026-09-19T16:59:33.737398Z","steps":["trace[178468195] 'range keys from in-memory index tree'  (duration: 212.369317ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:59:33.73746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T16:59:33.352351Z","time spent":"385.099992ms","remote":"127.0.0.1:42590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-19T16:59:33.904298Z","caller":"traceutil/trace.go:171","msg":"trace[1342707713] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"162.400706ms","start":"2026-09-19T16:59:33.741667Z","end":"2026-09-19T16:59:33.904068Z","steps":["trace[1342707713] 'process raft request'  (duration: 162.175919ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:33.911278Z","caller":"traceutil/trace.go:171","msg":"trace[1918355415] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"142.408014ms","start":"2026-09-19T16:59:33.768848Z","end":"2026-09-19T16:59:33.911256Z","steps":["trace[1918355415] 'process raft request'  (duration: 142.287221ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:59:34.191603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.255007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-680f3f9c-3faa-4792-b077-9d736e21d043\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-09-19T16:59:34.191715Z","caller":"traceutil/trace.go:171","msg":"trace[1333803647] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-680f3f9c-3faa-4792-b077-9d736e21d043; range_end:; response_count:1; response_revision:1951; }","duration":"254.471222ms","start":"2026-09-19T16:59:33.937225Z","end":"2026-09-19T16:59:34.191696Z","steps":["trace[1333803647] 'range keys from in-memory index tree'  (duration: 254.058381ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:59:34.192154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.844138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-680f3f9c-3faa-4792-b077-9d736e21d043\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-09-19T16:59:34.192206Z","caller":"traceutil/trace.go:171","msg":"trace[983925898] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-680f3f9c-3faa-4792-b077-9d736e21d043; range_end:; response_count:1; response_revision:1951; }","duration":"236.894799ms","start":"2026-09-19T16:59:33.955298Z","end":"2026-09-19T16:59:34.192193Z","steps":["trace[983925898] 'range keys from in-memory index tree'  (duration: 235.905082ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:46.436209Z","caller":"traceutil/trace.go:171","msg":"trace[1170902372] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"196.835209ms","start":"2026-09-19T16:59:46.239311Z","end":"2026-09-19T16:59:46.436146Z","steps":["trace[1170902372] 'process raft request'  (duration: 196.689535ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:46.4461Z","caller":"traceutil/trace.go:171","msg":"trace[239043193] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2134; }","duration":"163.063262ms","start":"2026-09-19T16:59:46.283014Z","end":"2026-09-19T16:59:46.446078Z","steps":["trace[239043193] 'read index received'  (duration: 152.892374ms)","trace[239043193] 'applied index is now lower than readState.Index'  (duration: 10.169788ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T16:59:46.446577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.693696ms","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-19T16:59:46.446209Z","caller":"traceutil/trace.go:171","msg":"trace[1952339018] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"206.648848ms","start":"2026-09-19T16:59:46.239539Z","end":"2026-09-19T16:59:46.446187Z","steps":["trace[1952339018] 'process raft request'  (duration: 206.424182ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:46.446811Z","caller":"traceutil/trace.go:171","msg":"trace[1084663763] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2055; }","duration":"111.992164ms","start":"2026-09-19T16:59:46.334794Z","end":"2026-09-19T16:59:46.446787Z","steps":["trace[1084663763] 'agreement among raft nodes before linearized reading'  (duration: 111.577922ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T16:59:46.447255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.218355ms","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-19T16:59:46.448311Z","caller":"traceutil/trace.go:171","msg":"trace[1756581696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2055; }","duration":"165.313986ms","start":"2026-09-19T16:59:46.282951Z","end":"2026-09-19T16:59:46.448265Z","steps":["trace[1756581696] 'agreement among raft nodes before linearized reading'  (duration: 163.240037ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:46.561296Z","caller":"traceutil/trace.go:171","msg":"trace[70630006] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"109.463153ms","start":"2026-09-19T16:59:46.451797Z","end":"2026-09-19T16:59:46.56126Z","steps":["trace[70630006] 'process raft request'  (duration: 103.654588ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T16:59:46.562723Z","caller":"traceutil/trace.go:171","msg":"trace[907160961] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"110.178433ms","start":"2026-09-19T16:59:46.452486Z","end":"2026-09-19T16:59:46.562665Z","steps":["trace[907160961] 'process raft request'  (duration: 108.691141ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:00:12.666742Z","caller":"traceutil/trace.go:171","msg":"trace[900242293] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"118.990275ms","start":"2026-09-19T17:00:12.547723Z","end":"2026-09-19T17:00:12.666713Z","steps":["trace[900242293] 'process raft request'  (duration: 118.551672ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:00:12.739031Z","caller":"traceutil/trace.go:171","msg":"trace[1036547102] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2297; }","duration":"159.318996ms","start":"2026-09-19T17:00:12.579673Z","end":"2026-09-19T17:00:12.738992Z","steps":["trace[1036547102] 'read index received'  (duration: 86.630674ms)","trace[1036547102] 'applied index is now lower than readState.Index'  (duration: 72.686792ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T17:00:12.739083Z","caller":"traceutil/trace.go:171","msg":"trace[1683551951] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"187.900749ms","start":"2026-09-19T17:00:12.551132Z","end":"2026-09-19T17:00:12.739032Z","steps":["trace[1683551951] 'process raft request'  (duration: 187.666132ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:00:12.73929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.8781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-19T17:00:12.73935Z","caller":"traceutil/trace.go:171","msg":"trace[1022142419] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2212; }","duration":"121.014223ms","start":"2026-09-19T17:00:12.618311Z","end":"2026-09-19T17:00:12.739325Z","steps":["trace[1022142419] 'agreement among raft nodes before linearized reading'  (duration: 120.893459ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:00:12.739351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.659386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-19T17:00:12.739407Z","caller":"traceutil/trace.go:171","msg":"trace[555493684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2212; }","duration":"159.764589ms","start":"2026-09-19T17:00:12.579626Z","end":"2026-09-19T17:00:12.73939Z","steps":["trace[555493684] 'agreement among raft nodes before linearized reading'  (duration: 159.522482ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:00:13.38451Z","caller":"traceutil/trace.go:171","msg":"trace[995440526] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"278.002625ms","start":"2026-09-19T17:00:13.106477Z","end":"2026-09-19T17:00:13.38448Z","steps":["trace[995440526] 'process raft request'  (duration: 277.82612ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:00:13.397565Z","caller":"traceutil/trace.go:171","msg":"trace[1665140979] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"290.64131ms","start":"2026-09-19T17:00:13.106886Z","end":"2026-09-19T17:00:13.397528Z","steps":["trace[1665140979] 'process raft request'  (duration: 290.441114ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:01:07.070579Z","caller":"traceutil/trace.go:171","msg":"trace[775135846] transaction","detail":"{read_only:false; response_revision:2610; number_of_response:1; }","duration":"219.142737ms","start":"2026-09-19T17:01:06.851411Z","end":"2026-09-19T17:01:07.070554Z","steps":["trace[775135846] 'process raft request'  (duration: 218.977272ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:01:07.0732Z","caller":"traceutil/trace.go:171","msg":"trace[71315488] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"140.435452ms","start":"2026-09-19T17:01:06.932738Z","end":"2026-09-19T17:01:07.073173Z","steps":["trace[71315488] 'process raft request'  (duration: 140.240946ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:01:44.009608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.943107ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7531884150121305522 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2807 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-19T17:01:44.009753Z","caller":"traceutil/trace.go:171","msg":"trace[1902943435] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"263.526209ms","start":"2026-09-19T17:01:43.74618Z","end":"2026-09-19T17:01:44.009706Z","steps":["trace[1902943435] 'process raft request'  (duration: 134.226702ms)","trace[1902943435] 'compare'  (duration: 128.819593ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T17:05:59.590114Z","caller":"traceutil/trace.go:171","msg":"trace[1458501152] transaction","detail":"{read_only:false; response_revision:4341; number_of_response:1; }","duration":"522.865515ms","start":"2026-09-19T17:05:59.067191Z","end":"2026-09-19T17:05:59.590056Z","steps":["trace[1458501152] 'process raft request'  (duration: 487.324776ms)","trace[1458501152] 'compare'  (duration: 35.360255ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-19T17:05:59.590308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T17:05:59.067153Z","time spent":"523.05719ms","remote":"127.0.0.1:42314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4324 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-19T17:06:12.317465Z","caller":"traceutil/trace.go:171","msg":"trace[520823639] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"138.82823ms","start":"2026-09-19T17:06:12.178592Z","end":"2026-09-19T17:06:12.31742Z","steps":["trace[520823639] 'process raft request'  (duration: 134.190615ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:12.3175Z","caller":"traceutil/trace.go:171","msg":"trace[1648619886] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5092; }","duration":"136.691992ms","start":"2026-09-19T17:06:12.180755Z","end":"2026-09-19T17:06:12.317447Z","steps":["trace[1648619886] 'read index received'  (duration: 12.999054ms)","trace[1648619886] 'applied index is now lower than readState.Index'  (duration: 123.691618ms)"],"step_count":2}
{"level":"info","ts":"2026-09-19T17:06:12.317627Z","caller":"traceutil/trace.go:171","msg":"trace[575489015] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4906; }","duration":"136.533009ms","start":"2026-09-19T17:06:12.181083Z","end":"2026-09-19T17:06:12.317616Z","steps":["trace[575489015] 'process raft request'  (duration: 136.303734ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:06:12.318285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.48331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"}
{"level":"info","ts":"2026-09-19T17:06:12.318447Z","caller":"traceutil/trace.go:171","msg":"trace[715338923] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4906; }","duration":"137.705065ms","start":"2026-09-19T17:06:12.18071Z","end":"2026-09-19T17:06:12.318415Z","steps":["trace[715338923] 'agreement among raft nodes before linearized reading'  (duration: 137.234204ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:06:12.323262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.04675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-19T17:06:12.323323Z","caller":"traceutil/trace.go:171","msg":"trace[1681699516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4908; }","duration":"118.151513ms","start":"2026-09-19T17:06:12.205155Z","end":"2026-09-19T17:06:12.323307Z","steps":["trace[1681699516] 'agreement among raft nodes before linearized reading'  (duration: 117.993479ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:12.491921Z","caller":"traceutil/trace.go:171","msg":"trace[1771871485] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"103.529122ms","start":"2026-09-19T17:06:12.388353Z","end":"2026-09-19T17:06:12.491882Z","steps":["trace[1771871485] 'process raft request'  (duration: 94.399716ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:06:19.337108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.475596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-54fb946d55-5sspj\" ","response":"range_response_count:1 size:11256"}
{"level":"warn","ts":"2026-09-19T17:06:19.337174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.891797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-09-19T17:06:19.337225Z","caller":"traceutil/trace.go:171","msg":"trace[1013849115] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-54fb946d55-5sspj; range_end:; response_count:1; response_revision:4962; }","duration":"310.65763ms","start":"2026-09-19T17:06:19.02654Z","end":"2026-09-19T17:06:19.337198Z","steps":["trace[1013849115] 'range keys from in-memory index tree'  (duration: 310.22455ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:06:19.337286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T17:06:19.02652Z","time spent":"310.751723ms","remote":"127.0.0.1:41452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11279,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-54fb946d55-5sspj\" "}
{"level":"info","ts":"2026-09-19T17:06:19.337291Z","caller":"traceutil/trace.go:171","msg":"trace[1035104042] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4962; }","duration":"276.04177ms","start":"2026-09-19T17:06:19.061209Z","end":"2026-09-19T17:06:19.337251Z","steps":["trace[1035104042] 'range keys from in-memory index tree'  (duration: 275.672452ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:19.92376Z","caller":"traceutil/trace.go:171","msg":"trace[1156767123] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"136.72401ms","start":"2026-09-19T17:06:19.786999Z","end":"2026-09-19T17:06:19.923723Z","steps":["trace[1156767123] 'process raft request'  (duration: 136.232749ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:19.925853Z","caller":"traceutil/trace.go:171","msg":"trace[1507646351] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"136.303631ms","start":"2026-09-19T17:06:19.789508Z","end":"2026-09-19T17:06:19.925811Z","steps":["trace[1507646351] 'process raft request'  (duration: 136.160448ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:32.89409Z","caller":"traceutil/trace.go:171","msg":"trace[245639704] linearizableReadLoop","detail":"{readStateIndex:5405; appliedIndex:5404; }","duration":"150.578759ms","start":"2026-09-19T17:06:32.743489Z","end":"2026-09-19T17:06:32.894068Z","steps":["trace[245639704] 'read index received'  (duration: 150.353274ms)","trace[245639704] 'applied index is now lower than readState.Index'  (duration: 223.695µs)"],"step_count":2}
{"level":"info","ts":"2026-09-19T17:06:32.894128Z","caller":"traceutil/trace.go:171","msg":"trace[1846663543] transaction","detail":"{read_only:false; response_revision:5208; number_of_response:1; }","duration":"154.587522ms","start":"2026-09-19T17:06:32.739504Z","end":"2026-09-19T17:06:32.894092Z","steps":["trace[1846663543] 'process raft request'  (duration: 154.402347ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-19T17:06:32.894649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.961738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.96\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-09-19T17:06:32.894712Z","caller":"traceutil/trace.go:171","msg":"trace[2030259244] range","detail":"{range_begin:/registry/masterleases/162.253.55.96; range_end:; response_count:1; response_revision:5208; }","duration":"151.240245ms","start":"2026-09-19T17:06:32.743456Z","end":"2026-09-19T17:06:32.894696Z","steps":["trace[2030259244] 'agreement among raft nodes before linearized reading'  (duration: 150.758543ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:06:49.291618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2842}
{"level":"info","ts":"2026-09-19T17:06:49.376526Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2842,"took":"83.560581ms","hash":896255298,"current-db-size-bytes":52256768,"current-db-size":"52 MB","current-db-size-in-use-bytes":27521024,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-19T17:06:49.376624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":896255298,"revision":2842,"compact-revision":-1}
{"level":"warn","ts":"2026-09-19T17:10:20.631013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.958856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-19T17:10:20.631147Z","caller":"traceutil/trace.go:171","msg":"trace[558061089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6842; }","duration":"112.167242ms","start":"2026-09-19T17:10:20.518953Z","end":"2026-09-19T17:10:20.63112Z","steps":["trace[558061089] 'range keys from in-memory index tree'  (duration: 111.868684ms)"],"step_count":1}
{"level":"info","ts":"2026-09-19T17:11:49.297704Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5327}
{"level":"info","ts":"2026-09-19T17:11:49.394069Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5327,"took":"94.40139ms","hash":550917738,"current-db-size-bytes":52256768,"current-db-size":"52 MB","current-db-size-in-use-bytes":18665472,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-19T17:11:49.394138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":550917738,"revision":5327,"compact-revision":2842}