{"level":"warn","ts":"2026-09-19T05:57:59.955998Z","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-19T05:57:59.956069Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.66: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.66:2380","--initial-cluster=instance=https://162.253.55.66:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.66:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.66: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-19T05:57:59.95612Z","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-19T05:57:59.956128Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.66:2380"]} {"level":"info","ts":"2026-09-19T05:57:59.95615Z","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-19T05:57:59.956831Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.66:2379"]} {"level":"info","ts":"2026-09-19T05:57:59.956917Z","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.66:2380"],"listen-peer-urls":["https://162.253.55.66:2380"],"advertise-client-urls":["https://162.253.55.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.66: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-19T05:57:59.963316Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.835018ms"} {"level":"info","ts":"2026-09-19T05:57:59.975493Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"48afe2e91b68f008","cluster-id":"5894dcc7313657d8"} {"level":"info","ts":"2026-09-19T05:57:59.97556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 switched to configuration voters=()"} {"level":"info","ts":"2026-09-19T05:57:59.975577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 became follower at term 0"} {"level":"info","ts":"2026-09-19T05:57:59.975586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 48afe2e91b68f008 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-19T05:57:59.975593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 became follower at term 1"} {"level":"info","ts":"2026-09-19T05:57:59.97562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 switched to configuration voters=(5237654382470295560)"} {"level":"warn","ts":"2026-09-19T05:57:59.986691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-19T05:57:59.988005Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-19T05:57:59.989119Z","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-19T05:57:59.99118Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"48afe2e91b68f008","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-19T05:57:59.991448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"48afe2e91b68f008","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-19T05:57:59.992295Z","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-19T05:57:59.992638Z","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-19T05:57:59.992743Z","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-19T05:57:59.993715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 switched to configuration voters=(5237654382470295560)"} {"level":"info","ts":"2026-09-19T05:57:59.993872Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5894dcc7313657d8","local-member-id":"48afe2e91b68f008","added-peer-id":"48afe2e91b68f008","added-peer-peer-urls":["https://162.253.55.66:2380"]} {"level":"info","ts":"2026-09-19T05:57:59.999717Z","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-19T05:57:59.999777Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.66:2380"} {"level":"info","ts":"2026-09-19T05:57:59.999881Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.66:2380"} {"level":"info","ts":"2026-09-19T05:58:00.001866Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"48afe2e91b68f008","initial-advertise-peer-urls":["https://162.253.55.66:2380"],"listen-peer-urls":["https://162.253.55.66:2380"],"advertise-client-urls":["https://162.253.55.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-19T05:58:00.001944Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-19T05:58:00.876584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 is starting a new election at term 1"} {"level":"info","ts":"2026-09-19T05:58:00.876641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-19T05:58:00.87668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 received MsgPreVoteResp from 48afe2e91b68f008 at term 1"} {"level":"info","ts":"2026-09-19T05:58:00.876698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 became candidate at term 2"} {"level":"info","ts":"2026-09-19T05:58:00.876715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 received MsgVoteResp from 48afe2e91b68f008 at term 2"} {"level":"info","ts":"2026-09-19T05:58:00.87673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"48afe2e91b68f008 became leader at term 2"} {"level":"info","ts":"2026-09-19T05:58:00.876742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 48afe2e91b68f008 elected leader 48afe2e91b68f008 at term 2"} {"level":"info","ts":"2026-09-19T05:58:00.878512Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"48afe2e91b68f008","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.66:2379]}","request-path":"/0/members/48afe2e91b68f008/attributes","cluster-id":"5894dcc7313657d8","publish-timeout":"7s"} {"level":"info","ts":"2026-09-19T05:58:00.878672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T05:58:00.878819Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-19T05:58:00.879192Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T05:58:00.879391Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-19T05:58:00.879431Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-19T05:58:00.880215Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5894dcc7313657d8","local-member-id":"48afe2e91b68f008","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T05:58:00.880355Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T05:58:00.8804Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-19T05:58:00.882442Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.66:2379"} {"level":"info","ts":"2026-09-19T05:58:00.882764Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-19T05:58:10.420934Z","caller":"traceutil/trace.go:171","msg":"trace[1795953189] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"104.010059ms","start":"2026-09-19T05:58:10.316895Z","end":"2026-09-19T05:58:10.420905Z","steps":["trace[1795953189] 'read index received' (duration: 103.913305ms)","trace[1795953189] 'applied index is now lower than readState.Index' (duration: 95.574µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:10.42105Z","caller":"traceutil/trace.go:171","msg":"trace[248177561] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"121.410981ms","start":"2026-09-19T05:58:10.299597Z","end":"2026-09-19T05:58:10.421008Z","steps":["trace[248177561] 'process raft request' (duration: 121.157991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:10.421152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.235519ms","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-19T05:58:10.421244Z","caller":"traceutil/trace.go:171","msg":"trace[1272188380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:298; }","duration":"104.388316ms","start":"2026-09-19T05:58:10.316836Z","end":"2026-09-19T05:58:10.421224Z","steps":["trace[1272188380] 'agreement among raft nodes before linearized reading' (duration: 104.194907ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:10.61851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.953079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T05:58:10.618613Z","caller":"traceutil/trace.go:171","msg":"trace[2054169618] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"191.560139ms","start":"2026-09-19T05:58:10.427037Z","end":"2026-09-19T05:58:10.618597Z","steps":["trace[2054169618] 'read index received' (duration: 8.793785ms)","trace[2054169618] 'applied index is now lower than readState.Index' (duration: 182.764094ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:10.618654Z","caller":"traceutil/trace.go:171","msg":"trace[333310162] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"193.483433ms","start":"2026-09-19T05:58:10.425142Z","end":"2026-09-19T05:58:10.618625Z","steps":["trace[333310162] 'process raft request' (duration: 10.744421ms)","trace[333310162] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:488; } (duration: 181.813813ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T05:58:10.618737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.695035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-19T05:58:10.618802Z","caller":"traceutil/trace.go:171","msg":"trace[282445208] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"191.782129ms","start":"2026-09-19T05:58:10.42701Z","end":"2026-09-19T05:58:10.618792Z","steps":["trace[282445208] 'agreement among raft nodes before linearized reading' (duration: 191.626982ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:10.945932Z","caller":"traceutil/trace.go:171","msg":"trace[1783286630] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"145.080337ms","start":"2026-09-19T05:58:10.800824Z","end":"2026-09-19T05:58:10.945904Z","steps":["trace[1783286630] 'read index received' (duration: 144.93218ms)","trace[1783286630] 'applied index is now lower than readState.Index' (duration: 147.077µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:10.945989Z","caller":"traceutil/trace.go:171","msg":"trace[174461849] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"197.617894ms","start":"2026-09-19T05:58:10.748337Z","end":"2026-09-19T05:58:10.945954Z","steps":["trace[174461849] 'process raft request' (duration: 197.412875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:10.946137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.257375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-09-19T05:58:10.946217Z","caller":"traceutil/trace.go:171","msg":"trace[1594208906] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:306; }","duration":"145.3903ms","start":"2026-09-19T05:58:10.800779Z","end":"2026-09-19T05:58:10.946169Z","steps":["trace[1594208906] 'agreement among raft nodes before linearized reading' (duration: 145.262045ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:10.946314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.802562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-19T05:58:10.94639Z","caller":"traceutil/trace.go:171","msg":"trace[1779502146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:306; }","duration":"106.909936ms","start":"2026-09-19T05:58:10.839461Z","end":"2026-09-19T05:58:10.946371Z","steps":["trace[1779502146] 'agreement among raft nodes before linearized reading' (duration: 106.611973ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:27.192928Z","caller":"traceutil/trace.go:171","msg":"trace[388134152] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"120.946039ms","start":"2026-09-19T05:58:27.07196Z","end":"2026-09-19T05:58:27.192906Z","steps":["trace[388134152] 'process raft request' (duration: 120.821744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:44.084672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.051461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-19T05:58:44.08498Z","caller":"traceutil/trace.go:171","msg":"trace[1397809836] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"222.676749ms","start":"2026-09-19T05:58:43.862278Z","end":"2026-09-19T05:58:44.084955Z","steps":["trace[1397809836] 'process raft request' (duration: 222.487763ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.084997Z","caller":"traceutil/trace.go:171","msg":"trace[695640630] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"227.318075ms","start":"2026-09-19T05:58:43.857661Z","end":"2026-09-19T05:58:44.084979Z","steps":["trace[695640630] 'process raft request' (duration: 87.606344ms)","trace[695640630] 'compare' (duration: 138.73137ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:44.085211Z","caller":"traceutil/trace.go:171","msg":"trace[588648750] transaction","detail":"{read_only:false; number_of_response:1; response_revision:502; }","duration":"221.737679ms","start":"2026-09-19T05:58:43.863445Z","end":"2026-09-19T05:58:44.085182Z","steps":["trace[588648750] 'process raft request' (duration: 221.43617ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.085347Z","caller":"traceutil/trace.go:171","msg":"trace[2044963833] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"221.800342ms","start":"2026-09-19T05:58:43.863528Z","end":"2026-09-19T05:58:44.085329Z","steps":["trace[2044963833] 'process raft request' (duration: 221.669018ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.08494Z","caller":"traceutil/trace.go:171","msg":"trace[1288813408] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"221.551843ms","start":"2026-09-19T05:58:43.863368Z","end":"2026-09-19T05:58:44.08492Z","steps":["trace[1288813408] 'process raft request' (duration: 221.479721ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.110798Z","caller":"traceutil/trace.go:171","msg":"trace[1746096460] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"244.377934ms","start":"2026-09-19T05:58:43.866394Z","end":"2026-09-19T05:58:44.110771Z","steps":["trace[1746096460] 'process raft request' (duration: 244.008803ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.11087Z","caller":"traceutil/trace.go:171","msg":"trace[374804309] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"244.418186ms","start":"2026-09-19T05:58:43.86643Z","end":"2026-09-19T05:58:44.110848Z","steps":["trace[374804309] 'process raft request' (duration: 244.258541ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.11104Z","caller":"traceutil/trace.go:171","msg":"trace[1231178276] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"239.527022ms","start":"2026-09-19T05:58:43.871503Z","end":"2026-09-19T05:58:44.11103Z","steps":["trace[1231178276] 'process raft request' (duration: 239.339636ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.111058Z","caller":"traceutil/trace.go:171","msg":"trace[881971630] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"239.573934ms","start":"2026-09-19T05:58:43.871454Z","end":"2026-09-19T05:58:44.111028Z","steps":["trace[881971630] 'process raft request' (duration: 239.319135ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.111211Z","caller":"traceutil/trace.go:171","msg":"trace[905134162] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"239.301005ms","start":"2026-09-19T05:58:43.871826Z","end":"2026-09-19T05:58:44.111127Z","steps":["trace[905134162] 'process raft request' (duration: 239.088839ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.111485Z","caller":"traceutil/trace.go:171","msg":"trace[2135787943] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"229.924379ms","start":"2026-09-19T05:58:43.88153Z","end":"2026-09-19T05:58:44.111454Z","steps":["trace[2135787943] 'process raft request' (duration: 229.428474ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.111858Z","caller":"traceutil/trace.go:171","msg":"trace[1846429523] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"220.906317ms","start":"2026-09-19T05:58:43.890937Z","end":"2026-09-19T05:58:44.111843Z","steps":["trace[1846429523] 'process raft request' (duration: 220.281038ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.112029Z","caller":"traceutil/trace.go:171","msg":"trace[1084952172] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"208.340431ms","start":"2026-09-19T05:58:43.903668Z","end":"2026-09-19T05:58:44.112008Z","steps":["trace[1084952172] 'process raft request' (duration: 207.739123ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:44.11203Z","caller":"traceutil/trace.go:171","msg":"trace[1853927099] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"173.885547ms","start":"2026-09-19T05:58:43.93812Z","end":"2026-09-19T05:58:44.112005Z","steps":["trace[1853927099] 'process raft request' (duration: 173.728922ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:50.339983Z","caller":"traceutil/trace.go:171","msg":"trace[1632307975] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"134.058992ms","start":"2026-09-19T05:58:50.205904Z","end":"2026-09-19T05:58:50.339963Z","steps":["trace[1632307975] 'process raft request' (duration: 132.890598ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:50.525223Z","caller":"traceutil/trace.go:171","msg":"trace[137800467] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"173.041726ms","start":"2026-09-19T05:58:50.352154Z","end":"2026-09-19T05:58:50.525196Z","steps":["trace[137800467] 'process raft request' (duration: 172.885251ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:58:50.8652Z","caller":"traceutil/trace.go:171","msg":"trace[630529331] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"427.703883ms","start":"2026-09-19T05:58:50.437466Z","end":"2026-09-19T05:58:50.86517Z","steps":["trace[630529331] 'read index received' (duration: 87.647721ms)","trace[630529331] 'applied index is now lower than readState.Index' (duration: 340.054942ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:50.865341Z","caller":"traceutil/trace.go:171","msg":"trace[163375787] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"470.310153ms","start":"2026-09-19T05:58:50.395005Z","end":"2026-09-19T05:58:50.865315Z","steps":["trace[163375787] 'process raft request' (duration: 458.354629ms)","trace[163375787] 'compare' (duration: 11.645524ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T05:58:50.865452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T05:58:50.394985Z","time spent":"470.411367ms","remote":"127.0.0.1:42374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T05:58:50.865521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.040804ms","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-19T05:58:50.865591Z","caller":"traceutil/trace.go:171","msg":"trace[338656436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"428.133146ms","start":"2026-09-19T05:58:50.437423Z","end":"2026-09-19T05:58:50.865556Z","steps":["trace[338656436] 'agreement among raft nodes before linearized reading' (duration: 427.90762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:50.865662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T05:58:50.437378Z","time spent":"428.24859ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T05:58:51.461761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.736001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T05:58:51.461909Z","caller":"traceutil/trace.go:171","msg":"trace[1639751301] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:627; }","duration":"584.573235ms","start":"2026-09-19T05:58:50.87732Z","end":"2026-09-19T05:58:51.461893Z","steps":["trace[1639751301] 'read index received' (duration: 8.575973ms)","trace[1639751301] 'applied index is now lower than readState.Index' (duration: 575.995982ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T05:58:51.46195Z","caller":"traceutil/trace.go:171","msg":"trace[376209291] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"591.576693ms","start":"2026-09-19T05:58:50.870334Z","end":"2026-09-19T05:58:51.461911Z","steps":["trace[376209291] 'process raft request' (duration: 372.598264ms)","trace[376209291] 'compare' (duration: 218.549385ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T05:58:51.462024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.691989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T05:58:51.462072Z","caller":"traceutil/trace.go:171","msg":"trace[1260899777] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:607; }","duration":"584.775582ms","start":"2026-09-19T05:58:50.87728Z","end":"2026-09-19T05:58:51.462056Z","steps":["trace[1260899777] 'agreement among raft nodes before linearized reading' (duration: 584.69468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:51.462083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.259677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T05:58:51.462112Z","caller":"traceutil/trace.go:171","msg":"trace[69818354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"204.352329ms","start":"2026-09-19T05:58:51.257751Z","end":"2026-09-19T05:58:51.462103Z","steps":["trace[69818354] 'agreement among raft nodes before linearized reading' (duration: 204.278537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:58:51.462116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T05:58:50.877268Z","time spent":"584.826583ms","remote":"127.0.0.1:42028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-19T05:58:51.462112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T05:58:50.870326Z","time spent":"591.708836ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T05:58:51.462254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.733976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-19T05:58:51.462304Z","caller":"traceutil/trace.go:171","msg":"trace[931140602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"152.829389ms","start":"2026-09-19T05:58:51.309459Z","end":"2026-09-19T05:58:51.462289Z","steps":["trace[931140602] 'agreement among raft nodes before linearized reading' (duration: 152.659284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T05:59:08.465408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.944479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T05:59:08.465575Z","caller":"traceutil/trace.go:171","msg":"trace[1725325354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:775; }","duration":"208.123932ms","start":"2026-09-19T05:59:08.257386Z","end":"2026-09-19T05:59:08.46551Z","steps":["trace[1725325354] 'range keys from in-memory index tree' (duration: 207.813215ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T05:59:42.17456Z","caller":"traceutil/trace.go:171","msg":"trace[1975357926] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"107.404003ms","start":"2026-09-19T05:59:42.067127Z","end":"2026-09-19T05:59:42.174531Z","steps":["trace[1975357926] 'process raft request' (duration: 107.22604ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:00:05.196255Z","caller":"traceutil/trace.go:171","msg":"trace[958715283] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"276.085656ms","start":"2026-09-19T06:00:04.920144Z","end":"2026-09-19T06:00:05.19623Z","steps":["trace[958715283] 'process raft request' (duration: 275.956613ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:00:31.187574Z","caller":"traceutil/trace.go:171","msg":"trace[1769698984] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"384.253755ms","start":"2026-09-19T06:00:30.803292Z","end":"2026-09-19T06:00:31.187546Z","steps":["trace[1769698984] 'process raft request' (duration: 384.084403ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:00:31.187773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:00:30.803273Z","time spent":"384.381457ms","remote":"127.0.0.1:41968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:00:31.201575Z","caller":"traceutil/trace.go:171","msg":"trace[1781980195] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"397.908884ms","start":"2026-09-19T06:00:30.803632Z","end":"2026-09-19T06:00:31.201541Z","steps":["trace[1781980195] 'process raft request' (duration: 397.770922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:00:31.20181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:00:30.803615Z","time spent":"398.051376ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:00:31.596004Z","caller":"traceutil/trace.go:171","msg":"trace[1130398320] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"102.44822ms","start":"2026-09-19T06:00:31.493517Z","end":"2026-09-19T06:00:31.595965Z","steps":["trace[1130398320] 'process raft request' (duration: 102.161826ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:00:31.802393Z","caller":"traceutil/trace.go:171","msg":"trace[1996136756] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"201.649406ms","start":"2026-09-19T06:00:31.60071Z","end":"2026-09-19T06:00:31.802359Z","steps":["trace[1996136756] 'process raft request' (duration: 190.191355ms)","trace[1996136756] 'compare' (duration: 11.075915ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:00:31.807299Z","caller":"traceutil/trace.go:171","msg":"trace[1284368905] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"206.236283ms","start":"2026-09-19T06:00:31.601045Z","end":"2026-09-19T06:00:31.807282Z","steps":["trace[1284368905] 'process raft request' (duration: 205.988549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:00:44.223463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.118864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:00:44.223726Z","caller":"traceutil/trace.go:171","msg":"trace[351283126] linearizableReadLoop","detail":"{readStateIndex:2055; appliedIndex:2052; }","duration":"141.129211ms","start":"2026-09-19T06:00:44.082578Z","end":"2026-09-19T06:00:44.223707Z","steps":["trace[351283126] 'read index received' (duration: 88.102µs)","trace[351283126] 'applied index is now lower than readState.Index' (duration: 141.035829ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:00:44.223781Z","caller":"traceutil/trace.go:171","msg":"trace[647842432] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"257.236299ms","start":"2026-09-19T06:00:43.966505Z","end":"2026-09-19T06:00:44.223742Z","steps":["trace[647842432] 'process raft request' (duration: 75.74969ms)","trace[647842432] 'compare' (duration: 181.001132ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:00:44.224114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.549247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.66\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-19T06:00:44.22416Z","caller":"traceutil/trace.go:171","msg":"trace[1746845234] range","detail":"{range_begin:/registry/masterleases/162.253.55.66; range_end:; response_count:1; response_revision:1979; }","duration":"141.653709ms","start":"2026-09-19T06:00:44.082492Z","end":"2026-09-19T06:00:44.224146Z","steps":["trace[1746845234] 'agreement among raft nodes before linearized reading' (duration: 141.483676ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:00:44.224337Z","caller":"traceutil/trace.go:171","msg":"trace[887539520] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"152.100666ms","start":"2026-09-19T06:00:44.072223Z","end":"2026-09-19T06:00:44.224324Z","steps":["trace[887539520] 'process raft request' (duration: 151.427876ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:00:44.224418Z","caller":"traceutil/trace.go:171","msg":"trace[615433750] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"255.359689ms","start":"2026-09-19T06:00:43.96905Z","end":"2026-09-19T06:00:44.22441Z","steps":["trace[615433750] 'process raft request' (duration: 254.547896ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:42.82315Z","caller":"traceutil/trace.go:171","msg":"trace[1149912101] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"320.69812ms","start":"2026-09-19T06:02:42.502428Z","end":"2026-09-19T06:02:42.823126Z","steps":["trace[1149912101] 'process raft request' (duration: 320.516452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:42.823322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:42.502413Z","time spent":"320.832606ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:02:42.823497Z","caller":"traceutil/trace.go:171","msg":"trace[282693638] linearizableReadLoop","detail":"{readStateIndex:2842; appliedIndex:2842; }","duration":"297.679245ms","start":"2026-09-19T06:02:42.525782Z","end":"2026-09-19T06:02:42.823461Z","steps":["trace[282693638] 'read index received' (duration: 297.657254ms)","trace[282693638] 'applied index is now lower than readState.Index' (duration: 19.261µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:02:42.823584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.79665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:02:42.823625Z","caller":"traceutil/trace.go:171","msg":"trace[285750451] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2739; }","duration":"297.903375ms","start":"2026-09-19T06:02:42.52571Z","end":"2026-09-19T06:02:42.823614Z","steps":["trace[285750451] 'agreement among raft nodes before linearized reading' (duration: 297.835472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.050647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.855592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-19T06:02:43.051253Z","caller":"traceutil/trace.go:171","msg":"trace[431493136] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"293.564444ms","start":"2026-09-19T06:02:42.757659Z","end":"2026-09-19T06:02:43.051224Z","steps":["trace[431493136] 'process raft request' (duration: 90.047134ms)","trace[431493136] 'compare' (duration: 202.417503ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:43.051292Z","caller":"traceutil/trace.go:171","msg":"trace[1800248438] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"127.859195ms","start":"2026-09-19T06:02:42.923413Z","end":"2026-09-19T06:02:43.051272Z","steps":["trace[1800248438] 'process raft request' (duration: 127.441487ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:43.051305Z","caller":"traceutil/trace.go:171","msg":"trace[1892856221] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"291.929603ms","start":"2026-09-19T06:02:42.759338Z","end":"2026-09-19T06:02:43.051267Z","steps":["trace[1892856221] 'process raft request' (duration: 291.432172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.051703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.812894ms","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:02:43.051753Z","caller":"traceutil/trace.go:171","msg":"trace[560660442] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2742; }","duration":"355.941249ms","start":"2026-09-19T06:02:42.695797Z","end":"2026-09-19T06:02:43.051739Z","steps":["trace[560660442] 'agreement among raft nodes before linearized reading' (duration: 355.73256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.05179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:42.695779Z","time spent":"356.002622ms","remote":"127.0.0.1:41970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1391,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-09-19T06:02:43.051842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.203656ms","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:02:43.051902Z","caller":"traceutil/trace.go:171","msg":"trace[260368576] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2742; }","duration":"463.31244ms","start":"2026-09-19T06:02:42.588576Z","end":"2026-09-19T06:02:43.051888Z","steps":["trace[260368576] 'agreement among raft nodes before linearized reading' (duration: 463.082151ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.051939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:42.588557Z","time spent":"463.374043ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-19T06:02:43.052205Z","caller":"traceutil/trace.go:171","msg":"trace[857218247] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2842; }","duration":"227.695986ms","start":"2026-09-19T06:02:42.823602Z","end":"2026-09-19T06:02:43.051298Z","steps":["trace[857218247] 'read index received' (duration: 24.007978ms)","trace[857218247] 'applied index is now lower than readState.Index' (duration: 203.685248ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:02:43.052403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.208739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:02:43.052455Z","caller":"traceutil/trace.go:171","msg":"trace[909570151] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2742; }","duration":"225.320843ms","start":"2026-09-19T06:02:42.82712Z","end":"2026-09-19T06:02:43.052441Z","steps":["trace[909570151] 'agreement among raft nodes before linearized reading' (duration: 225.219219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.052836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.942004ms","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:02:43.052883Z","caller":"traceutil/trace.go:171","msg":"trace[572497954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2742; }","duration":"178.028779ms","start":"2026-09-19T06:02:42.874843Z","end":"2026-09-19T06:02:43.052872Z","steps":["trace[572497954] 'agreement among raft nodes before linearized reading' (duration: 177.881791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.052997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.986619ms","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:02:43.053064Z","caller":"traceutil/trace.go:171","msg":"trace[1526845036] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2742; }","duration":"195.123755ms","start":"2026-09-19T06:02:42.857924Z","end":"2026-09-19T06:02:43.053048Z","steps":["trace[1526845036] 'agreement among raft nodes before linearized reading' (duration: 194.934177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:43.05301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.807791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-19T06:02:43.053201Z","caller":"traceutil/trace.go:171","msg":"trace[1089837007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2742; }","duration":"133.015031ms","start":"2026-09-19T06:02:42.920169Z","end":"2026-09-19T06:02:43.053184Z","steps":["trace[1089837007] 'agreement among raft nodes before linearized reading' (duration: 132.782931ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:48.9833Z","caller":"traceutil/trace.go:171","msg":"trace[605212570] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"302.732071ms","start":"2026-09-19T06:02:48.680542Z","end":"2026-09-19T06:02:48.983274Z","steps":["trace[605212570] 'process raft request' (duration: 302.555804ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:48.983388Z","caller":"traceutil/trace.go:171","msg":"trace[1202615405] linearizableReadLoop","detail":"{readStateIndex:2875; appliedIndex:2875; }","duration":"286.789514ms","start":"2026-09-19T06:02:48.696572Z","end":"2026-09-19T06:02:48.983362Z","steps":["trace[1202615405] 'read index received' (duration: 286.779443ms)","trace[1202615405] 'applied index is now lower than readState.Index' (duration: 8.531µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:02:48.983441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:48.680518Z","time spent":"302.850456ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:02:48.983656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.032744ms","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:02:48.983685Z","caller":"traceutil/trace.go:171","msg":"trace[203929443] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2771; }","duration":"287.148859ms","start":"2026-09-19T06:02:48.69653Z","end":"2026-09-19T06:02:48.983679Z","steps":["trace[203929443] 'agreement among raft nodes before linearized reading' (duration: 286.91894ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:49.210846Z","caller":"traceutil/trace.go:171","msg":"trace[567096928] linearizableReadLoop","detail":"{readStateIndex:2876; appliedIndex:2875; }","duration":"223.499115ms","start":"2026-09-19T06:02:48.987324Z","end":"2026-09-19T06:02:49.210823Z","steps":["trace[567096928] 'read index received' (duration: 223.326337ms)","trace[567096928] 'applied index is now lower than readState.Index' (duration: 171.698µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:02:49.21096Z","caller":"traceutil/trace.go:171","msg":"trace[302920585] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"364.914432ms","start":"2026-09-19T06:02:48.846035Z","end":"2026-09-19T06:02:49.210949Z","steps":["trace[302920585] 'process raft request' (duration: 364.619299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:49.21107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:02:48.846013Z","time spent":"364.970915ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-19T06:02:49.211232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.828628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18d6a390be19abc1\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-09-19T06:02:49.211303Z","caller":"traceutil/trace.go:171","msg":"trace[1662124378] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18d6a390be19abc1; range_end:; response_count:1; response_revision:2772; }","duration":"223.989865ms","start":"2026-09-19T06:02:48.987296Z","end":"2026-09-19T06:02:49.211285Z","steps":["trace[1662124378] 'agreement among raft nodes before linearized reading' (duration: 223.752565ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:49.219867Z","caller":"traceutil/trace.go:171","msg":"trace[139274254] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"148.570652ms","start":"2026-09-19T06:02:49.071282Z","end":"2026-09-19T06:02:49.219852Z","steps":["trace[139274254] 'process raft request' (duration: 148.452828ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:49.21993Z","caller":"traceutil/trace.go:171","msg":"trace[779620743] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"150.571086ms","start":"2026-09-19T06:02:49.069329Z","end":"2026-09-19T06:02:49.2199Z","steps":["trace[779620743] 'process raft request' (duration: 150.311326ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:02:49.220089Z","caller":"traceutil/trace.go:171","msg":"trace[115679919] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"141.689602ms","start":"2026-09-19T06:02:49.078389Z","end":"2026-09-19T06:02:49.220079Z","steps":["trace[115679919] 'process raft request' (duration: 141.418991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:02:49.22012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.13186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1447"} {"level":"info","ts":"2026-09-19T06:02:49.22052Z","caller":"traceutil/trace.go:171","msg":"trace[57881335] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2775; }","duration":"232.518506ms","start":"2026-09-19T06:02:48.987963Z","end":"2026-09-19T06:02:49.220482Z","steps":["trace[57881335] 'agreement among raft nodes before linearized reading' (duration: 232.042416ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:33.517892Z","caller":"traceutil/trace.go:171","msg":"trace[397970876] transaction","detail":"{read_only:false; response_revision:3004; number_of_response:1; }","duration":"111.324004ms","start":"2026-09-19T06:03:33.406545Z","end":"2026-09-19T06:03:33.517869Z","steps":["trace[397970876] 'process raft request' (duration: 111.180359ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:33.832613Z","caller":"traceutil/trace.go:171","msg":"trace[1308807994] transaction","detail":"{read_only:false; response_revision:3009; number_of_response:1; }","duration":"126.293078ms","start":"2026-09-19T06:03:33.706295Z","end":"2026-09-19T06:03:33.832588Z","steps":["trace[1308807994] 'process raft request' (duration: 112.706441ms)","trace[1308807994] 'compare' (duration: 13.495634ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:33.839132Z","caller":"traceutil/trace.go:171","msg":"trace[1507432946] transaction","detail":"{read_only:false; response_revision:3010; number_of_response:1; }","duration":"130.344839ms","start":"2026-09-19T06:03:33.708715Z","end":"2026-09-19T06:03:33.83906Z","steps":["trace[1507432946] 'process raft request' (duration: 130.053299ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:33.839222Z","caller":"traceutil/trace.go:171","msg":"trace[1986896298] linearizableReadLoop","detail":"{readStateIndex:3124; appliedIndex:3122; }","duration":"121.312604ms","start":"2026-09-19T06:03:33.717636Z","end":"2026-09-19T06:03:33.838949Z","steps":["trace[1986896298] 'read index received' (duration: 101.378425ms)","trace[1986896298] 'applied index is now lower than readState.Index' (duration: 19.933108ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:03:33.839319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.652915ms","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:03:33.839386Z","caller":"traceutil/trace.go:171","msg":"trace[1927136939] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3010; }","duration":"121.760999ms","start":"2026-09-19T06:03:33.717607Z","end":"2026-09-19T06:03:33.839368Z","steps":["trace[1927136939] 'agreement among raft nodes before linearized reading' (duration: 121.529191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:33.83952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.631669ms","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:03:33.839666Z","caller":"traceutil/trace.go:171","msg":"trace[1651784944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3010; }","duration":"108.790684ms","start":"2026-09-19T06:03:33.730855Z","end":"2026-09-19T06:03:33.839646Z","steps":["trace[1651784944] 'agreement among raft nodes before linearized reading' (duration: 108.503584ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:37.716862Z","caller":"traceutil/trace.go:171","msg":"trace[691769658] transaction","detail":"{read_only:false; response_revision:3026; number_of_response:1; }","duration":"177.072152ms","start":"2026-09-19T06:03:37.539753Z","end":"2026-09-19T06:03:37.716825Z","steps":["trace[691769658] 'process raft request' (duration: 136.648637ms)","trace[691769658] 'compare' (duration: 40.137976ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:37.717242Z","caller":"traceutil/trace.go:171","msg":"trace[1729570435] linearizableReadLoop","detail":"{readStateIndex:3143; appliedIndex:3139; }","duration":"142.177187ms","start":"2026-09-19T06:03:37.575032Z","end":"2026-09-19T06:03:37.717209Z","steps":["trace[1729570435] 'read index received' (duration: 32.703049ms)","trace[1729570435] 'applied index is now lower than readState.Index' (duration: 109.472368ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:37.717315Z","caller":"traceutil/trace.go:171","msg":"trace[113092014] transaction","detail":"{read_only:false; response_revision:3028; number_of_response:1; }","duration":"177.494486ms","start":"2026-09-19T06:03:37.539803Z","end":"2026-09-19T06:03:37.717298Z","steps":["trace[113092014] 'process raft request' (duration: 177.217187ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:03:37.717395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.341873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:03:37.717446Z","caller":"traceutil/trace.go:171","msg":"trace[1111198648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:3028; }","duration":"142.478518ms","start":"2026-09-19T06:03:37.574953Z","end":"2026-09-19T06:03:37.717431Z","steps":["trace[1111198648] 'agreement among raft nodes before linearized reading' (duration: 142.372444ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:37.717228Z","caller":"traceutil/trace.go:171","msg":"trace[1610820852] transaction","detail":"{read_only:false; response_revision:3027; number_of_response:1; }","duration":"177.445525ms","start":"2026-09-19T06:03:37.539755Z","end":"2026-09-19T06:03:37.717201Z","steps":["trace[1610820852] 'process raft request' (duration: 177.0047ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:03:41.847572Z","caller":"traceutil/trace.go:171","msg":"trace[1470334102] transaction","detail":"{read_only:false; response_revision:3048; number_of_response:1; }","duration":"111.060135ms","start":"2026-09-19T06:03:41.736479Z","end":"2026-09-19T06:03:41.847539Z","steps":["trace[1470334102] 'process raft request' (duration: 89.040626ms)","trace[1470334102] 'compare' (duration: 21.377107ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:03:41.848106Z","caller":"traceutil/trace.go:171","msg":"trace[2007277257] transaction","detail":"{read_only:false; response_revision:3049; number_of_response:1; }","duration":"111.126307ms","start":"2026-09-19T06:03:41.736948Z","end":"2026-09-19T06:03:41.848074Z","steps":["trace[2007277257] 'process raft request' (duration: 110.527727ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:12.902583Z","caller":"traceutil/trace.go:171","msg":"trace[1631885806] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"332.311705ms","start":"2026-09-19T06:07:12.570246Z","end":"2026-09-19T06:07:12.902558Z","steps":["trace[1631885806] 'process raft request' (duration: 332.126361ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:12.90257Z","caller":"traceutil/trace.go:171","msg":"trace[891189083] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4939; }","duration":"286.736734ms","start":"2026-09-19T06:07:12.615785Z","end":"2026-09-19T06:07:12.902522Z","steps":["trace[891189083] 'read index received' (duration: 286.577121ms)","trace[891189083] 'applied index is now lower than readState.Index' (duration: 158.063µs)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:07:12.902742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:12.570227Z","time spent":"332.426508ms","remote":"127.0.0.1:55560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-19T06:07:12.904534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.720915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-19T06:07:12.904606Z","caller":"traceutil/trace.go:171","msg":"trace[1166636886] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4760; }","duration":"288.831948ms","start":"2026-09-19T06:07:12.615756Z","end":"2026-09-19T06:07:12.904588Z","steps":["trace[1166636886] 'agreement among raft nodes before linearized reading' (duration: 286.952449ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:12.948349Z","caller":"traceutil/trace.go:171","msg":"trace[780773228] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"231.202046ms","start":"2026-09-19T06:07:12.717115Z","end":"2026-09-19T06:07:12.948317Z","steps":["trace[780773228] 'process raft request' (duration: 231.013232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:12.948706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.307162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:07:12.948778Z","caller":"traceutil/trace.go:171","msg":"trace[203387394] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4765; }","duration":"298.391424ms","start":"2026-09-19T06:07:12.65037Z","end":"2026-09-19T06:07:12.948761Z","steps":["trace[203387394] 'agreement among raft nodes before linearized reading' (duration: 298.245841ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:12.949227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.797463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69f16b7e-b2de-4a14-adfc-4aa0679c53d8\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-19T06:07:12.949278Z","caller":"traceutil/trace.go:171","msg":"trace[1069058684] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69f16b7e-b2de-4a14-adfc-4aa0679c53d8; range_end:; response_count:1; response_revision:4765; }","duration":"240.847125ms","start":"2026-09-19T06:07:12.708416Z","end":"2026-09-19T06:07:12.949263Z","steps":["trace[1069058684] 'agreement among raft nodes before linearized reading' (duration: 240.409045ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:12.948992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.413886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69f16b7e-b2de-4a14-adfc-4aa0679c53d8\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-19T06:07:12.949388Z","caller":"traceutil/trace.go:171","msg":"trace[1148153077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69f16b7e-b2de-4a14-adfc-4aa0679c53d8; range_end:; response_count:1; response_revision:4765; }","duration":"239.918477ms","start":"2026-09-19T06:07:12.70945Z","end":"2026-09-19T06:07:12.949368Z","steps":["trace[1148153077] 'agreement among raft nodes before linearized reading' (duration: 239.314904ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:13.423616Z","caller":"traceutil/trace.go:171","msg":"trace[558044294] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"144.991471ms","start":"2026-09-19T06:07:13.27861Z","end":"2026-09-19T06:07:13.423602Z","steps":["trace[558044294] 'process raft request' (duration: 60.243303ms)","trace[558044294] 'compare' (duration: 84.524904ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:13.423559Z","caller":"traceutil/trace.go:171","msg":"trace[1779208248] linearizableReadLoop","detail":"{readStateIndex:4967; appliedIndex:4966; }","duration":"112.282947ms","start":"2026-09-19T06:07:13.311247Z","end":"2026-09-19T06:07:13.42353Z","steps":["trace[1779208248] 'read index received' (duration: 27.56789ms)","trace[1779208248] 'applied index is now lower than readState.Index' (duration: 84.713907ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:07:13.424184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.923681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-19T06:07:13.424235Z","caller":"traceutil/trace.go:171","msg":"trace[1660728683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4786; }","duration":"113.012012ms","start":"2026-09-19T06:07:13.31121Z","end":"2026-09-19T06:07:13.424222Z","steps":["trace[1660728683] 'agreement among raft nodes before linearized reading' (duration: 112.503311ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:13.42472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.102182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:21 size:499064"} {"level":"info","ts":"2026-09-19T06:07:13.424784Z","caller":"traceutil/trace.go:171","msg":"trace[461515378] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:21; response_revision:4786; }","duration":"110.220685ms","start":"2026-09-19T06:07:13.314547Z","end":"2026-09-19T06:07:13.424767Z","steps":["trace[461515378] 'agreement among raft nodes before linearized reading' (duration: 109.539551ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:17.109318Z","caller":"traceutil/trace.go:171","msg":"trace[212433171] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"122.446656ms","start":"2026-09-19T06:07:16.986849Z","end":"2026-09-19T06:07:17.109295Z","steps":["trace[212433171] 'process raft request' (duration: 74.069302ms)","trace[212433171] 'compare' (duration: 48.226281ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:17.109684Z","caller":"traceutil/trace.go:171","msg":"trace[856181480] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"122.753002ms","start":"2026-09-19T06:07:16.986916Z","end":"2026-09-19T06:07:17.109669Z","steps":["trace[856181480] 'process raft request' (duration: 122.592619ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:17.109792Z","caller":"traceutil/trace.go:171","msg":"trace[56042695] linearizableReadLoop","detail":"{readStateIndex:5048; appliedIndex:5045; }","duration":"101.32172ms","start":"2026-09-19T06:07:17.008458Z","end":"2026-09-19T06:07:17.10978Z","steps":["trace[56042695] 'read index received' (duration: 52.430726ms)","trace[56042695] 'applied index is now lower than readState.Index' (duration: 48.888754ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:17.109747Z","caller":"traceutil/trace.go:171","msg":"trace[1476574977] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"122.859344ms","start":"2026-09-19T06:07:16.986876Z","end":"2026-09-19T06:07:17.109735Z","steps":["trace[1476574977] 'process raft request' (duration: 122.382525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:17.110829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.330636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-19T06:07:17.110884Z","caller":"traceutil/trace.go:171","msg":"trace[287894816] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4865; }","duration":"110.421258ms","start":"2026-09-19T06:07:17.000451Z","end":"2026-09-19T06:07:17.110872Z","steps":["trace[287894816] 'agreement among raft nodes before linearized reading' (duration: 109.395296ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:17.167184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.138437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-19T06:07:17.167265Z","caller":"traceutil/trace.go:171","msg":"trace[559720426] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4866; }","duration":"156.274299ms","start":"2026-09-19T06:07:17.01097Z","end":"2026-09-19T06:07:17.167244Z","steps":["trace[559720426] 'agreement among raft nodes before linearized reading' (duration: 156.002574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:17.167541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.748751ms","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:07:17.167585Z","caller":"traceutil/trace.go:171","msg":"trace[595518826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4866; }","duration":"143.817693ms","start":"2026-09-19T06:07:17.023753Z","end":"2026-09-19T06:07:17.167571Z","steps":["trace[595518826] 'agreement among raft nodes before linearized reading' (duration: 143.69786ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:17.276816Z","caller":"traceutil/trace.go:171","msg":"trace[1208315411] linearizableReadLoop","detail":"{readStateIndex:5052; appliedIndex:5050; }","duration":"103.820152ms","start":"2026-09-19T06:07:17.172978Z","end":"2026-09-19T06:07:17.276798Z","steps":["trace[1208315411] 'read index received' (duration: 75.684044ms)","trace[1208315411] 'applied index is now lower than readState.Index' (duration: 28.135298ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:07:17.277191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.18994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:17.277282Z","caller":"traceutil/trace.go:171","msg":"trace[252644403] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4868; }","duration":"104.318533ms","start":"2026-09-19T06:07:17.172937Z","end":"2026-09-19T06:07:17.277256Z","steps":["trace[252644403] 'agreement among raft nodes before linearized reading' (duration: 104.038407ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:17.277277Z","caller":"traceutil/trace.go:171","msg":"trace[146193428] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"105.741642ms","start":"2026-09-19T06:07:17.171505Z","end":"2026-09-19T06:07:17.277247Z","steps":["trace[146193428] 'process raft request' (duration: 77.200075ms)","trace[146193428] 'compare' (duration: 27.925544ms)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:17.277568Z","caller":"traceutil/trace.go:171","msg":"trace[368698181] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"104.658859ms","start":"2026-09-19T06:07:17.172897Z","end":"2026-09-19T06:07:17.277556Z","steps":["trace[368698181] 'process raft request' (duration: 103.857272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:24.988393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.463209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e77f2d36-c12a-447f-aa1a-9a07e23e26c7\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-19T06:07:24.988491Z","caller":"traceutil/trace.go:171","msg":"trace[1683808832] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e77f2d36-c12a-447f-aa1a-9a07e23e26c7; range_end:; response_count:1; response_revision:4988; }","duration":"213.604772ms","start":"2026-09-19T06:07:24.774863Z","end":"2026-09-19T06:07:24.988468Z","steps":["trace[1683808832] 'range keys from in-memory index tree' (duration: 213.221904ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:25.11334Z","caller":"traceutil/trace.go:171","msg":"trace[1629243104] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"107.667781ms","start":"2026-09-19T06:07:25.005642Z","end":"2026-09-19T06:07:25.11331Z","steps":["trace[1629243104] 'process raft request' (duration: 102.6977ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:27.148242Z","caller":"traceutil/trace.go:171","msg":"trace[674319796] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"145.497085ms","start":"2026-09-19T06:07:27.002721Z","end":"2026-09-19T06:07:27.148218Z","steps":["trace[674319796] 'process raft request' (duration: 145.325532ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:07:39.824598Z","caller":"traceutil/trace.go:171","msg":"trace[2036564652] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"385.704426ms","start":"2026-09-19T06:07:39.438863Z","end":"2026-09-19T06:07:39.824567Z","steps":["trace[2036564652] 'read index received' (duration: 385.616765ms)","trace[2036564652] 'applied index is now lower than readState.Index' (duration: 86.781µs)"],"step_count":2} {"level":"info","ts":"2026-09-19T06:07:39.824681Z","caller":"traceutil/trace.go:171","msg":"trace[1669019640] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"388.026223ms","start":"2026-09-19T06:07:39.436632Z","end":"2026-09-19T06:07:39.824658Z","steps":["trace[1669019640] 'process raft request' (duration: 387.811649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.82502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.106845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-09-19T06:07:39.825138Z","caller":"traceutil/trace.go:171","msg":"trace[1657258362] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5175; }","duration":"386.264888ms","start":"2026-09-19T06:07:39.438838Z","end":"2026-09-19T06:07:39.825102Z","steps":["trace[1657258362] 'agreement among raft nodes before linearized reading' (duration: 385.91454ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.825372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:39.438826Z","time spent":"386.532383ms","remote":"127.0.0.1:41968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12232,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-19T06:07:39.825378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:39.436618Z","time spent":"388.670916ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-19T06:07:39.923964Z","caller":"traceutil/trace.go:171","msg":"trace[1923916623] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"250.577226ms","start":"2026-09-19T06:07:39.673363Z","end":"2026-09-19T06:07:39.92394Z","steps":["trace[1923916623] 'process raft request' (duration: 233.941522ms)","trace[1923916623] 'compare' (duration: 16.280847ms)"],"step_count":2} {"level":"warn","ts":"2026-09-19T06:07:39.92449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.100407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-19T06:07:39.924587Z","caller":"traceutil/trace.go:171","msg":"trace[157606041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5176; }","duration":"253.228589ms","start":"2026-09-19T06:07:39.671342Z","end":"2026-09-19T06:07:39.92457Z","steps":["trace[157606041] 'agreement among raft nodes before linearized reading' (duration: 253.034615ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.925008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.628108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-19T06:07:39.92509Z","caller":"traceutil/trace.go:171","msg":"trace[978458414] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5176; }","duration":"263.75427ms","start":"2026-09-19T06:07:39.661324Z","end":"2026-09-19T06:07:39.925078Z","steps":["trace[978458414] 'agreement among raft nodes before linearized reading' (duration: 263.611837ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.925378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.177499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-19T06:07:39.925465Z","caller":"traceutil/trace.go:171","msg":"trace[982645133] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5176; }","duration":"273.326722ms","start":"2026-09-19T06:07:39.652123Z","end":"2026-09-19T06:07:39.925449Z","steps":["trace[982645133] 'agreement among raft nodes before linearized reading' (duration: 273.21487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.92589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.971373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-19T06:07:39.925997Z","caller":"traceutil/trace.go:171","msg":"trace[942458977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5176; }","duration":"404.154686ms","start":"2026-09-19T06:07:39.52183Z","end":"2026-09-19T06:07:39.925985Z","steps":["trace[942458977] 'agreement among raft nodes before linearized reading' (duration: 403.965923ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.926091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:39.521811Z","time spent":"404.264329ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-19T06:07:39.926391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.27388ms","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:07:39.926494Z","caller":"traceutil/trace.go:171","msg":"trace[884408100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5176; }","duration":"437.412563ms","start":"2026-09-19T06:07:39.489066Z","end":"2026-09-19T06:07:39.926478Z","steps":["trace[884408100] 'agreement among raft nodes before linearized reading' (duration: 437.25204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:39.926584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-19T06:07:39.489045Z","time spent":"437.528126ms","remote":"127.0.0.1:42056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-19T06:07:39.926914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.054287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11741"} {"level":"info","ts":"2026-09-19T06:07:39.927016Z","caller":"traceutil/trace.go:171","msg":"trace[1004640166] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5176; }","duration":"100.21034ms","start":"2026-09-19T06:07:39.826794Z","end":"2026-09-19T06:07:39.927005Z","steps":["trace[1004640166] 'agreement among raft nodes before linearized reading' (duration: 100.016796ms)"],"step_count":1} {"level":"warn","ts":"2026-09-19T06:07:40.3537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.322361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-19T06:07:40.353781Z","caller":"traceutil/trace.go:171","msg":"trace[1255627528] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5181; }","duration":"125.447063ms","start":"2026-09-19T06:07:40.228313Z","end":"2026-09-19T06:07:40.35376Z","steps":["trace[1255627528] 'count revisions from in-memory index tree' (duration: 125.205269ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:08:00.910914Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2833} {"level":"info","ts":"2026-09-19T06:08:00.988813Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2833,"took":"76.514065ms","hash":3431639213,"current-db-size-bytes":52830208,"current-db-size":"53 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-19T06:08:00.988886Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3431639213,"revision":2833,"compact-revision":-1} {"level":"info","ts":"2026-09-19T06:10:45.011664Z","caller":"traceutil/trace.go:171","msg":"trace[1917868206] transaction","detail":"{read_only:false; response_revision:6429; number_of_response:1; }","duration":"157.987295ms","start":"2026-09-19T06:10:44.853639Z","end":"2026-09-19T06:10:45.011626Z","steps":["trace[1917868206] 'process raft request' (duration: 157.765235ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:47.616073Z","caller":"traceutil/trace.go:171","msg":"trace[128193834] transaction","detail":"{read_only:false; response_revision:6448; number_of_response:1; }","duration":"160.535184ms","start":"2026-09-19T06:10:47.455505Z","end":"2026-09-19T06:10:47.616041Z","steps":["trace[128193834] 'process raft request' (duration: 160.381347ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:50.448161Z","caller":"traceutil/trace.go:171","msg":"trace[1736100062] transaction","detail":"{read_only:false; response_revision:6470; number_of_response:1; }","duration":"121.363272ms","start":"2026-09-19T06:10:50.326776Z","end":"2026-09-19T06:10:50.44814Z","steps":["trace[1736100062] 'process raft request' (duration: 119.577911ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:10:50.458931Z","caller":"traceutil/trace.go:171","msg":"trace[1984029239] transaction","detail":"{read_only:false; response_revision:6471; number_of_response:1; }","duration":"125.412376ms","start":"2026-09-19T06:10:50.333443Z","end":"2026-09-19T06:10:50.458855Z","steps":["trace[1984029239] 'process raft request' (duration: 125.195606ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:11:16.979979Z","caller":"traceutil/trace.go:171","msg":"trace[1248990802] transaction","detail":"{read_only:false; response_revision:6755; number_of_response:1; }","duration":"290.789929ms","start":"2026-09-19T06:11:16.689165Z","end":"2026-09-19T06:11:16.979955Z","steps":["trace[1248990802] 'process raft request' (duration: 290.643653ms)"],"step_count":1} {"level":"info","ts":"2026-09-19T06:13:00.92122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5317} {"level":"info","ts":"2026-09-19T06:13:01.027963Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5317,"took":"105.794263ms","hash":2639207122,"current-db-size-bytes":52830208,"current-db-size":"53 MB","current-db-size-in-use-bytes":18644992,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-19T06:13:01.028032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2639207122,"revision":5317,"compact-revision":2833}