{"level":"warn","ts":"2026-09-19T06:01:00.583714Z","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:01:00.584042Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143: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:01:00.584141Z","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:01:00.584157Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-19T06:01:00.58444Z","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:01:00.585389Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]} {"level":"info","ts":"2026-09-19T06:01:00.585476Z","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.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143: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:01:00.590928Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.126552ms"} {"level":"info","ts":"2026-09-19T06:01:00.59771Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"} {"level":"info","ts":"2026-09-19T06:01:00.597779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T06:01:00.597806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"} {"level":"info","ts":"2026-09-19T06:01:00.597817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T06:01:00.597826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"} {"level":"info","ts":"2026-09-19T06:01:00.597866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"warn","ts":"2026-09-19T06:01:00.608415Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T06:01:00.612965Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T06:01:00.615159Z","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:01:00.617868Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T06:01:00.618117Z","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:01:00.618233Z","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:01:00.618242Z","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:01:00.618558Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T06:01:00.619374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"info","ts":"2026-09-19T06:01:00.619485Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-19T06:01:00.623588Z","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:01:00.62376Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-19T06:01:00.62381Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-19T06:01:00.623968Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T06:01:00.624047Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T06:01:00.798982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T06:01:00.799036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T06:01:00.799062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"} {"level":"info","ts":"2026-09-19T06:01:00.799081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"} {"level":"info","ts":"2026-09-19T06:01:00.799085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-19T06:01:00.799095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"} {"level":"info","ts":"2026-09-19T06:01:00.799103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-19T06:01:00.801322Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T06:01:00.801464Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:01:00.801542Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T06:01:00.801787Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:01:00.801967Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T06:01:00.802003Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T06:01:00.803255Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:01:00.803322Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:01:00.803335Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T06:01:00.804325Z","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:01:00.805424Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"} {"level":"info","ts":"2026-09-19T06:01:08.744344Z","caller":"traceutil/trace.go:171","msg":"trace[1778057539] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"163.741513ms","start":"2026-09-19T06:01:08.580571Z","end":"2026-09-19T06:01:08.744313Z","steps":["trace[1778057539] 'process raft request' (duration: 163.544007ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.037668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.315155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:01:09.038028Z","caller":"traceutil/trace.go:171","msg":"trace[1990119275] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"455.444762ms","start":"2026-09-19T06:01:08.582505Z","end":"2026-09-19T06:01:09.03795Z","steps":["trace[1990119275] 'process raft request' (duration: 279.075856ms)","trace[1990119275] 'compare' (duration: 175.14865ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:01:09.038267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:08.582492Z","time spent":"455.639357ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:01:09.039084Z","caller":"traceutil/trace.go:171","msg":"trace[285704143] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"418.274044ms","start":"2026-09-19T06:01:08.620794Z","end":"2026-09-19T06:01:09.039068Z","steps":["trace[285704143] 'process raft request' (duration: 416.999677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.039166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:08.620764Z","time spent":"418.361397ms","remote":"127.0.0.1:51776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T06:01:09.339994Z","caller":"traceutil/trace.go:171","msg":"trace[1573174981] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"236.865063ms","start":"2026-09-19T06:01:09.103099Z","end":"2026-09-19T06:01:09.339964Z","steps":["trace[1573174981] 'read index received' (duration: 236.664687ms)","trace[1573174981] 'applied index is now lower than readState.Index' (duration: 198.486µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:01:09.340091Z","caller":"traceutil/trace.go:171","msg":"trace[237530022] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"241.739207ms","start":"2026-09-19T06:01:09.098308Z","end":"2026-09-19T06:01:09.340048Z","steps":["trace[237530022] 'process raft request' (duration: 241.473689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.340437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.309976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-09-19T06:01:09.340495Z","caller":"traceutil/trace.go:171","msg":"trace[243460939] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:301; }","duration":"237.41508ms","start":"2026-09-19T06:01:09.103062Z","end":"2026-09-19T06:01:09.340477Z","steps":["trace[243460939] 'agreement among raft nodes before linearized reading' (duration: 237.050739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.359361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.740947ms","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:01:09.359495Z","caller":"traceutil/trace.go:171","msg":"trace[358006004] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:303; }","duration":"128.964185ms","start":"2026-09-19T06:01:09.230507Z","end":"2026-09-19T06:01:09.359472Z","steps":["trace[358006004] 'agreement among raft nodes before linearized reading' (duration: 128.698167ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:09.35951Z","caller":"traceutil/trace.go:171","msg":"trace[954753877] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"254.081186ms","start":"2026-09-19T06:01:09.105402Z","end":"2026-09-19T06:01:09.359483Z","steps":["trace[954753877] 'process raft request' (duration: 253.689024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.359554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.059897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-19T06:01:09.359648Z","caller":"traceutil/trace.go:171","msg":"trace[873318698] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:303; }","duration":"129.206591ms","start":"2026-09-19T06:01:09.230417Z","end":"2026-09-19T06:01:09.359623Z","steps":["trace[873318698] 'agreement among raft nodes before linearized reading' (duration: 128.991515ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.359891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.329895ms","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:01:09.359928Z","caller":"traceutil/trace.go:171","msg":"trace[1389978571] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:303; }","duration":"129.425148ms","start":"2026-09-19T06:01:09.230492Z","end":"2026-09-19T06:01:09.359917Z","steps":["trace[1389978571] 'agreement among raft nodes before linearized reading' (duration: 129.363606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.360075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.206408ms","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:01:09.360101Z","caller":"traceutil/trace.go:171","msg":"trace[289184211] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:303; }","duration":"216.26576ms","start":"2026-09-19T06:01:09.143827Z","end":"2026-09-19T06:01:09.360093Z","steps":["trace[289184211] 'agreement among raft nodes before linearized reading' (duration: 216.215829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.360146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.237049ms","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:01:09.360198Z","caller":"traceutil/trace.go:171","msg":"trace[116314009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:303; }","duration":"231.325061ms","start":"2026-09-19T06:01:09.128857Z","end":"2026-09-19T06:01:09.360182Z","steps":["trace[116314009] 'agreement among raft nodes before linearized reading' (duration: 231.217828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:09.360305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.045499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-19T06:01:09.36037Z","caller":"traceutil/trace.go:171","msg":"trace[969435904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:303; }","duration":"251.160722ms","start":"2026-09-19T06:01:09.109198Z","end":"2026-09-19T06:01:09.360359Z","steps":["trace[969435904] 'agreement among raft nodes before linearized reading' (duration: 251.003287ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:09.360374Z","caller":"traceutil/trace.go:171","msg":"trace[239962485] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"256.394295ms","start":"2026-09-19T06:01:09.10394Z","end":"2026-09-19T06:01:09.360334Z","steps":["trace[239962485] 'process raft request' (duration: 254.956283ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:44.990539Z","caller":"traceutil/trace.go:171","msg":"trace[1338914513] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"243.957088ms","start":"2026-09-19T06:01:44.746516Z","end":"2026-09-19T06:01:44.990473Z","steps":["trace[1338914513] 'process raft request' (duration: 146.944555ms)","trace[1338914513] 'compare' (duration: 96.849489ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:01:45.000296Z","caller":"traceutil/trace.go:171","msg":"trace[71734805] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"250.083538ms","start":"2026-09-19T06:01:44.750153Z","end":"2026-09-19T06:01:45.000236Z","steps":["trace[71734805] 'process raft request' (duration: 249.560686ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.000536Z","caller":"traceutil/trace.go:171","msg":"trace[937664683] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"218.941594ms","start":"2026-09-19T06:01:44.781567Z","end":"2026-09-19T06:01:45.000509Z","steps":["trace[937664683] 'process raft request' (duration: 218.841272ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.000745Z","caller":"traceutil/trace.go:171","msg":"trace[1521501926] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"233.511869ms","start":"2026-09-19T06:01:44.767222Z","end":"2026-09-19T06:01:45.000734Z","steps":["trace[1521501926] 'process raft request' (duration: 232.757321ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.000879Z","caller":"traceutil/trace.go:171","msg":"trace[349078213] transaction","detail":"{read_only:false; number_of_response:0; response_revision:513; }","duration":"233.649222ms","start":"2026-09-19T06:01:44.767218Z","end":"2026-09-19T06:01:45.000867Z","steps":["trace[349078213] 'process raft request' (duration: 233.15464ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001177Z","caller":"traceutil/trace.go:171","msg":"trace[2034191822] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"217.4409ms","start":"2026-09-19T06:01:44.783724Z","end":"2026-09-19T06:01:45.001165Z","steps":["trace[2034191822] 'process raft request' (duration: 217.03285ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001269Z","caller":"traceutil/trace.go:171","msg":"trace[2044912925] transaction","detail":"{read_only:false; number_of_response:1; response_revision:516; }","duration":"214.154125ms","start":"2026-09-19T06:01:44.787089Z","end":"2026-09-19T06:01:45.001243Z","steps":["trace[2044912925] 'process raft request' (duration: 213.866639ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001067Z","caller":"traceutil/trace.go:171","msg":"trace[1939765537] transaction","detail":"{read_only:false; number_of_response:1; response_revision:514; }","duration":"217.299727ms","start":"2026-09-19T06:01:44.783615Z","end":"2026-09-19T06:01:45.000915Z","steps":["trace[1939765537] 'process raft request' (duration: 216.848516ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001366Z","caller":"traceutil/trace.go:171","msg":"trace[1856947807] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"217.672415ms","start":"2026-09-19T06:01:44.783683Z","end":"2026-09-19T06:01:45.001355Z","steps":["trace[1856947807] 'process raft request' (duration: 216.928228ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001434Z","caller":"traceutil/trace.go:171","msg":"trace[248436328] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"214.280528ms","start":"2026-09-19T06:01:44.787135Z","end":"2026-09-19T06:01:45.001415Z","steps":["trace[248436328] 'process raft request' (duration: 213.93435ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001421Z","caller":"traceutil/trace.go:171","msg":"trace[1642513195] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"178.901658ms","start":"2026-09-19T06:01:44.822488Z","end":"2026-09-19T06:01:45.001389Z","steps":["trace[1642513195] 'process raft request' (duration: 178.811456ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.001621Z","caller":"traceutil/trace.go:171","msg":"trace[1034176061] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"200.494423ms","start":"2026-09-19T06:01:44.801114Z","end":"2026-09-19T06:01:45.001609Z","steps":["trace[1034176061] 'process raft request' (duration: 200.038842ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.671776Z","caller":"traceutil/trace.go:171","msg":"trace[53542300] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"227.808876ms","start":"2026-09-19T06:01:45.443934Z","end":"2026-09-19T06:01:45.671743Z","steps":["trace[53542300] 'process raft request' (duration: 227.609212ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.802443Z","caller":"traceutil/trace.go:171","msg":"trace[303183281] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"357.676615ms","start":"2026-09-19T06:01:45.44472Z","end":"2026-09-19T06:01:45.802396Z","steps":["trace[303183281] 'process raft request' (duration: 333.441882ms)","trace[303183281] 'compare' (duration: 23.955216ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:01:45.802599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:45.444707Z","time spent":"357.817058ms","remote":"127.0.0.1:51660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-19T06:01:45.802828Z","caller":"traceutil/trace.go:171","msg":"trace[1997202759] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"315.542004ms","start":"2026-09-19T06:01:45.487234Z","end":"2026-09-19T06:01:45.802776Z","steps":["trace[1997202759] 'process raft request' (duration: 315.057424ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:45.802915Z","caller":"traceutil/trace.go:171","msg":"trace[226163183] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:586; }","duration":"229.662278ms","start":"2026-09-19T06:01:45.573137Z","end":"2026-09-19T06:01:45.802799Z","steps":["trace[226163183] 'read index received' (duration: 98.43705ms)","trace[226163183] 'applied index is now lower than readState.Index' (duration: 131.223648ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:01:45.803038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:45.487211Z","time spent":"315.732808ms","remote":"127.0.0.1:51660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:01:45.803113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.963055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-19T06:01:45.803169Z","caller":"traceutil/trace.go:171","msg":"trace[1797768235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:562; }","duration":"230.060547ms","start":"2026-09-19T06:01:45.573094Z","end":"2026-09-19T06:01:45.803155Z","steps":["trace[1797768235] 'agreement among raft nodes before linearized reading' (duration: 229.876013ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:50.603919Z","caller":"traceutil/trace.go:171","msg":"trace[1744729483] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"120.017016ms","start":"2026-09-19T06:01:50.483878Z","end":"2026-09-19T06:01:50.603895Z","steps":["trace[1744729483] 'process raft request' (duration: 119.387332ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:51.606184Z","caller":"traceutil/trace.go:171","msg":"trace[475087981] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"204.318805ms","start":"2026-09-19T06:01:51.40181Z","end":"2026-09-19T06:01:51.606129Z","steps":["trace[475087981] 'process raft request' (duration: 204.119361ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:01:52.15437Z","caller":"traceutil/trace.go:171","msg":"trace[1404649101] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"492.590979ms","start":"2026-09-19T06:01:51.661727Z","end":"2026-09-19T06:01:52.154318Z","steps":["trace[1404649101] 'process raft request' (duration: 478.228655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:52.154581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:51.661677Z","time spent":"492.791283ms","remote":"127.0.0.1:51692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:01:52.155136Z","caller":"traceutil/trace.go:171","msg":"trace[1568464816] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"313.737213ms","start":"2026-09-19T06:01:51.841369Z","end":"2026-09-19T06:01:52.155106Z","steps":["trace[1568464816] 'read index received' (duration: 297.731534ms)","trace[1568464816] 'applied index is now lower than readState.Index' (duration: 16.002819ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:01:52.155279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.913227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-19T06:01:52.155301Z","caller":"traceutil/trace.go:171","msg":"trace[1607915752] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"313.977229ms","start":"2026-09-19T06:01:51.841318Z","end":"2026-09-19T06:01:52.155295Z","steps":["trace[1607915752] 'agreement among raft nodes before linearized reading' (duration: 313.863246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:01:52.155317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:01:51.841295Z","time spent":"314.018299ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-19T06:02:08.862903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.029352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p9lpc\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-19T06:02:08.863001Z","caller":"traceutil/trace.go:171","msg":"trace[280120657] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p9lpc; range_end:; response_count:1; response_revision:780; }","duration":"347.218046ms","start":"2026-09-19T06:02:08.515761Z","end":"2026-09-19T06:02:08.862979Z","steps":["trace[280120657] 'range keys from in-memory index tree' (duration: 346.796997ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:08.863046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:08.515739Z","time spent":"347.295698ms","remote":"127.0.0.1:51770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-p9lpc\" "} {"level":"warn","ts":"2026-09-19T06:02:40.019455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.442634ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-19T06:02:40.020157Z","caller":"traceutil/trace.go:171","msg":"trace[2125512953] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"284.602368ms","start":"2026-09-19T06:02:39.735524Z","end":"2026-09-19T06:02:40.020126Z","steps":["trace[2125512953] 'process raft request' (duration: 284.368464ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:04.128408Z","caller":"traceutil/trace.go:171","msg":"trace[972092092] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"174.095068ms","start":"2026-09-19T06:03:03.954274Z","end":"2026-09-19T06:03:04.128369Z","steps":["trace[972092092] 'process raft request' (duration: 173.878276ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:29.616417Z","caller":"traceutil/trace.go:171","msg":"trace[1904042575] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"242.572866ms","start":"2026-09-19T06:03:29.373664Z","end":"2026-09-19T06:03:29.616236Z","steps":["trace[1904042575] 'process raft request' (duration: 242.422014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:29.616566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.985925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-19T06:03:29.616714Z","caller":"traceutil/trace.go:171","msg":"trace[47980000] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1850; }","duration":"140.185709ms","start":"2026-09-19T06:03:29.47647Z","end":"2026-09-19T06:03:29.616656Z","steps":["trace[47980000] 'agreement among raft nodes before linearized reading' (duration: 139.822933ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:29.616286Z","caller":"traceutil/trace.go:171","msg":"trace[1680625623] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"139.66826ms","start":"2026-09-19T06:03:29.476531Z","end":"2026-09-19T06:03:29.6162Z","steps":["trace[1680625623] 'read index received' (duration: 139.488278ms)","trace[1680625623] 'applied index is now lower than readState.Index' (duration: 176.062µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:29.62469Z","caller":"traceutil/trace.go:171","msg":"trace[1028601838] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"145.972411ms","start":"2026-09-19T06:03:29.478697Z","end":"2026-09-19T06:03:29.62467Z","steps":["trace[1028601838] 'process raft request' (duration: 145.747077ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:30.131478Z","caller":"traceutil/trace.go:171","msg":"trace[1987244628] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"187.539309ms","start":"2026-09-19T06:03:29.943912Z","end":"2026-09-19T06:03:30.131451Z","steps":["trace[1987244628] 'process raft request' (duration: 187.352506ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:04.47161Z","caller":"traceutil/trace.go:171","msg":"trace[1150976875] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"100.038911ms","start":"2026-09-19T06:04:04.371543Z","end":"2026-09-19T06:04:04.471582Z","steps":["trace[1150976875] 'read index received' (duration: 99.918979ms)","trace[1150976875] 'applied index is now lower than readState.Index' (duration: 118.512µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:04:04.471778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.204504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:04:04.47184Z","caller":"traceutil/trace.go:171","msg":"trace[1496493807] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2097; }","duration":"100.315355ms","start":"2026-09-19T06:04:04.371506Z","end":"2026-09-19T06:04:04.471821Z","steps":["trace[1496493807] 'agreement among raft nodes before linearized reading' (duration: 100.201174ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:04.591267Z","caller":"traceutil/trace.go:171","msg":"trace[1795131339] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"118.645724ms","start":"2026-09-19T06:04:04.472567Z","end":"2026-09-19T06:04:04.591213Z","steps":["trace[1795131339] 'process raft request' (duration: 39.976348ms)","trace[1795131339] 'compare' (duration: 78.192858ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:04:04.80379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.264074ms","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-19T06:04:04.803907Z","caller":"traceutil/trace.go:171","msg":"trace[177897534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2100; }","duration":"106.430017ms","start":"2026-09-19T06:04:04.697452Z","end":"2026-09-19T06:04:04.803883Z","steps":["trace[177897534] 'range keys from in-memory index tree' (duration: 106.076932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:04:05.393584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.088011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:04:05.394277Z","caller":"traceutil/trace.go:171","msg":"trace[557578978] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"427.779825ms","start":"2026-09-19T06:04:04.966452Z","end":"2026-09-19T06:04:05.394231Z","steps":["trace[557578978] 'process raft request' (duration: 125.898232ms)","trace[557578978] 'compare' (duration: 300.926658ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:05.394318Z","caller":"traceutil/trace.go:171","msg":"trace[2098485271] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"195.293465ms","start":"2026-09-19T06:04:05.198994Z","end":"2026-09-19T06:04:05.394287Z","steps":["trace[2098485271] 'process raft request' (duration: 195.164133ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.394547Z","caller":"traceutil/trace.go:171","msg":"trace[2046776624] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2190; }","duration":"406.118266ms","start":"2026-09-19T06:04:04.988225Z","end":"2026-09-19T06:04:05.394343Z","steps":["trace[2046776624] 'read index received' (duration: 104.06756ms)","trace[2046776624] 'applied index is now lower than readState.Index' (duration: 302.047066ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:04:05.394724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:04:04.966431Z","time spent":"427.935017ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:04:05.394805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.557453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-19T06:04:05.394987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.311766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:04:05.39504Z","caller":"traceutil/trace.go:171","msg":"trace[546542685] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2104; }","duration":"228.368127ms","start":"2026-09-19T06:04:05.16666Z","end":"2026-09-19T06:04:05.395028Z","steps":["trace[546542685] 'agreement among raft nodes before linearized reading' (duration: 228.270606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:04:05.395024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.824417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:04:05.395082Z","caller":"traceutil/trace.go:171","msg":"trace[1808699105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2104; }","duration":"211.941849ms","start":"2026-09-19T06:04:05.183124Z","end":"2026-09-19T06:04:05.395065Z","steps":["trace[1808699105] 'agreement among raft nodes before linearized reading' (duration: 211.845547ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:04:05.394984Z","caller":"traceutil/trace.go:171","msg":"trace[418910128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2104; }","duration":"406.711466ms","start":"2026-09-19T06:04:04.98821Z","end":"2026-09-19T06:04:05.394922Z","steps":["trace[418910128] 'agreement among raft nodes before linearized reading' (duration: 406.394051ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:04:05.39522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:04:04.988158Z","time spent":"407.01079ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-19T06:04:05.54943Z","caller":"traceutil/trace.go:171","msg":"trace[14209337] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"149.387018ms","start":"2026-09-19T06:04:05.400012Z","end":"2026-09-19T06:04:05.549399Z","steps":["trace[14209337] 'process raft request' (duration: 100.638518ms)","trace[14209337] 'compare' (duration: 48.529377ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:04:05.549642Z","caller":"traceutil/trace.go:171","msg":"trace[1511088865] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"100.369285ms","start":"2026-09-19T06:04:05.449242Z","end":"2026-09-19T06:04:05.549612Z","steps":["trace[1511088865] 'process raft request' (duration: 100.113081ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:12.69442Z","caller":"traceutil/trace.go:171","msg":"trace[291662530] linearizableReadLoop","detail":"{readStateIndex:2670; appliedIndex:2669; }","duration":"117.285568ms","start":"2026-09-19T06:05:12.577092Z","end":"2026-09-19T06:05:12.694377Z","steps":["trace[291662530] 'read index received' (duration: 116.843862ms)","trace[291662530] 'applied index is now lower than readState.Index' (duration: 440.336µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:05:12.694603Z","caller":"traceutil/trace.go:171","msg":"trace[145728403] transaction","detail":"{read_only:false; response_revision:2567; number_of_response:1; }","duration":"201.826911ms","start":"2026-09-19T06:05:12.492762Z","end":"2026-09-19T06:05:12.694589Z","steps":["trace[145728403] 'process raft request' (duration: 201.331383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:12.694766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.345351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-19T06:05:12.694856Z","caller":"traceutil/trace.go:171","msg":"trace[1592214730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2567; }","duration":"102.461272ms","start":"2026-09-19T06:05:12.592354Z","end":"2026-09-19T06:05:12.694815Z","steps":["trace[1592214730] 'agreement among raft nodes before linearized reading' (duration: 102.31115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:12.695121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.002129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-19T06:05:12.69518Z","caller":"traceutil/trace.go:171","msg":"trace[1302862722] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2567; }","duration":"118.113851ms","start":"2026-09-19T06:05:12.577056Z","end":"2026-09-19T06:05:12.69517Z","steps":["trace[1302862722] 'agreement among raft nodes before linearized reading' (duration: 117.897548ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:12.832537Z","caller":"traceutil/trace.go:171","msg":"trace[1545958672] linearizableReadLoop","detail":"{readStateIndex:2671; appliedIndex:2670; }","duration":"132.999418ms","start":"2026-09-19T06:05:12.699509Z","end":"2026-09-19T06:05:12.832508Z","steps":["trace[1545958672] 'read index received' (duration: 69.127568ms)","trace[1545958672] 'applied index is now lower than readState.Index' (duration: 63.87072ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:05:12.832679Z","caller":"traceutil/trace.go:171","msg":"trace[1548854421] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"133.427824ms","start":"2026-09-19T06:05:12.699238Z","end":"2026-09-19T06:05:12.832666Z","steps":["trace[1548854421] 'process raft request' (duration: 69.535783ms)","trace[1548854421] 'compare' (duration: 63.599906ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:05:12.832988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.458355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"} {"level":"info","ts":"2026-09-19T06:05:12.833042Z","caller":"traceutil/trace.go:171","msg":"trace[535492703] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2568; }","duration":"133.562127ms","start":"2026-09-19T06:05:12.699465Z","end":"2026-09-19T06:05:12.833027Z","steps":["trace[535492703] 'agreement among raft nodes before linearized reading' (duration: 133.363404ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:13.498896Z","caller":"traceutil/trace.go:171","msg":"trace[740820854] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"130.780744ms","start":"2026-09-19T06:05:13.368088Z","end":"2026-09-19T06:05:13.498869Z","steps":["trace[740820854] 'process raft request' (duration: 130.599252ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:43.627563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.932376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:43.627683Z","caller":"traceutil/trace.go:171","msg":"trace[629917426] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2738; }","duration":"186.108079ms","start":"2026-09-19T06:05:43.441551Z","end":"2026-09-19T06:05:43.627659Z","steps":["trace[629917426] 'count revisions from in-memory index tree' (duration: 185.829293ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:49.161583Z","caller":"traceutil/trace.go:171","msg":"trace[609147174] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"145.959876ms","start":"2026-09-19T06:05:49.01558Z","end":"2026-09-19T06:05:49.16154Z","steps":["trace[609147174] 'process raft request' (duration: 145.65616ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:49.388971Z","caller":"traceutil/trace.go:171","msg":"trace[1430571430] linearizableReadLoop","detail":"{readStateIndex:2879; appliedIndex:2878; }","duration":"227.508127ms","start":"2026-09-19T06:05:49.161428Z","end":"2026-09-19T06:05:49.388936Z","steps":["trace[1430571430] 'read index received' (duration: 219.361023ms)","trace[1430571430] 'applied index is now lower than readState.Index' (duration: 8.145494ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:05:49.38932Z","caller":"traceutil/trace.go:171","msg":"trace[621765902] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"266.892039ms","start":"2026-09-19T06:05:49.122414Z","end":"2026-09-19T06:05:49.389306Z","steps":["trace[621765902] 'process raft request' (duration: 258.336827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.389588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.125552ms","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-19T06:05:49.389682Z","caller":"traceutil/trace.go:171","msg":"trace[12811356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2768; }","duration":"254.270956ms","start":"2026-09-19T06:05:49.135388Z","end":"2026-09-19T06:05:49.389659Z","steps":["trace[12811356] 'agreement among raft nodes before linearized reading' (duration: 253.958169ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:05:49.396712Z","caller":"traceutil/trace.go:171","msg":"trace[1646300316] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"230.327143ms","start":"2026-09-19T06:05:49.166354Z","end":"2026-09-19T06:05:49.396682Z","steps":["trace[1646300316] 'process raft request' (duration: 230.128319ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.396731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.629247ms","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:49.39681Z","caller":"traceutil/trace.go:171","msg":"trace[12444602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2769; }","duration":"212.750859ms","start":"2026-09-19T06:05:49.184041Z","end":"2026-09-19T06:05:49.396792Z","steps":["trace[12444602] 'agreement among raft nodes before linearized reading' (duration: 212.607306ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:05:49.397125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.803086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:05:49.397168Z","caller":"traceutil/trace.go:171","msg":"trace[1293141680] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2769; }","duration":"175.889508ms","start":"2026-09-19T06:05:49.221269Z","end":"2026-09-19T06:05:49.397158Z","steps":["trace[1293141680] 'agreement among raft nodes before linearized reading' (duration: 175.818706ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:25.158789Z","caller":"traceutil/trace.go:171","msg":"trace[514083750] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"154.633148ms","start":"2026-09-19T06:10:25.004138Z","end":"2026-09-19T06:10:25.158771Z","steps":["trace[514083750] 'process raft request' (duration: 154.502996ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:25.15915Z","caller":"traceutil/trace.go:171","msg":"trace[543935461] linearizableReadLoop","detail":"{readStateIndex:5001; appliedIndex:5001; }","duration":"150.687756ms","start":"2026-09-19T06:10:25.008456Z","end":"2026-09-19T06:10:25.159144Z","steps":["trace[543935461] 'read index received' (duration: 150.684766ms)","trace[543935461] 'applied index is now lower than readState.Index' (duration: 2.61µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:10:25.159744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.263355ms","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:10:25.160115Z","caller":"traceutil/trace.go:171","msg":"trace[1410712872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4810; }","duration":"151.668692ms","start":"2026-09-19T06:10:25.008434Z","end":"2026-09-19T06:10:25.160103Z","steps":["trace[1410712872] 'agreement among raft nodes before linearized reading' (duration: 151.080062ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:25.212734Z","caller":"traceutil/trace.go:171","msg":"trace[820354857] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"169.033814ms","start":"2026-09-19T06:10:25.043676Z","end":"2026-09-19T06:10:25.21271Z","steps":["trace[820354857] 'process raft request' (duration: 168.81653ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:25.212942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.634938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a4428b9d-4b73-4997-95ef-5af78f6977c3\" ","response":"range_response_count:1 size:3774"} {"level":"warn","ts":"2026-09-19T06:10:25.212959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.744746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-19T06:10:25.213011Z","caller":"traceutil/trace.go:171","msg":"trace[810832129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4812; }","duration":"155.824307ms","start":"2026-09-19T06:10:25.057175Z","end":"2026-09-19T06:10:25.212999Z","steps":["trace[810832129] 'agreement among raft nodes before linearized reading' (duration: 155.697735ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:25.213022Z","caller":"traceutil/trace.go:171","msg":"trace[457958553] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a4428b9d-4b73-4997-95ef-5af78f6977c3; range_end:; response_count:1; response_revision:4812; }","duration":"177.74047ms","start":"2026-09-19T06:10:25.035272Z","end":"2026-09-19T06:10:25.213012Z","steps":["trace[457958553] 'agreement among raft nodes before linearized reading' (duration: 177.472975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:25.213055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.589592ms","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:10:25.213098Z","caller":"traceutil/trace.go:171","msg":"trace[294338164] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"115.839452ms","start":"2026-09-19T06:10:25.09725Z","end":"2026-09-19T06:10:25.213089Z","steps":["trace[294338164] 'process raft request' (duration: 115.386005ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:25.213146Z","caller":"traceutil/trace.go:171","msg":"trace[2114295941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4812; }","duration":"201.704543ms","start":"2026-09-19T06:10:25.011419Z","end":"2026-09-19T06:10:25.213123Z","steps":["trace[2114295941] 'agreement among raft nodes before linearized reading' (duration: 201.405429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:25.213439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.664082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-19T06:10:25.213512Z","caller":"traceutil/trace.go:171","msg":"trace[695583834] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4812; }","duration":"119.794044ms","start":"2026-09-19T06:10:25.093704Z","end":"2026-09-19T06:10:25.213498Z","steps":["trace[695583834] 'agreement among raft nodes before linearized reading' (duration: 119.017282ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:36.817208Z","caller":"traceutil/trace.go:171","msg":"trace[2114278559] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"404.922633ms","start":"2026-09-19T06:10:36.41226Z","end":"2026-09-19T06:10:36.817183Z","steps":["trace[2114278559] 'process raft request' (duration: 404.705439ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:36.817383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.202063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-19T06:10:36.817418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:10:36.41223Z","time spent":"405.096545ms","remote":"127.0.0.1:39244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2724,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:10:36.817457Z","caller":"traceutil/trace.go:171","msg":"trace[1759836146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4982; }","duration":"297.317855ms","start":"2026-09-19T06:10:36.520125Z","end":"2026-09-19T06:10:36.817443Z","steps":["trace[1759836146] 'agreement among raft nodes before linearized reading' (duration: 297.169293ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:36.817228Z","caller":"traceutil/trace.go:171","msg":"trace[1507157298] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5179; }","duration":"297.0095ms","start":"2026-09-19T06:10:36.520167Z","end":"2026-09-19T06:10:36.817177Z","steps":["trace[1507157298] 'read index received' (duration: 296.99624ms)","trace[1507157298] 'applied index is now lower than readState.Index' (duration: 10.42µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:36.849113Z","caller":"traceutil/trace.go:171","msg":"trace[896630952] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"188.888693ms","start":"2026-09-19T06:10:36.660191Z","end":"2026-09-19T06:10:36.84908Z","steps":["trace[896630952] 'process raft request' (duration: 188.641519ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:36.849629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.361873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:10:36.849694Z","caller":"traceutil/trace.go:171","msg":"trace[26585296] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4985; }","duration":"293.476325ms","start":"2026-09-19T06:10:36.556201Z","end":"2026-09-19T06:10:36.849678Z","steps":["trace[26585296] 'agreement among raft nodes before linearized reading' (duration: 293.304802ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.156872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.303194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:10:37.157105Z","caller":"traceutil/trace.go:171","msg":"trace[600154250] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"183.169764ms","start":"2026-09-19T06:10:36.973899Z","end":"2026-09-19T06:10:37.157069Z","steps":["trace[600154250] 'process raft request' (duration: 12.587835ms)","trace[600154250] 'compare' (duration: 170.007461ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:37.157544Z","caller":"traceutil/trace.go:171","msg":"trace[1053187757] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"183.459569ms","start":"2026-09-19T06:10:36.974055Z","end":"2026-09-19T06:10:37.157515Z","steps":["trace[1053187757] 'process raft request' (duration: 182.928671ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.157753Z","caller":"traceutil/trace.go:171","msg":"trace[82063210] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"182.150298ms","start":"2026-09-19T06:10:36.975582Z","end":"2026-09-19T06:10:37.157732Z","steps":["trace[82063210] 'process raft request' (duration: 181.471188ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.159109Z","caller":"traceutil/trace.go:171","msg":"trace[448194587] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"183.243006ms","start":"2026-09-19T06:10:36.975846Z","end":"2026-09-19T06:10:37.159089Z","steps":["trace[448194587] 'process raft request' (duration: 181.492708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.419645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.717202ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:10:37.42045Z","caller":"traceutil/trace.go:171","msg":"trace[768968072] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"189.462452ms","start":"2026-09-19T06:10:37.230935Z","end":"2026-09-19T06:10:37.420398Z","steps":["trace[768968072] 'process raft request' (duration: 40.926328ms)","trace[768968072] 'compare' (duration: 147.347637ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:37.42056Z","caller":"traceutil/trace.go:171","msg":"trace[1470413893] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"187.001644ms","start":"2026-09-19T06:10:37.233521Z","end":"2026-09-19T06:10:37.420523Z","steps":["trace[1470413893] 'process raft request' (duration: 186.406685ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.421451Z","caller":"traceutil/trace.go:171","msg":"trace[686799953] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"170.04599ms","start":"2026-09-19T06:10:37.251384Z","end":"2026-09-19T06:10:37.42143Z","steps":["trace[686799953] 'process raft request' (duration: 169.937438ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.421481Z","caller":"traceutil/trace.go:171","msg":"trace[740627995] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5196; }","duration":"188.092611ms","start":"2026-09-19T06:10:37.233344Z","end":"2026-09-19T06:10:37.421437Z","steps":["trace[740627995] 'read index received' (duration: 13.54706ms)","trace[740627995] 'applied index is now lower than readState.Index' (duration: 174.537361ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:10:37.421851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.456747ms","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-19T06:10:37.421884Z","caller":"traceutil/trace.go:171","msg":"trace[915637390] 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:5002; }","duration":"188.563919ms","start":"2026-09-19T06:10:37.23331Z","end":"2026-09-19T06:10:37.421874Z","steps":["trace[915637390] 'agreement among raft nodes before linearized reading' (duration: 188.294555ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.453971Z","caller":"traceutil/trace.go:171","msg":"trace[1184145239] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"174.876975ms","start":"2026-09-19T06:10:37.279066Z","end":"2026-09-19T06:10:37.453943Z","steps":["trace[1184145239] 'process raft request' (duration: 174.687362ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:37.454176Z","caller":"traceutil/trace.go:171","msg":"trace[1900107604] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"144.772986ms","start":"2026-09-19T06:10:37.309387Z","end":"2026-09-19T06:10:37.45416Z","steps":["trace[1900107604] 'process raft request' (duration: 144.513891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.454493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.765496ms","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:10:37.454555Z","caller":"traceutil/trace.go:171","msg":"trace[1948159456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5004; }","duration":"101.875498ms","start":"2026-09-19T06:10:37.352662Z","end":"2026-09-19T06:10:37.454537Z","steps":["trace[1948159456] 'agreement among raft nodes before linearized reading' (duration: 101.652224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.454565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.359338ms","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:10:37.454586Z","caller":"traceutil/trace.go:171","msg":"trace[1886775327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5004; }","duration":"140.427638ms","start":"2026-09-19T06:10:37.314151Z","end":"2026-09-19T06:10:37.454579Z","steps":["trace[1886775327] 'agreement among raft nodes before linearized reading' (duration: 140.304246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.454601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.39366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-19T06:10:37.454801Z","caller":"traceutil/trace.go:171","msg":"trace[229023632] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5004; }","duration":"110.750355ms","start":"2026-09-19T06:10:37.34403Z","end":"2026-09-19T06:10:37.45478Z","steps":["trace[229023632] 'agreement among raft nodes before linearized reading' (duration: 110.191967ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:37.455324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.442823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-19T06:10:37.455757Z","caller":"traceutil/trace.go:171","msg":"trace[1621942186] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5004; }","duration":"214.582884ms","start":"2026-09-19T06:10:37.240819Z","end":"2026-09-19T06:10:37.455402Z","steps":["trace[1621942186] 'agreement among raft nodes before linearized reading' (duration: 213.975425ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:51.23565Z","caller":"traceutil/trace.go:171","msg":"trace[1966344229] linearizableReadLoop","detail":"{readStateIndex:5415; appliedIndex:5414; }","duration":"271.030949ms","start":"2026-09-19T06:10:50.964595Z","end":"2026-09-19T06:10:51.235626Z","steps":["trace[1966344229] 'read index received' (duration: 270.930327ms)","trace[1966344229] 'applied index is now lower than readState.Index' (duration: 99.292µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:51.235768Z","caller":"traceutil/trace.go:171","msg":"trace[1803454209] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"336.985883ms","start":"2026-09-19T06:10:50.898771Z","end":"2026-09-19T06:10:51.235756Z","steps":["trace[1803454209] 'process raft request' (duration: 336.668798ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:51.236174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:10:50.898746Z","time spent":"337.199677ms","remote":"127.0.0.1:51824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:10:51.236254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.600447ms","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:10:51.23639Z","caller":"traceutil/trace.go:171","msg":"trace[1143653423] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5212; }","duration":"271.794631ms","start":"2026-09-19T06:10:50.96453Z","end":"2026-09-19T06:10:51.236325Z","steps":["trace[1143653423] 'agreement among raft nodes before linearized reading' (duration: 271.496846ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:51.273815Z","caller":"traceutil/trace.go:171","msg":"trace[1279031158] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"263.175747ms","start":"2026-09-19T06:10:51.010587Z","end":"2026-09-19T06:10:51.273763Z","steps":["trace[1279031158] 'process raft request' (duration: 249.747899ms)","trace[1279031158] 'compare' (duration: 13.261486ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:51.702896Z","caller":"traceutil/trace.go:171","msg":"trace[1102915791] linearizableReadLoop","detail":"{readStateIndex:5425; appliedIndex:5422; }","duration":"144.264911ms","start":"2026-09-19T06:10:51.558606Z","end":"2026-09-19T06:10:51.702871Z","steps":["trace[1102915791] 'read index received' (duration: 67.052462ms)","trace[1102915791] 'applied index is now lower than readState.Index' (duration: 77.210589ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:10:51.703023Z","caller":"traceutil/trace.go:171","msg":"trace[1129923009] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"147.173595ms","start":"2026-09-19T06:10:51.555836Z","end":"2026-09-19T06:10:51.703009Z","steps":["trace[1129923009] 'process raft request' (duration: 146.916822ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:51.703185Z","caller":"traceutil/trace.go:171","msg":"trace[45143963] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"144.375552ms","start":"2026-09-19T06:10:51.558797Z","end":"2026-09-19T06:10:51.703172Z","steps":["trace[45143963] 'process raft request' (duration: 144.011107ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:51.703176Z","caller":"traceutil/trace.go:171","msg":"trace[1799625382] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"147.991909ms","start":"2026-09-19T06:10:51.555148Z","end":"2026-09-19T06:10:51.70314Z","steps":["trace[1799625382] 'process raft request' (duration: 109.826686ms)","trace[1799625382] 'compare' (duration: 37.647815ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:10:51.703502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.829489ms","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:10:51.703544Z","caller":"traceutil/trace.go:171","msg":"trace[359773244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5223; }","duration":"144.89704ms","start":"2026-09-19T06:10:51.558637Z","end":"2026-09-19T06:10:51.703534Z","steps":["trace[359773244] 'agreement among raft nodes before linearized reading' (duration: 144.743637ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:10:51.703727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.098853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-19T06:10:51.703819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.500104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-19T06:10:51.703865Z","caller":"traceutil/trace.go:171","msg":"trace[1953513103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5223; }","duration":"108.576346ms","start":"2026-09-19T06:10:51.595278Z","end":"2026-09-19T06:10:51.703855Z","steps":["trace[1953513103] 'agreement among raft nodes before linearized reading' (duration: 108.421023ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:51.703864Z","caller":"traceutil/trace.go:171","msg":"trace[1240431055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5223; }","duration":"145.237645ms","start":"2026-09-19T06:10:51.558575Z","end":"2026-09-19T06:10:51.703812Z","steps":["trace[1240431055] 'agreement among raft nodes before linearized reading' (duration: 145.035672ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:01.006467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2829} {"level":"info","ts":"2026-09-19T06:11:01.251061Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2829,"took":"243.196827ms","hash":2420650072,"current-db-size-bytes":52424704,"current-db-size":"52 MB","current-db-size-in-use-bytes":27639808,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T06:11:01.251116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2420650072,"revision":2829,"compact-revision":-1} {"level":"info","ts":"2026-09-19T06:11:28.113991Z","caller":"traceutil/trace.go:171","msg":"trace[1387163525] transaction","detail":"{read_only:false; response_revision:5556; number_of_response:1; }","duration":"148.994695ms","start":"2026-09-19T06:11:27.964962Z","end":"2026-09-19T06:11:28.113957Z","steps":["trace[1387163525] 'process raft request' (duration: 115.221175ms)","trace[1387163525] 'compare' (duration: 33.527736ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:11:28.114074Z","caller":"traceutil/trace.go:171","msg":"trace[1954541608] transaction","detail":"{read_only:false; response_revision:5557; number_of_response:1; }","duration":"147.538664ms","start":"2026-09-19T06:11:27.966496Z","end":"2026-09-19T06:11:28.114035Z","steps":["trace[1954541608] 'process raft request' (duration: 147.381121ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:13:44.750634Z","caller":"traceutil/trace.go:171","msg":"trace[1869747726] transaction","detail":"{read_only:false; response_revision:6418; number_of_response:1; }","duration":"130.724194ms","start":"2026-09-19T06:13:44.619882Z","end":"2026-09-19T06:13:44.750606Z","steps":["trace[1869747726] 'process raft request' (duration: 130.566231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:15:42.870061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.975976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:15:42.870312Z","caller":"traceutil/trace.go:171","msg":"trace[1594016156] transaction","detail":"{read_only:false; response_revision:7268; number_of_response:1; }","duration":"150.457903ms","start":"2026-09-19T06:15:42.719814Z","end":"2026-09-19T06:15:42.870272Z","steps":["trace[1594016156] 'process raft request' (duration: 43.129182ms)","trace[1594016156] 'compare' (duration: 106.60289ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:16:01.013458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5295} {"level":"info","ts":"2026-09-19T06:16:01.089795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5295,"took":"74.791299ms","hash":506425536,"current-db-size-bytes":52424704,"current-db-size":"52 MB","current-db-size-in-use-bytes":18722816,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T06:16:01.089864Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":506425536,"revision":5295,"compact-revision":2829}