{"level":"warn","ts":"2026-09-29T03:43:42.83281Z","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-29T03:43:42.832896Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.80: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.80:2380","--initial-cluster=instance=https://162.253.55.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.80: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-29T03:43:42.833063Z","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-29T03:43:42.83308Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-09-29T03:43:42.834462Z","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-29T03:43:42.83773Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"]} {"level":"info","ts":"2026-09-29T03:43:42.838487Z","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.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.80: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-29T03:43:42.845202Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.062869ms"} {"level":"info","ts":"2026-09-29T03:43:42.852297Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a87e3d9cf178847b","cluster-id":"df2e96c7e71d56b9"} {"level":"info","ts":"2026-09-29T03:43:42.852459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=()"} {"level":"info","ts":"2026-09-29T03:43:42.852577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 0"} {"level":"info","ts":"2026-09-29T03:43:42.852629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a87e3d9cf178847b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-29T03:43:42.852702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 1"} {"level":"info","ts":"2026-09-29T03:43:42.852812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"warn","ts":"2026-09-29T03:43:42.870672Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-29T03:43:42.872426Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-29T03:43:42.873926Z","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-29T03:43:42.877698Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a87e3d9cf178847b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-29T03:43:42.877883Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a87e3d9cf178847b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-29T03:43:42.878636Z","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-29T03:43:42.878724Z","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-29T03:43:42.87875Z","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-29T03:43:42.886828Z","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-29T03:43:42.886943Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-09-29T03:43:42.887009Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a87e3d9cf178847b","initial-advertise-peer-urls":["https://162.253.55.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-29T03:43:42.886997Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-09-29T03:43:42.88703Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-29T03:43:42.887468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"info","ts":"2026-09-29T03:43:42.88763Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","added-peer-id":"a87e3d9cf178847b","added-peer-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-09-29T03:43:43.254043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b is starting a new election at term 1"} {"level":"info","ts":"2026-09-29T03:43:43.2541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-29T03:43:43.254259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgPreVoteResp from a87e3d9cf178847b at term 1"} {"level":"info","ts":"2026-09-29T03:43:43.254288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became candidate at term 2"} {"level":"info","ts":"2026-09-29T03:43:43.254304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgVoteResp from a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-09-29T03:43:43.254319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became leader at term 2"} {"level":"info","ts":"2026-09-29T03:43:43.254332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a87e3d9cf178847b elected leader a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-09-29T03:43:43.270836Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a87e3d9cf178847b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.80:2379]}","request-path":"/0/members/a87e3d9cf178847b/attributes","cluster-id":"df2e96c7e71d56b9","publish-timeout":"7s"} {"level":"info","ts":"2026-09-29T03:43:43.271086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:43:43.271075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-29T03:43:43.271198Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-29T03:43:43.271218Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-29T03:43:43.271313Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:43:43.272676Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:43:43.272763Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:43:43.272795Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-29T03:43:43.273837Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.80:2379"} {"level":"info","ts":"2026-09-29T03:43:43.274974Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-29T03:43:52.131193Z","caller":"traceutil/trace.go:171","msg":"trace[2058642504] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:309; }","duration":"216.212598ms","start":"2026-09-29T03:43:51.914962Z","end":"2026-09-29T03:43:52.131174Z","steps":["trace[2058642504] 'read index received' (duration: 216.009999ms)","trace[2058642504] 'applied index is now lower than readState.Index' (duration: 201.779µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:43:52.131338Z","caller":"traceutil/trace.go:171","msg":"trace[1256122473] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"258.597627ms","start":"2026-09-29T03:43:51.872639Z","end":"2026-09-29T03:43:52.131237Z","steps":["trace[1256122473] 'process raft request' (duration: 258.396558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.131487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.488277ms","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-29T03:43:52.131532Z","caller":"traceutil/trace.go:171","msg":"trace[399564420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:299; }","duration":"153.566961ms","start":"2026-09-29T03:43:51.977954Z","end":"2026-09-29T03:43:52.131521Z","steps":["trace[399564420] 'agreement among raft nodes before linearized reading' (duration: 153.504678ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.131541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.737981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-09-29T03:43:52.131622Z","caller":"traceutil/trace.go:171","msg":"trace[1409169207] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:299; }","duration":"115.857556ms","start":"2026-09-29T03:43:52.015746Z","end":"2026-09-29T03:43:52.131603Z","steps":["trace[1409169207] 'agreement among raft nodes before linearized reading' (duration: 115.691308ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.131396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.411166ms","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-29T03:43:52.131707Z","caller":"traceutil/trace.go:171","msg":"trace[1420568087] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:299; }","duration":"216.742001ms","start":"2026-09-29T03:43:51.914939Z","end":"2026-09-29T03:43:52.131681Z","steps":["trace[1420568087] 'agreement among raft nodes before linearized reading' (duration: 216.363505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.131425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.150559ms","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-29T03:43:52.131959Z","caller":"traceutil/trace.go:171","msg":"trace[292108859] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:299; }","duration":"166.682062ms","start":"2026-09-29T03:43:51.965225Z","end":"2026-09-29T03:43:52.131907Z","steps":["trace[292108859] 'agreement among raft nodes before linearized reading' (duration: 166.118687ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.413544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.532856ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:43:52.413729Z","caller":"traceutil/trace.go:171","msg":"trace[164810126] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"274.392392ms","start":"2026-09-29T03:43:52.13932Z","end":"2026-09-29T03:43:52.413712Z","steps":["trace[164810126] 'process raft request' (duration: 170.255959ms)","trace[164810126] 'compare' (duration: 103.415141ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:43:52.587558Z","caller":"traceutil/trace.go:171","msg":"trace[312493527] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"447.944526ms","start":"2026-09-29T03:43:52.139592Z","end":"2026-09-29T03:43:52.587536Z","steps":["trace[312493527] 'process raft request' (duration: 447.450114ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.587618Z","caller":"traceutil/trace.go:171","msg":"trace[527252304] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"447.920585ms","start":"2026-09-29T03:43:52.139671Z","end":"2026-09-29T03:43:52.587592Z","steps":["trace[527252304] 'process raft request' (duration: 447.786939ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.587629Z","caller":"traceutil/trace.go:171","msg":"trace[798902056] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:310; }","duration":"421.908685ms","start":"2026-09-29T03:43:52.165704Z","end":"2026-09-29T03:43:52.587613Z","steps":["trace[798902056] 'read index received' (duration: 143.947547ms)","trace[798902056] 'applied index is now lower than readState.Index' (duration: 277.960148ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:43:52.587834Z","caller":"traceutil/trace.go:171","msg":"trace[1118276067] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"448.105713ms","start":"2026-09-29T03:43:52.139704Z","end":"2026-09-29T03:43:52.58781Z","steps":["trace[1118276067] 'process raft request' (duration: 447.81377ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.587891Z","caller":"traceutil/trace.go:171","msg":"trace[424958998] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"446.977564ms","start":"2026-09-29T03:43:52.140898Z","end":"2026-09-29T03:43:52.587876Z","steps":["trace[424958998] 'process raft request' (duration: 446.66738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.587875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.164197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-09-29T03:43:52.587983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.140865Z","time spent":"447.074888ms","remote":"127.0.0.1:36156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:43:52.58799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.139648Z","time spent":"448.085592ms","remote":"127.0.0.1:35774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:43:52.588028Z","caller":"traceutil/trace.go:171","msg":"trace[1671997467] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:304; }","duration":"422.346594ms","start":"2026-09-29T03:43:52.16566Z","end":"2026-09-29T03:43:52.588007Z","steps":["trace[1671997467] 'agreement among raft nodes before linearized reading' (duration: 422.02772ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.587948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.13969Z","time spent":"448.198197ms","remote":"127.0.0.1:35832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-29T03:43:52.588087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.16564Z","time spent":"422.427018ms","remote":"127.0.0.1:35856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":242,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-09-29T03:43:52.587931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.139575Z","time spent":"448.053611ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:43:52.600307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.19164ms","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-29T03:43:52.600357Z","caller":"traceutil/trace.go:171","msg":"trace[554947665] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:305; }","duration":"184.301085ms","start":"2026-09-29T03:43:52.416044Z","end":"2026-09-29T03:43:52.600346Z","steps":["trace[554947665] 'agreement among raft nodes before linearized reading' (duration: 184.19557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.600405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.870951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-09-29T03:43:52.600426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.224993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-29T03:43:52.60045Z","caller":"traceutil/trace.go:171","msg":"trace[29453735] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:305; }","duration":"234.944674ms","start":"2026-09-29T03:43:52.365494Z","end":"2026-09-29T03:43:52.600438Z","steps":["trace[29453735] 'agreement among raft nodes before linearized reading' (duration: 234.879661ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.600493Z","caller":"traceutil/trace.go:171","msg":"trace[1570634725] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:305; }","duration":"284.37951ms","start":"2026-09-29T03:43:52.316095Z","end":"2026-09-29T03:43:52.600475Z","steps":["trace[1570634725] 'agreement among raft nodes before linearized reading' (duration: 284.17119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.600615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.306901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-09-29T03:43:52.600631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.913211ms","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-29T03:43:52.600648Z","caller":"traceutil/trace.go:171","msg":"trace[475256812] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:305; }","duration":"335.401226ms","start":"2026-09-29T03:43:52.265234Z","end":"2026-09-29T03:43:52.600635Z","steps":["trace[475256812] 'agreement among raft nodes before linearized reading' (duration: 335.354834ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.600643Z","caller":"traceutil/trace.go:171","msg":"trace[131310741] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"183.717719ms","start":"2026-09-29T03:43:52.416906Z","end":"2026-09-29T03:43:52.600623Z","steps":["trace[131310741] 'process raft request' (duration: 183.255299ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.600663Z","caller":"traceutil/trace.go:171","msg":"trace[575238111] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:305; }","duration":"384.308278ms","start":"2026-09-29T03:43:52.216345Z","end":"2026-09-29T03:43:52.600653Z","steps":["trace[575238111] 'agreement among raft nodes before linearized reading' (duration: 383.872529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.600787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.2163Z","time spent":"384.476376ms","remote":"127.0.0.1:35856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-09-29T03:43:52.600677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:43:52.265224Z","time spent":"335.446377ms","remote":"127.0.0.1:35856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":233,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-09-29T03:43:52.758984Z","caller":"traceutil/trace.go:171","msg":"trace[1152878549] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"114.057988ms","start":"2026-09-29T03:43:52.644909Z","end":"2026-09-29T03:43:52.758967Z","steps":["trace[1152878549] 'process raft request' (duration: 108.265984ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.759024Z","caller":"traceutil/trace.go:171","msg":"trace[1183657296] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"112.502009ms","start":"2026-09-29T03:43:52.646499Z","end":"2026-09-29T03:43:52.759001Z","steps":["trace[1183657296] 'process raft request' (duration: 112.405555ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782215Z","caller":"traceutil/trace.go:171","msg":"trace[988549154] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"112.605803ms","start":"2026-09-29T03:43:52.669588Z","end":"2026-09-29T03:43:52.782194Z","steps":["trace[988549154] 'process raft request' (duration: 112.497239ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782429Z","caller":"traceutil/trace.go:171","msg":"trace[1312740129] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"108.331437ms","start":"2026-09-29T03:43:52.674092Z","end":"2026-09-29T03:43:52.782423Z","steps":["trace[1312740129] 'process raft request' (duration: 108.159159ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782463Z","caller":"traceutil/trace.go:171","msg":"trace[1037007346] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"106.180983ms","start":"2026-09-29T03:43:52.676266Z","end":"2026-09-29T03:43:52.782447Z","steps":["trace[1037007346] 'process raft request' (duration: 106.019286ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782502Z","caller":"traceutil/trace.go:171","msg":"trace[1754196822] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"111.956276ms","start":"2026-09-29T03:43:52.67054Z","end":"2026-09-29T03:43:52.782496Z","steps":["trace[1754196822] 'process raft request' (duration: 111.629111ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782689Z","caller":"traceutil/trace.go:171","msg":"trace[1860113954] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"111.003494ms","start":"2026-09-29T03:43:52.67168Z","end":"2026-09-29T03:43:52.782684Z","steps":["trace[1860113954] 'process raft request' (duration: 110.528503ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.782728Z","caller":"traceutil/trace.go:171","msg":"trace[1611358894] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"106.326008ms","start":"2026-09-29T03:43:52.676391Z","end":"2026-09-29T03:43:52.782717Z","steps":["trace[1611358894] 'process raft request' (duration: 105.926171ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.783519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.51825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-29T03:43:52.783585Z","caller":"traceutil/trace.go:171","msg":"trace[385977468] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:327; }","duration":"112.647336ms","start":"2026-09-29T03:43:52.670925Z","end":"2026-09-29T03:43:52.783572Z","steps":["trace[385977468] 'agreement among raft nodes before linearized reading' (duration: 111.935835ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.943658Z","caller":"traceutil/trace.go:171","msg":"trace[445839437] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"157.748171ms","start":"2026-09-29T03:43:52.785879Z","end":"2026-09-29T03:43:52.943627Z","steps":["trace[445839437] 'process raft request' (duration: 94.786833ms)","trace[445839437] 'compare' (duration: 62.788861ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:43:52.943721Z","caller":"traceutil/trace.go:171","msg":"trace[658215515] linearizableReadLoop","detail":"{readStateIndex:343; appliedIndex:339; }","duration":"112.099752ms","start":"2026-09-29T03:43:52.831604Z","end":"2026-09-29T03:43:52.943704Z","steps":["trace[658215515] 'read index received' (duration: 49.07492ms)","trace[658215515] 'applied index is now lower than readState.Index' (duration: 63.022092ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:43:52.943732Z","caller":"traceutil/trace.go:171","msg":"trace[448988296] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"155.513904ms","start":"2026-09-29T03:43:52.788195Z","end":"2026-09-29T03:43:52.943709Z","steps":["trace[448988296] 'process raft request' (duration: 155.375738ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.943853Z","caller":"traceutil/trace.go:171","msg":"trace[824528062] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"152.24945ms","start":"2026-09-29T03:43:52.791557Z","end":"2026-09-29T03:43:52.943807Z","steps":["trace[824528062] 'process raft request' (duration: 152.064342ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:43:52.943928Z","caller":"traceutil/trace.go:171","msg":"trace[1076463668] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"123.737611ms","start":"2026-09-29T03:43:52.820164Z","end":"2026-09-29T03:43:52.943902Z","steps":["trace[1076463668] 'process raft request' (duration: 123.495071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:43:52.944186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.564152ms","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-29T03:43:52.944226Z","caller":"traceutil/trace.go:171","msg":"trace[957580831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:332; }","duration":"112.633215ms","start":"2026-09-29T03:43:52.831583Z","end":"2026-09-29T03:43:52.944216Z","steps":["trace[957580831] 'agreement among raft nodes before linearized reading' (duration: 112.209977ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:33.342061Z","caller":"traceutil/trace.go:171","msg":"trace[19666094] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"128.763151ms","start":"2026-09-29T03:44:33.213274Z","end":"2026-09-29T03:44:33.342037Z","steps":["trace[19666094] 'read index received' (duration: 128.683189ms)","trace[19666094] 'applied index is now lower than readState.Index' (duration: 78.972µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:33.342123Z","caller":"traceutil/trace.go:171","msg":"trace[360334045] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"143.605414ms","start":"2026-09-29T03:44:33.198483Z","end":"2026-09-29T03:44:33.342089Z","steps":["trace[360334045] 'process raft request' (duration: 143.427289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:33.342311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.014768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-29T03:44:33.34236Z","caller":"traceutil/trace.go:171","msg":"trace[2129518088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:606; }","duration":"129.137462ms","start":"2026-09-29T03:44:33.213209Z","end":"2026-09-29T03:44:33.342346Z","steps":["trace[2129518088] 'agreement among raft nodes before linearized reading' (duration: 128.947437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:33.595747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.967578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:44:33.595848Z","caller":"traceutil/trace.go:171","msg":"trace[2142805286] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"239.805367ms","start":"2026-09-29T03:44:33.356028Z","end":"2026-09-29T03:44:33.595833Z","steps":["trace[2142805286] 'read index received' (duration: 84.612962ms)","trace[2142805286] 'applied index is now lower than readState.Index' (duration: 155.191275ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:44:33.595926Z","caller":"traceutil/trace.go:171","msg":"trace[784045701] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"248.875576ms","start":"2026-09-29T03:44:33.34704Z","end":"2026-09-29T03:44:33.595916Z","steps":["trace[784045701] 'process raft request' (duration: 93.657871ms)","trace[784045701] 'compare' (duration: 154.837284ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:44:33.596116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.073375ms","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-29T03:44:33.596204Z","caller":"traceutil/trace.go:171","msg":"trace[1853239897] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:607; }","duration":"240.23275ms","start":"2026-09-29T03:44:33.35595Z","end":"2026-09-29T03:44:33.596183Z","steps":["trace[1853239897] 'agreement among raft nodes before linearized reading' (duration: 240.097096ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:33.596219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.796347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T03:44:33.596265Z","caller":"traceutil/trace.go:171","msg":"trace[1008628890] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"172.985212ms","start":"2026-09-29T03:44:33.423267Z","end":"2026-09-29T03:44:33.596253Z","steps":["trace[1008628890] 'agreement among raft nodes before linearized reading' (duration: 172.788236ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:34.095685Z","caller":"traceutil/trace.go:171","msg":"trace[173810654] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"294.343398ms","start":"2026-09-29T03:44:33.801275Z","end":"2026-09-29T03:44:34.095618Z","steps":["trace[173810654] 'process raft request' (duration: 294.108122ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:34.65778Z","caller":"traceutil/trace.go:171","msg":"trace[1041755687] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"651.858284ms","start":"2026-09-29T03:44:34.005886Z","end":"2026-09-29T03:44:34.657745Z","steps":["trace[1041755687] 'process raft request' (duration: 650.584148ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:34.658002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:34.005853Z","time spent":"652.027679ms","remote":"127.0.0.1:35770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:44:36.079354Z","caller":"traceutil/trace.go:171","msg":"trace[1100433614] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"133.56705ms","start":"2026-09-29T03:44:35.94577Z","end":"2026-09-29T03:44:36.079337Z","steps":["trace[1100433614] 'process raft request' (duration: 133.448987ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:49.219548Z","caller":"traceutil/trace.go:171","msg":"trace[1925476814] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"314.566238ms","start":"2026-09-29T03:44:48.904958Z","end":"2026-09-29T03:44:49.219524Z","steps":["trace[1925476814] 'process raft request' (duration: 314.430934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:49.219727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:44:48.904927Z","time spent":"314.696151ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:44:51.9044Z","caller":"traceutil/trace.go:171","msg":"trace[1461280024] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"201.348122ms","start":"2026-09-29T03:44:51.703029Z","end":"2026-09-29T03:44:51.904377Z","steps":["trace[1461280024] 'process raft request' (duration: 201.196089ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:44:51.904586Z","caller":"traceutil/trace.go:171","msg":"trace[720915943] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"197.96281ms","start":"2026-09-29T03:44:51.706612Z","end":"2026-09-29T03:44:51.904575Z","steps":["trace[720915943] 'read index received' (duration: 197.52919ms)","trace[720915943] 'applied index is now lower than readState.Index' (duration: 432.86µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:44:51.904781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.148705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T03:44:51.904826Z","caller":"traceutil/trace.go:171","msg":"trace[1547634492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:778; }","duration":"198.230447ms","start":"2026-09-29T03:44:51.706585Z","end":"2026-09-29T03:44:51.904816Z","steps":["trace[1547634492] 'agreement among raft nodes before linearized reading' (duration: 198.056033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:51.904923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.064433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:44:51.904956Z","caller":"traceutil/trace.go:171","msg":"trace[976131983] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"127.134835ms","start":"2026-09-29T03:44:51.777813Z","end":"2026-09-29T03:44:51.904948Z","steps":["trace[976131983] 'agreement among raft nodes before linearized reading' (duration: 127.083504ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:44:51.905139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.220848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:44:51.905176Z","caller":"traceutil/trace.go:171","msg":"trace[848608574] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:778; }","duration":"127.30371ms","start":"2026-09-29T03:44:51.777865Z","end":"2026-09-29T03:44:51.905168Z","steps":["trace[848608574] 'agreement among raft nodes before linearized reading' (duration: 127.250058ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:45:13.349931Z","caller":"traceutil/trace.go:171","msg":"trace[1496939346] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"108.353355ms","start":"2026-09-29T03:45:13.241514Z","end":"2026-09-29T03:45:13.349867Z","steps":["trace[1496939346] 'process raft request' (duration: 99.122415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:45:13.562135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.717632ms","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-29T03:45:13.562223Z","caller":"traceutil/trace.go:171","msg":"trace[2104370352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1092; }","duration":"106.850555ms","start":"2026-09-29T03:45:13.455352Z","end":"2026-09-29T03:45:13.562203Z","steps":["trace[2104370352] 'range keys from in-memory index tree' (duration: 106.554558ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:45:24.362372Z","caller":"traceutil/trace.go:171","msg":"trace[658158827] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"235.106194ms","start":"2026-09-29T03:45:24.127252Z","end":"2026-09-29T03:45:24.362358Z","steps":["trace[658158827] 'process raft request' (duration: 234.89132ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:45:24.3623Z","caller":"traceutil/trace.go:171","msg":"trace[794376494] linearizableReadLoop","detail":"{readStateIndex:1224; appliedIndex:1223; }","duration":"227.160651ms","start":"2026-09-29T03:45:24.135119Z","end":"2026-09-29T03:45:24.36228Z","steps":["trace[794376494] 'read index received' (duration: 226.965798ms)","trace[794376494] 'applied index is now lower than readState.Index' (duration: 193.993µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:45:24.362818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.689282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-29T03:45:24.36288Z","caller":"traceutil/trace.go:171","msg":"trace[119518489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1186; }","duration":"227.823184ms","start":"2026-09-29T03:45:24.135041Z","end":"2026-09-29T03:45:24.362864Z","steps":["trace[119518489] 'agreement among raft nodes before linearized reading' (duration: 227.621431ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:45:24.3629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.050363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-29T03:45:24.362965Z","caller":"traceutil/trace.go:171","msg":"trace[1980534025] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1186; }","duration":"135.118324ms","start":"2026-09-29T03:45:24.227827Z","end":"2026-09-29T03:45:24.362945Z","steps":["trace[1980534025] 'agreement among raft nodes before linearized reading' (duration: 135.005282ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:45:24.363348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.866501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-29T03:45:24.363458Z","caller":"traceutil/trace.go:171","msg":"trace[2080135634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1186; }","duration":"133.115875ms","start":"2026-09-29T03:45:24.230318Z","end":"2026-09-29T03:45:24.363434Z","steps":["trace[2080135634] 'agreement among raft nodes before linearized reading' (duration: 132.617386ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:16.001688Z","caller":"traceutil/trace.go:171","msg":"trace[1809024603] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"126.341169ms","start":"2026-09-29T03:46:15.875321Z","end":"2026-09-29T03:46:16.001662Z","steps":["trace[1809024603] 'read index received' (duration: 126.138776ms)","trace[1809024603] 'applied index is now lower than readState.Index' (duration: 201.443µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:16.001815Z","caller":"traceutil/trace.go:171","msg":"trace[1915619360] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"268.426624ms","start":"2026-09-29T03:46:15.733305Z","end":"2026-09-29T03:46:16.001732Z","steps":["trace[1915619360] 'process raft request' (duration: 268.216911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:16.001901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.552472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-29T03:46:16.002075Z","caller":"traceutil/trace.go:171","msg":"trace[320453274] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"126.798226ms","start":"2026-09-29T03:46:15.87526Z","end":"2026-09-29T03:46:16.002058Z","steps":["trace[320453274] 'agreement among raft nodes before linearized reading' (duration: 126.504982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:16.703195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.803549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:46:16.703333Z","caller":"traceutil/trace.go:171","msg":"trace[1866373750] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"382.279235ms","start":"2026-09-29T03:46:16.321039Z","end":"2026-09-29T03:46:16.703318Z","steps":["trace[1866373750] 'read index received' (duration: 30.281313ms)","trace[1866373750] 'applied index is now lower than readState.Index' (duration: 351.996762ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:16.703596Z","caller":"traceutil/trace.go:171","msg":"trace[1173737801] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"619.888665ms","start":"2026-09-29T03:46:16.083662Z","end":"2026-09-29T03:46:16.703551Z","steps":["trace[1173737801] 'process raft request' (duration: 267.639599ms)","trace[1173737801] 'compare' (duration: 351.696277ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:46:16.703764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.711362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0504f89-8b6f-4034-9dff-6f0d0e609d54\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-29T03:46:16.703861Z","caller":"traceutil/trace.go:171","msg":"trace[1460057703] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b0504f89-8b6f-4034-9dff-6f0d0e609d54; range_end:; response_count:1; response_revision:1881; }","duration":"382.842064ms","start":"2026-09-29T03:46:16.320988Z","end":"2026-09-29T03:46:16.70383Z","steps":["trace[1460057703] 'agreement among raft nodes before linearized reading' (duration: 382.58216ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:16.703906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:16.320962Z","time spent":"382.935816ms","remote":"127.0.0.1:35846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0504f89-8b6f-4034-9dff-6f0d0e609d54\" "} {"level":"warn","ts":"2026-09-29T03:46:16.704653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:16.08364Z","time spent":"620.039167ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:46:30.01776Z","caller":"traceutil/trace.go:171","msg":"trace[558796972] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"100.963049ms","start":"2026-09-29T03:46:29.916758Z","end":"2026-09-29T03:46:30.017721Z","steps":["trace[558796972] 'process raft request' (duration: 100.789887ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:30.246492Z","caller":"traceutil/trace.go:171","msg":"trace[165934858] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"200.365059ms","start":"2026-09-29T03:46:30.046095Z","end":"2026-09-29T03:46:30.24646Z","steps":["trace[165934858] 'process raft request' (duration: 189.718306ms)","trace[165934858] 'compare' (duration: 10.4373ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:30.247305Z","caller":"traceutil/trace.go:171","msg":"trace[1042726170] linearizableReadLoop","detail":"{readStateIndex:2083; appliedIndex:2080; }","duration":"170.249657ms","start":"2026-09-29T03:46:30.077026Z","end":"2026-09-29T03:46:30.247276Z","steps":["trace[1042726170] 'read index received' (duration: 158.930776ms)","trace[1042726170] 'applied index is now lower than readState.Index' (duration: 11.317961ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:30.247586Z","caller":"traceutil/trace.go:171","msg":"trace[1223132852] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"201.430355ms","start":"2026-09-29T03:46:30.046142Z","end":"2026-09-29T03:46:30.247573Z","steps":["trace[1223132852] 'process raft request' (duration: 200.883627ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:30.247832Z","caller":"traceutil/trace.go:171","msg":"trace[1647163604] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"199.405735ms","start":"2026-09-29T03:46:30.048416Z","end":"2026-09-29T03:46:30.247822Z","steps":["trace[1647163604] 'process raft request' (duration: 198.766876ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:30.248058Z","caller":"traceutil/trace.go:171","msg":"trace[324084114] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"114.725603ms","start":"2026-09-29T03:46:30.133323Z","end":"2026-09-29T03:46:30.248049Z","steps":["trace[324084114] 'process raft request' (duration: 113.912601ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:30.248307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.264162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-29T03:46:30.248351Z","caller":"traceutil/trace.go:171","msg":"trace[267755624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2004; }","duration":"171.344434ms","start":"2026-09-29T03:46:30.076995Z","end":"2026-09-29T03:46:30.248339Z","steps":["trace[267755624] 'agreement among raft nodes before linearized reading' (duration: 171.208082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:30.248519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.323148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-29T03:46:30.248555Z","caller":"traceutil/trace.go:171","msg":"trace[1729121160] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2004; }","duration":"142.371599ms","start":"2026-09-29T03:46:30.106173Z","end":"2026-09-29T03:46:30.248544Z","steps":["trace[1729121160] 'agreement among raft nodes before linearized reading' (duration: 142.285837ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:30.935344Z","caller":"traceutil/trace.go:171","msg":"trace[1439626293] linearizableReadLoop","detail":"{readStateIndex:2087; appliedIndex:2086; }","duration":"131.99785ms","start":"2026-09-29T03:46:30.8033Z","end":"2026-09-29T03:46:30.935298Z","steps":["trace[1439626293] 'read index received' (duration: 131.809287ms)","trace[1439626293] 'applied index is now lower than readState.Index' (duration: 187.253µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:30.93541Z","caller":"traceutil/trace.go:171","msg":"trace[506218446] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"154.158277ms","start":"2026-09-29T03:46:30.781227Z","end":"2026-09-29T03:46:30.935385Z","steps":["trace[506218446] 'process raft request' (duration: 153.889183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:30.93562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.304134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T03:46:30.935712Z","caller":"traceutil/trace.go:171","msg":"trace[1910064035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2007; }","duration":"132.438427ms","start":"2026-09-29T03:46:30.803252Z","end":"2026-09-29T03:46:30.93569Z","steps":["trace[1910064035] 'agreement among raft nodes before linearized reading' (duration: 132.176883ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:30.950283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.018278ms","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-29T03:46:30.950342Z","caller":"traceutil/trace.go:171","msg":"trace[518789380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2008; }","duration":"136.088919ms","start":"2026-09-29T03:46:30.814236Z","end":"2026-09-29T03:46:30.950325Z","steps":["trace[518789380] 'agreement among raft nodes before linearized reading' (duration: 135.864456ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:30.950426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.396894ms","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-29T03:46:30.950482Z","caller":"traceutil/trace.go:171","msg":"trace[1811091503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2008; }","duration":"120.519255ms","start":"2026-09-29T03:46:30.829948Z","end":"2026-09-29T03:46:30.950467Z","steps":["trace[1811091503] 'agreement among raft nodes before linearized reading' (duration: 120.262721ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.220019Z","caller":"traceutil/trace.go:171","msg":"trace[221850957] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"163.482989ms","start":"2026-09-29T03:46:55.056515Z","end":"2026-09-29T03:46:55.219998Z","steps":["trace[221850957] 'process raft request' (duration: 163.356077ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.484262Z","caller":"traceutil/trace.go:171","msg":"trace[1754447099] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"423.735819ms","start":"2026-09-29T03:46:55.060432Z","end":"2026-09-29T03:46:55.484168Z","steps":["trace[1754447099] 'process raft request' (duration: 423.555367ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.484529Z","caller":"traceutil/trace.go:171","msg":"trace[1472704207] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2227; }","duration":"397.298844ms","start":"2026-09-29T03:46:55.087211Z","end":"2026-09-29T03:46:55.48451Z","steps":["trace[1472704207] 'read index received' (duration: 132.610664ms)","trace[1472704207] 'applied index is now lower than readState.Index' (duration: 264.68682ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:55.484713Z","caller":"traceutil/trace.go:171","msg":"trace[686373033] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"412.946363ms","start":"2026-09-29T03:46:55.071756Z","end":"2026-09-29T03:46:55.484703Z","steps":["trace[686373033] 'process raft request' (duration: 412.366235ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:55.484787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:55.071744Z","time spent":"412.997014ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:46:55.484812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:55.060419Z","time spent":"423.914371ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-29T03:46:55.484925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.650451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-09-29T03:46:55.484929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.757443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-29T03:46:55.484993Z","caller":"traceutil/trace.go:171","msg":"trace[1921883594] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2144; }","duration":"395.768863ms","start":"2026-09-29T03:46:55.089207Z","end":"2026-09-29T03:46:55.484976Z","steps":["trace[1921883594] 'agreement among raft nodes before linearized reading' (duration: 395.53746ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.485014Z","caller":"traceutil/trace.go:171","msg":"trace[1625985552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2144; }","duration":"395.878784ms","start":"2026-09-29T03:46:55.089112Z","end":"2026-09-29T03:46:55.484991Z","steps":["trace[1625985552] 'agreement among raft nodes before linearized reading' (duration: 395.60134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:55.485047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:55.089196Z","time spent":"395.837964ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-29T03:46:55.485058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:55.08904Z","time spent":"396.007276ms","remote":"127.0.0.1:35928","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-29T03:46:55.485006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.74609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-09-29T03:46:55.485158Z","caller":"traceutil/trace.go:171","msg":"trace[788757718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2144; }","duration":"397.954232ms","start":"2026-09-29T03:46:55.087177Z","end":"2026-09-29T03:46:55.485131Z","steps":["trace[788757718] 'agreement among raft nodes before linearized reading' (duration: 397.493396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:55.485231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:46:55.087163Z","time spent":"398.055873ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-29T03:46:55.743163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.960366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:46:55.743363Z","caller":"traceutil/trace.go:171","msg":"trace[1890627073] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"252.943733ms","start":"2026-09-29T03:46:55.490401Z","end":"2026-09-29T03:46:55.743345Z","steps":["trace[1890627073] 'process raft request' (duration: 252.861961ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.743434Z","caller":"traceutil/trace.go:171","msg":"trace[345442547] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"253.967146ms","start":"2026-09-29T03:46:55.489421Z","end":"2026-09-29T03:46:55.743388Z","steps":["trace[345442547] 'process raft request' (duration: 60.684826ms)","trace[345442547] 'compare' (duration: 192.853974ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:46:55.743725Z","caller":"traceutil/trace.go:171","msg":"trace[549043976] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2230; }","duration":"132.082557ms","start":"2026-09-29T03:46:55.61163Z","end":"2026-09-29T03:46:55.743712Z","steps":["trace[549043976] 'read index received' (duration: 93.982604ms)","trace[549043976] 'applied index is now lower than readState.Index' (duration: 38.098682ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:46:55.743794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.169148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:46:55.743781Z","caller":"traceutil/trace.go:171","msg":"trace[1412815605] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"253.195646ms","start":"2026-09-29T03:46:55.490566Z","end":"2026-09-29T03:46:55.743761Z","steps":["trace[1412815605] 'process raft request' (duration: 252.74493ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.743827Z","caller":"traceutil/trace.go:171","msg":"trace[2135128534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2147; }","duration":"132.246979ms","start":"2026-09-29T03:46:55.611569Z","end":"2026-09-29T03:46:55.743816Z","steps":["trace[2135128534] 'agreement among raft nodes before linearized reading' (duration: 132.193168ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:46:55.746429Z","caller":"traceutil/trace.go:171","msg":"trace[1798598972] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"133.80584ms","start":"2026-09-29T03:46:55.612585Z","end":"2026-09-29T03:46:55.746391Z","steps":["trace[1798598972] 'process raft request' (duration: 133.540946ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:46:56.005404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.432878ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:46:56.005688Z","caller":"traceutil/trace.go:171","msg":"trace[580472822] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2148; }","duration":"128.781563ms","start":"2026-09-29T03:46:55.876875Z","end":"2026-09-29T03:46:56.005656Z","steps":["trace[580472822] 'range keys from in-memory index tree' (duration: 128.398078ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:48:32.445966Z","caller":"traceutil/trace.go:171","msg":"trace[1889131038] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"349.150553ms","start":"2026-09-29T03:48:32.096783Z","end":"2026-09-29T03:48:32.445934Z","steps":["trace[1889131038] 'process raft request' (duration: 348.919286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:48:32.44641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:48:32.096758Z","time spent":"349.425482ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:48:32.459669Z","caller":"traceutil/trace.go:171","msg":"trace[91190067] linearizableReadLoop","detail":"{readStateIndex:2865; appliedIndex:2863; }","duration":"227.26195ms","start":"2026-09-29T03:48:32.23239Z","end":"2026-09-29T03:48:32.459652Z","steps":["trace[91190067] 'read index received' (duration: 213.377366ms)","trace[91190067] 'applied index is now lower than readState.Index' (duration: 13.883424ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:48:32.459709Z","caller":"traceutil/trace.go:171","msg":"trace[1592080083] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"261.069099ms","start":"2026-09-29T03:48:32.198617Z","end":"2026-09-29T03:48:32.459686Z","steps":["trace[1592080083] 'process raft request' (duration: 260.926374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:48:32.459971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.57389ms","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-29T03:48:32.460147Z","caller":"traceutil/trace.go:171","msg":"trace[998093613] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2757; }","duration":"227.806957ms","start":"2026-09-29T03:48:32.232323Z","end":"2026-09-29T03:48:32.46013Z","steps":["trace[998093613] 'agreement among raft nodes before linearized reading' (duration: 227.433186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:48:32.460254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.053444ms","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-29T03:48:32.460331Z","caller":"traceutil/trace.go:171","msg":"trace[1636073047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2757; }","duration":"150.164838ms","start":"2026-09-29T03:48:32.310147Z","end":"2026-09-29T03:48:32.460312Z","steps":["trace[1636073047] 'agreement among raft nodes before linearized reading' (duration: 149.960932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:48:32.460548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.217445ms","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-29T03:48:32.46059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.767404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T03:48:32.460668Z","caller":"traceutil/trace.go:171","msg":"trace[1056300544] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2757; }","duration":"186.885567ms","start":"2026-09-29T03:48:32.27377Z","end":"2026-09-29T03:48:32.460656Z","steps":["trace[1056300544] 'agreement among raft nodes before linearized reading' (duration: 186.211976ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:48:32.460644Z","caller":"traceutil/trace.go:171","msg":"trace[44306699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2757; }","duration":"162.37279ms","start":"2026-09-29T03:48:32.298251Z","end":"2026-09-29T03:48:32.460623Z","steps":["trace[44306699] 'agreement among raft nodes before linearized reading' (duration: 161.962637ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:52:43.768373Z","caller":"traceutil/trace.go:171","msg":"trace[1091067267] transaction","detail":"{read_only:false; response_revision:4223; number_of_response:1; }","duration":"100.652842ms","start":"2026-09-29T03:52:43.667695Z","end":"2026-09-29T03:52:43.768347Z","steps":["trace[1091067267] 'process raft request' (duration: 37.24355ms)","trace[1091067267] 'compare' (duration: 62.733161ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:23.44948Z","caller":"traceutil/trace.go:171","msg":"trace[230404860] transaction","detail":"{read_only:false; response_revision:4480; number_of_response:1; }","duration":"152.327829ms","start":"2026-09-29T03:53:23.297129Z","end":"2026-09-29T03:53:23.449457Z","steps":["trace[230404860] 'process raft request' (duration: 140.154151ms)","trace[230404860] 'compare' (duration: 12.072877ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:37.476417Z","caller":"traceutil/trace.go:171","msg":"trace[414957915] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"361.487111ms","start":"2026-09-29T03:53:37.114893Z","end":"2026-09-29T03:53:37.47638Z","steps":["trace[414957915] 'process raft request' (duration: 357.08839ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.47663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-29T03:53:37.114867Z","time spent":"361.664884ms","remote":"127.0.0.1:35928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-29T03:53:37.512753Z","caller":"traceutil/trace.go:171","msg":"trace[1272972443] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"262.043309ms","start":"2026-09-29T03:53:37.25068Z","end":"2026-09-29T03:53:37.512723Z","steps":["trace[1272972443] 'process raft request' (duration: 261.754594ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:37.512925Z","caller":"traceutil/trace.go:171","msg":"trace[1574222920] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5220; }","duration":"145.870289ms","start":"2026-09-29T03:53:37.367033Z","end":"2026-09-29T03:53:37.512903Z","steps":["trace[1574222920] 'read index received' (duration: 104.966371ms)","trace[1574222920] 'applied index is now lower than readState.Index' (duration: 40.901988ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:37.513014Z","caller":"traceutil/trace.go:171","msg":"trace[1971269666] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"109.478993ms","start":"2026-09-29T03:53:37.403501Z","end":"2026-09-29T03:53:37.51298Z","steps":["trace[1971269666] 'process raft request' (duration: 109.167578ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.513156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.111853ms","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-29T03:53:37.513191Z","caller":"traceutil/trace.go:171","msg":"trace[1927300605] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5027; }","duration":"146.197173ms","start":"2026-09-29T03:53:37.366983Z","end":"2026-09-29T03:53:37.51318Z","steps":["trace[1927300605] 'agreement among raft nodes before linearized reading' (duration: 146.00724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.552441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.916737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a460e4a7-f15a-4ab9-b163-8534ea98f33b\" ","response":"range_response_count:1 size:4046"} {"level":"info","ts":"2026-09-29T03:53:37.552545Z","caller":"traceutil/trace.go:171","msg":"trace[1811880556] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a460e4a7-f15a-4ab9-b163-8534ea98f33b; range_end:; response_count:1; response_revision:5028; }","duration":"180.063339ms","start":"2026-09-29T03:53:37.372461Z","end":"2026-09-29T03:53:37.552524Z","steps":["trace[1811880556] 'agreement among raft nodes before linearized reading' (duration: 179.767954ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:37.552559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.342207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-rz9mq\" ","response":"range_response_count:1 size:9753"} {"level":"info","ts":"2026-09-29T03:53:37.552626Z","caller":"traceutil/trace.go:171","msg":"trace[1878212986] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-rz9mq; range_end:; response_count:1; response_revision:5028; }","duration":"151.463969ms","start":"2026-09-29T03:53:37.401142Z","end":"2026-09-29T03:53:37.552606Z","steps":["trace[1878212986] 'agreement among raft nodes before linearized reading' (duration: 151.262406ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:43.385131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2823} {"level":"info","ts":"2026-09-29T03:53:43.533987Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2823,"took":"147.548995ms","hash":2206813122,"current-db-size-bytes":51908608,"current-db-size":"52 MB","current-db-size-in-use-bytes":26525696,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-29T03:53:43.534074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2206813122,"revision":2823,"compact-revision":-1} {"level":"warn","ts":"2026-09-29T03:53:44.000992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.101725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-29T03:53:44.001089Z","caller":"traceutil/trace.go:171","msg":"trace[220150471] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5108; }","duration":"168.251177ms","start":"2026-09-29T03:53:43.832815Z","end":"2026-09-29T03:53:44.001066Z","steps":["trace[220150471] 'count revisions from in-memory index tree' (duration: 167.949173ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:44.279039Z","caller":"traceutil/trace.go:171","msg":"trace[1170563020] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5309; }","duration":"191.68482ms","start":"2026-09-29T03:53:44.087334Z","end":"2026-09-29T03:53:44.279019Z","steps":["trace[1170563020] 'read index received' (duration: 191.505357ms)","trace[1170563020] 'applied index is now lower than readState.Index' (duration: 178.623µs)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:53:44.279253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.908793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-29T03:53:44.279289Z","caller":"traceutil/trace.go:171","msg":"trace[117439528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5109; }","duration":"191.995805ms","start":"2026-09-29T03:53:44.087284Z","end":"2026-09-29T03:53:44.279279Z","steps":["trace[117439528] 'agreement among raft nodes before linearized reading' (duration: 191.837673ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:44.279275Z","caller":"traceutil/trace.go:171","msg":"trace[643336236] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"244.836572ms","start":"2026-09-29T03:53:44.03442Z","end":"2026-09-29T03:53:44.279256Z","steps":["trace[643336236] 'process raft request' (duration: 244.459876ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:44.279556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.658041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-09-29T03:53:44.279543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.366947ms","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-29T03:53:44.279708Z","caller":"traceutil/trace.go:171","msg":"trace[1137619765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5109; }","duration":"173.59315ms","start":"2026-09-29T03:53:44.106091Z","end":"2026-09-29T03:53:44.279684Z","steps":["trace[1137619765] 'agreement among raft nodes before linearized reading' (duration: 173.226454ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:44.279643Z","caller":"traceutil/trace.go:171","msg":"trace[1776066695] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5109; }","duration":"158.793993ms","start":"2026-09-29T03:53:44.120831Z","end":"2026-09-29T03:53:44.279625Z","steps":["trace[1776066695] 'agreement among raft nodes before linearized reading' (duration: 158.515098ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:44.628188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.42423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-29T03:53:44.628375Z","caller":"traceutil/trace.go:171","msg":"trace[1635314046] linearizableReadLoop","detail":"{readStateIndex:5314; appliedIndex:5313; }","duration":"161.371075ms","start":"2026-09-29T03:53:44.466988Z","end":"2026-09-29T03:53:44.628359Z","steps":["trace[1635314046] 'read index received' (duration: 25.62073ms)","trace[1635314046] 'applied index is now lower than readState.Index' (duration: 135.748885ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:44.628537Z","caller":"traceutil/trace.go:171","msg":"trace[1917343496] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"183.309607ms","start":"2026-09-29T03:53:44.445127Z","end":"2026-09-29T03:53:44.628437Z","steps":["trace[1917343496] 'process raft request' (duration: 47.571822ms)","trace[1917343496] 'compare' (duration: 135.274947ms)"],"step_count":2} {"level":"warn","ts":"2026-09-29T03:53:44.628673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.664169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-09-29T03:53:44.628744Z","caller":"traceutil/trace.go:171","msg":"trace[985873915] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5113; }","duration":"161.780082ms","start":"2026-09-29T03:53:44.466944Z","end":"2026-09-29T03:53:44.628724Z","steps":["trace[985873915] 'agreement among raft nodes before linearized reading' (duration: 161.534398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:53:44.629038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.253647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-29T03:53:44.629099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.16618ms","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-29T03:53:44.629148Z","caller":"traceutil/trace.go:171","msg":"trace[162167446] 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:5113; }","duration":"101.246192ms","start":"2026-09-29T03:53:44.527887Z","end":"2026-09-29T03:53:44.629133Z","steps":["trace[162167446] 'agreement among raft nodes before linearized reading' (duration: 101.09206ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:44.629119Z","caller":"traceutil/trace.go:171","msg":"trace[489307367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5113; }","duration":"155.38822ms","start":"2026-09-29T03:53:44.473718Z","end":"2026-09-29T03:53:44.629107Z","steps":["trace[489307367] 'agreement among raft nodes before linearized reading' (duration: 155.152966ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:44.815253Z","caller":"traceutil/trace.go:171","msg":"trace[825838062] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"172.661346ms","start":"2026-09-29T03:53:44.642556Z","end":"2026-09-29T03:53:44.815217Z","steps":["trace[825838062] 'process raft request' (duration: 104.951731ms)","trace[825838062] 'compare' (duration: 67.546153ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:53:45.074751Z","caller":"traceutil/trace.go:171","msg":"trace[227539128] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"244.401545ms","start":"2026-09-29T03:53:44.830327Z","end":"2026-09-29T03:53:45.074729Z","steps":["trace[227539128] 'process raft request' (duration: 244.164441ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:45.075085Z","caller":"traceutil/trace.go:171","msg":"trace[1811129629] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"244.569927ms","start":"2026-09-29T03:53:44.83049Z","end":"2026-09-29T03:53:45.07506Z","steps":["trace[1811129629] 'process raft request' (duration: 244.181731ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:53:45.075278Z","caller":"traceutil/trace.go:171","msg":"trace[1418979597] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"237.840989ms","start":"2026-09-29T03:53:44.837391Z","end":"2026-09-29T03:53:45.075232Z","steps":["trace[1418979597] 'process raft request' (duration: 237.578295ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:14.552125Z","caller":"traceutil/trace.go:171","msg":"trace[1601822423] linearizableReadLoop","detail":"{readStateIndex:5636; appliedIndex:5635; }","duration":"104.268089ms","start":"2026-09-29T03:54:14.447835Z","end":"2026-09-29T03:54:14.552103Z","steps":["trace[1601822423] 'read index received' (duration: 104.053456ms)","trace[1601822423] 'applied index is now lower than readState.Index' (duration: 213.563µs)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:14.55219Z","caller":"traceutil/trace.go:171","msg":"trace[635599847] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"156.468809ms","start":"2026-09-29T03:54:14.395692Z","end":"2026-09-29T03:54:14.552161Z","steps":["trace[635599847] 'process raft request' (duration: 156.270096ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:14.553836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.974806ms","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-29T03:54:14.553965Z","caller":"traceutil/trace.go:171","msg":"trace[1002042384] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5427; }","duration":"106.154148ms","start":"2026-09-29T03:54:14.447788Z","end":"2026-09-29T03:54:14.553942Z","steps":["trace[1002042384] 'agreement among raft nodes before linearized reading' (duration: 104.415911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:56.91039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.045237ms","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-29T03:54:56.910547Z","caller":"traceutil/trace.go:171","msg":"trace[1533784374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5784; }","duration":"105.21013ms","start":"2026-09-29T03:54:56.805279Z","end":"2026-09-29T03:54:56.910489Z","steps":["trace[1533784374] 'range keys from in-memory index tree' (duration: 104.954416ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:57.027456Z","caller":"traceutil/trace.go:171","msg":"trace[764499651] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"112.36768ms","start":"2026-09-29T03:54:56.915043Z","end":"2026-09-29T03:54:57.027411Z","steps":["trace[764499651] 'process raft request' (duration: 112.210878ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:57.029048Z","caller":"traceutil/trace.go:171","msg":"trace[1685682796] transaction","detail":"{read_only:false; response_revision:5786; number_of_response:1; }","duration":"113.932154ms","start":"2026-09-29T03:54:56.915062Z","end":"2026-09-29T03:54:57.029028Z","steps":["trace[1685682796] 'process raft request' (duration: 113.70273ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:54:57.029091Z","caller":"traceutil/trace.go:171","msg":"trace[2112225445] transaction","detail":"{read_only:false; response_revision:5787; number_of_response:1; }","duration":"113.339325ms","start":"2026-09-29T03:54:56.915731Z","end":"2026-09-29T03:54:57.029071Z","steps":["trace[2112225445] 'process raft request' (duration: 113.225573ms)"],"step_count":1} {"level":"warn","ts":"2026-09-29T03:54:57.029164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.789637ms","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-29T03:54:57.029036Z","caller":"traceutil/trace.go:171","msg":"trace[2045038152] linearizableReadLoop","detail":"{readStateIndex:6007; appliedIndex:6004; }","duration":"112.657285ms","start":"2026-09-29T03:54:56.916357Z","end":"2026-09-29T03:54:57.029014Z","steps":["trace[2045038152] 'read index received' (duration: 110.931098ms)","trace[2045038152] 'applied index is now lower than readState.Index' (duration: 1.725247ms)"],"step_count":2} {"level":"info","ts":"2026-09-29T03:54:57.029219Z","caller":"traceutil/trace.go:171","msg":"trace[1794381940] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:5787; }","duration":"112.877078ms","start":"2026-09-29T03:54:56.916325Z","end":"2026-09-29T03:54:57.029202Z","steps":["trace[1794381940] 'agreement among raft nodes before linearized reading' (duration: 112.760176ms)"],"step_count":1} {"level":"info","ts":"2026-09-29T03:58:43.391966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5101} {"level":"info","ts":"2026-09-29T03:58:43.46189Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5101,"took":"68.47888ms","hash":1077887907,"current-db-size-bytes":51908608,"current-db-size":"52 MB","current-db-size-in-use-bytes":19333120,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-29T03:58:43.461957Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1077887907,"revision":5101,"compact-revision":2823} {"level":"info","ts":"2026-09-29T04:03:43.401801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7333} {"level":"info","ts":"2026-09-29T04:03:43.456586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7333,"took":"53.806483ms","hash":2630895997,"current-db-size-bytes":51908608,"current-db-size":"52 MB","current-db-size-in-use-bytes":16556032,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-09-29T04:03:43.456633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2630895997,"revision":7333,"compact-revision":5101}