{"level":"warn","ts":"2026-09-18T05:20:02.851218Z","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-18T05:20:02.851315Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.81: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.81:2380","--initial-cluster=instance=https://162.253.55.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.81: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-18T05:20:02.851445Z","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-18T05:20:02.85146Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-18T05:20:02.851481Z","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-18T05:20:02.853487Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"]} {"level":"info","ts":"2026-09-18T05:20:02.853705Z","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.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.81: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-18T05:20:02.859388Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.126954ms"} {"level":"info","ts":"2026-09-18T05:20:02.86817Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d346c241c42fcdea","cluster-id":"331f16aa5aa938b6"} {"level":"info","ts":"2026-09-18T05:20:02.868276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T05:20:02.868293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 0"} {"level":"info","ts":"2026-09-18T05:20:02.868302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d346c241c42fcdea [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T05:20:02.868308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 1"} {"level":"info","ts":"2026-09-18T05:20:02.868336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"warn","ts":"2026-09-18T05:20:02.875512Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T05:20:02.8772Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T05:20:02.878701Z","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-18T05:20:02.880895Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d346c241c42fcdea","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T05:20:02.881183Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d346c241c42fcdea","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T05:20:02.881269Z","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-18T05:20:02.881302Z","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-18T05:20:02.881307Z","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-18T05:20:02.882997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"info","ts":"2026-09-18T05:20:02.883177Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","added-peer-id":"d346c241c42fcdea","added-peer-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-18T05:20:02.884543Z","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-18T05:20:02.8846Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-18T05:20:02.88513Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-18T05:20:02.885204Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d346c241c42fcdea","initial-advertise-peer-urls":["https://162.253.55.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T05:20:02.885237Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T05:20:03.068828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T05:20:03.068876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T05:20:03.068898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgPreVoteResp from d346c241c42fcdea at term 1"} {"level":"info","ts":"2026-09-18T05:20:03.068912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became candidate at term 2"} {"level":"info","ts":"2026-09-18T05:20:03.068919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgVoteResp from d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-18T05:20:03.068929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became leader at term 2"} {"level":"info","ts":"2026-09-18T05:20:03.068939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d346c241c42fcdea elected leader d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-18T05:20:03.07048Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d346c241c42fcdea","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.81:2379]}","request-path":"/0/members/d346c241c42fcdea/attributes","cluster-id":"331f16aa5aa938b6","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T05:20:03.07052Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:20:03.070692Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:20:03.07084Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:20:03.071255Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T05:20:03.071294Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T05:20:03.07297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T05:20:03.074253Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.81:2379"} {"level":"info","ts":"2026-09-18T05:20:03.074842Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:20:03.074947Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:20:03.07498Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-09-18T05:20:06.378852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.703379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:20:06.379Z","caller":"traceutil/trace.go:171","msg":"trace[1490047443] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"306.251134ms","start":"2026-09-18T05:20:06.072725Z","end":"2026-09-18T05:20:06.378977Z","steps":["trace[1490047443] 'process raft request' (duration: 72.737636ms)","trace[1490047443] 'compare' (duration: 232.499071ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:20:06.379092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:20:06.072709Z","time spent":"306.349458ms","remote":"127.0.0.1:47134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":732,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T05:20:06.946895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.59842ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:20:06.946999Z","caller":"traceutil/trace.go:171","msg":"trace[1020803111] linearizableReadLoop","detail":"{readStateIndex:178; appliedIndex:177; }","duration":"527.271052ms","start":"2026-09-18T05:20:06.419711Z","end":"2026-09-18T05:20:06.946982Z","steps":["trace[1020803111] 'read index received' (duration: 174.458944ms)","trace[1020803111] 'applied index is now lower than readState.Index' (duration: 352.810718ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:20:06.947097Z","caller":"traceutil/trace.go:171","msg":"trace[587369363] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"563.35422ms","start":"2026-09-18T05:20:06.383679Z","end":"2026-09-18T05:20:06.947034Z","steps":["trace[587369363] 'process raft request' (duration: 210.547572ms)","trace[587369363] 'compare' (duration: 352.459695ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:20:06.947326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.372686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T05:20:06.94735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:20:06.383561Z","time spent":"563.684542ms","remote":"127.0.0.1:47134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":748,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T05:20:06.947373Z","caller":"traceutil/trace.go:171","msg":"trace[1138387729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:174; }","duration":"527.701498ms","start":"2026-09-18T05:20:06.419658Z","end":"2026-09-18T05:20:06.94736Z","steps":["trace[1138387729] 'agreement among raft nodes before linearized reading' (duration: 527.366386ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:06.947419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:20:06.419636Z","time spent":"527.774111ms","remote":"127.0.0.1:46758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T05:20:08.466648Z","caller":"traceutil/trace.go:171","msg":"trace[2030391198] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"103.69695ms","start":"2026-09-18T05:20:08.362917Z","end":"2026-09-18T05:20:08.466614Z","steps":["trace[2030391198] 'process raft request' (duration: 95.473314ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:08.865586Z","caller":"traceutil/trace.go:171","msg":"trace[1850191175] linearizableReadLoop","detail":"{readStateIndex:249; appliedIndex:246; }","duration":"113.310075ms","start":"2026-09-18T05:20:08.75223Z","end":"2026-09-18T05:20:08.86554Z","steps":["trace[1850191175] 'read index received' (duration: 24.246002ms)","trace[1850191175] 'applied index is now lower than readState.Index' (duration: 89.062153ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:20:08.865599Z","caller":"traceutil/trace.go:171","msg":"trace[879350340] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"122.774816ms","start":"2026-09-18T05:20:08.742788Z","end":"2026-09-18T05:20:08.865563Z","steps":["trace[879350340] 'process raft request' (duration: 122.265628ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:08.865845Z","caller":"traceutil/trace.go:171","msg":"trace[710765568] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"122.657041ms","start":"2026-09-18T05:20:08.743167Z","end":"2026-09-18T05:20:08.865824Z","steps":["trace[710765568] 'process raft request' (duration: 122.084111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:08.866357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.501002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:20:08.866461Z","caller":"traceutil/trace.go:171","msg":"trace[2022568564] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:243; }","duration":"114.244898ms","start":"2026-09-18T05:20:08.752187Z","end":"2026-09-18T05:20:08.866431Z","steps":["trace[2022568564] 'agreement among raft nodes before linearized reading' (duration: 113.489281ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:32.278799Z","caller":"traceutil/trace.go:171","msg":"trace[1583183119] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"123.105278ms","start":"2026-09-18T05:20:32.155669Z","end":"2026-09-18T05:20:32.278774Z","steps":["trace[1583183119] 'process raft request' (duration: 84.652251ms)","trace[1583183119] 'compare' (duration: 38.273782ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:20:32.27919Z","caller":"traceutil/trace.go:171","msg":"trace[1179341134] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"123.148919ms","start":"2026-09-18T05:20:32.156019Z","end":"2026-09-18T05:20:32.279168Z","steps":["trace[1179341134] 'process raft request' (duration: 122.698476ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:32.27953Z","caller":"traceutil/trace.go:171","msg":"trace[707555008] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"123.094677ms","start":"2026-09-18T05:20:32.15642Z","end":"2026-09-18T05:20:32.279515Z","steps":["trace[707555008] 'process raft request' (duration: 122.558442ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:32.279614Z","caller":"traceutil/trace.go:171","msg":"trace[406624829] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"123.107147ms","start":"2026-09-18T05:20:32.156494Z","end":"2026-09-18T05:20:32.279601Z","steps":["trace[406624829] 'process raft request' (duration: 122.936723ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.537415Z","caller":"traceutil/trace.go:171","msg":"trace[547712822] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"141.121139ms","start":"2026-09-18T05:20:46.396273Z","end":"2026-09-18T05:20:46.537394Z","steps":["trace[547712822] 'process raft request' (duration: 133.104035ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.539866Z","caller":"traceutil/trace.go:171","msg":"trace[689556295] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"140.920094ms","start":"2026-09-18T05:20:46.398932Z","end":"2026-09-18T05:20:46.539852Z","steps":["trace[689556295] 'process raft request' (duration: 140.717428ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.539976Z","caller":"traceutil/trace.go:171","msg":"trace[479258083] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"143.693857ms","start":"2026-09-18T05:20:46.396277Z","end":"2026-09-18T05:20:46.539971Z","steps":["trace[479258083] 'process raft request' (duration: 143.132572ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540043Z","caller":"traceutil/trace.go:171","msg":"trace[816888442] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"143.618576ms","start":"2026-09-18T05:20:46.396419Z","end":"2026-09-18T05:20:46.540037Z","steps":["trace[816888442] 'process raft request' (duration: 143.128812ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.54016Z","caller":"traceutil/trace.go:171","msg":"trace[1077028544] transaction","detail":"{read_only:false; number_of_response:1; response_revision:513; }","duration":"135.1459ms","start":"2026-09-18T05:20:46.404986Z","end":"2026-09-18T05:20:46.540131Z","steps":["trace[1077028544] 'process raft request' (duration: 135.034957ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540381Z","caller":"traceutil/trace.go:171","msg":"trace[492729819] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"110.340306ms","start":"2026-09-18T05:20:46.430034Z","end":"2026-09-18T05:20:46.540374Z","steps":["trace[492729819] 'process raft request' (duration: 110.258404ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540461Z","caller":"traceutil/trace.go:171","msg":"trace[1323366737] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"137.321698ms","start":"2026-09-18T05:20:46.403109Z","end":"2026-09-18T05:20:46.54043Z","steps":["trace[1323366737] 'process raft request' (duration: 136.714722ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540456Z","caller":"traceutil/trace.go:171","msg":"trace[1580402038] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"137.253406ms","start":"2026-09-18T05:20:46.403158Z","end":"2026-09-18T05:20:46.540412Z","steps":["trace[1580402038] 'process raft request' (duration: 136.712431ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540501Z","caller":"traceutil/trace.go:171","msg":"trace[527552956] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"137.494362ms","start":"2026-09-18T05:20:46.403Z","end":"2026-09-18T05:20:46.540495Z","steps":["trace[527552956] 'process raft request' (duration: 136.763752ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540536Z","caller":"traceutil/trace.go:171","msg":"trace[1494177171] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"137.363509ms","start":"2026-09-18T05:20:46.40316Z","end":"2026-09-18T05:20:46.540523Z","steps":["trace[1494177171] 'process raft request' (duration: 136.752382ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.54058Z","caller":"traceutil/trace.go:171","msg":"trace[455996941] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"137.507353ms","start":"2026-09-18T05:20:46.403066Z","end":"2026-09-18T05:20:46.540573Z","steps":["trace[455996941] 'process raft request' (duration: 136.727062ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540635Z","caller":"traceutil/trace.go:171","msg":"trace[461559126] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"135.565322ms","start":"2026-09-18T05:20:46.405064Z","end":"2026-09-18T05:20:46.54063Z","steps":["trace[461559126] 'process raft request' (duration: 134.998246ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540645Z","caller":"traceutil/trace.go:171","msg":"trace[1871587868] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"137.363739ms","start":"2026-09-18T05:20:46.40327Z","end":"2026-09-18T05:20:46.540633Z","steps":["trace[1871587868] 'process raft request' (duration: 136.704721ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:46.540696Z","caller":"traceutil/trace.go:171","msg":"trace[1856488830] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"134.729388ms","start":"2026-09-18T05:20:46.40596Z","end":"2026-09-18T05:20:46.540689Z","steps":["trace[1856488830] 'process raft request' (duration: 134.247025ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:52.541514Z","caller":"traceutil/trace.go:171","msg":"trace[1752589712] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"140.710288ms","start":"2026-09-18T05:20:52.400777Z","end":"2026-09-18T05:20:52.541487Z","steps":["trace[1752589712] 'read index received' (duration: 140.586435ms)","trace[1752589712] 'applied index is now lower than readState.Index' (duration: 122.953µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:20:52.54171Z","caller":"traceutil/trace.go:171","msg":"trace[116967807] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"225.195164ms","start":"2026-09-18T05:20:52.316493Z","end":"2026-09-18T05:20:52.541688Z","steps":["trace[116967807] 'process raft request' (duration: 224.830535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:52.541897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.106898ms","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-18T05:20:52.541948Z","caller":"traceutil/trace.go:171","msg":"trace[1875493972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:605; }","duration":"141.201811ms","start":"2026-09-18T05:20:52.400734Z","end":"2026-09-18T05:20:52.541936Z","steps":["trace[1875493972] 'agreement among raft nodes before linearized reading' (duration: 140.980655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:52.655812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.389066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:20:52.655907Z","caller":"traceutil/trace.go:171","msg":"trace[1499153121] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:606; }","duration":"102.54546ms","start":"2026-09-18T05:20:52.553339Z","end":"2026-09-18T05:20:52.655884Z","steps":["trace[1499153121] 'agreement among raft nodes before linearized reading' (duration: 61.051431ms)","trace[1499153121] 'range keys from in-memory index tree' (duration: 41.342225ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:20:52.84419Z","caller":"traceutil/trace.go:171","msg":"trace[1629127105] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"113.562413ms","start":"2026-09-18T05:20:52.730607Z","end":"2026-09-18T05:20:52.844169Z","steps":["trace[1629127105] 'read index received' (duration: 113.435779ms)","trace[1629127105] 'applied index is now lower than readState.Index' (duration: 125.534µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:20:52.844384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.769198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:20:52.844413Z","caller":"traceutil/trace.go:171","msg":"trace[1294998384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"113.871091ms","start":"2026-09-18T05:20:52.730535Z","end":"2026-09-18T05:20:52.844406Z","steps":["trace[1294998384] 'agreement among raft nodes before linearized reading' (duration: 113.727667ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:52.844291Z","caller":"traceutil/trace.go:171","msg":"trace[1709845209] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"167.899495ms","start":"2026-09-18T05:20:52.676343Z","end":"2026-09-18T05:20:52.844243Z","steps":["trace[1709845209] 'process raft request' (duration: 167.669548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:53.681155Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14837848612802345260,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-18T05:20:53.827379Z","caller":"traceutil/trace.go:171","msg":"trace[1297013003] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"646.662961ms","start":"2026-09-18T05:20:53.180699Z","end":"2026-09-18T05:20:53.827362Z","steps":["trace[1297013003] 'read index received' (duration: 646.014164ms)","trace[1297013003] 'applied index is now lower than readState.Index' (duration: 648.217µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:20:53.827564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.560616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:20:53.827628Z","caller":"traceutil/trace.go:171","msg":"trace[1215455848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"255.671749ms","start":"2026-09-18T05:20:53.571946Z","end":"2026-09-18T05:20:53.827618Z","steps":["trace[1215455848] 'agreement among raft nodes before linearized reading' (duration: 255.572717ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:20:53.827652Z","caller":"traceutil/trace.go:171","msg":"trace[1572612167] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"740.033135ms","start":"2026-09-18T05:20:53.087527Z","end":"2026-09-18T05:20:53.82756Z","steps":["trace[1572612167] 'process raft request' (duration: 739.411818ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:53.827974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:20:53.08748Z","time spent":"740.25ms","remote":"127.0.0.1:46868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:20:53.828206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.501234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T05:20:53.82828Z","caller":"traceutil/trace.go:171","msg":"trace[1349985275] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"647.578506ms","start":"2026-09-18T05:20:53.180693Z","end":"2026-09-18T05:20:53.828272Z","steps":["trace[1349985275] 'agreement among raft nodes before linearized reading' (duration: 647.404921ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:20:53.828303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:20:53.180645Z","time spent":"647.653348ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T05:21:10.413532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.452659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:21:10.413782Z","caller":"traceutil/trace.go:171","msg":"trace[668468311] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:772; }","duration":"198.764717ms","start":"2026-09-18T05:21:10.214997Z","end":"2026-09-18T05:21:10.413762Z","steps":["trace[668468311] 'count revisions from in-memory index tree' (duration: 198.312906ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:06.272439Z","caller":"traceutil/trace.go:171","msg":"trace[1214917570] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"220.251808ms","start":"2026-09-18T05:22:06.052164Z","end":"2026-09-18T05:22:06.272416Z","steps":["trace[1214917570] 'read index received' (duration: 220.021782ms)","trace[1214917570] 'applied index is now lower than readState.Index' (duration: 228.986µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:06.272513Z","caller":"traceutil/trace.go:171","msg":"trace[700327910] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"226.049996ms","start":"2026-09-18T05:22:06.046425Z","end":"2026-09-18T05:22:06.272475Z","steps":["trace[700327910] 'process raft request' (duration: 225.817979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:06.272618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.419902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:22:06.272695Z","caller":"traceutil/trace.go:171","msg":"trace[1157834431] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1111; }","duration":"220.545865ms","start":"2026-09-18T05:22:06.052131Z","end":"2026-09-18T05:22:06.272677Z","steps":["trace[1157834431] 'agreement among raft nodes before linearized reading' (duration: 220.391791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:06.272635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.231263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:22:06.272813Z","caller":"traceutil/trace.go:171","msg":"trace[6239100] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1111; }","duration":"180.428708ms","start":"2026-09-18T05:22:06.092356Z","end":"2026-09-18T05:22:06.272785Z","steps":["trace[6239100] 'agreement among raft nodes before linearized reading' (duration: 180.231163ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:06.406954Z","caller":"traceutil/trace.go:171","msg":"trace[791537750] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"113.469476ms","start":"2026-09-18T05:22:06.293454Z","end":"2026-09-18T05:22:06.406923Z","steps":["trace[791537750] 'read index received' (duration: 112.680224ms)","trace[791537750] 'applied index is now lower than readState.Index' (duration: 787.612µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:06.407035Z","caller":"traceutil/trace.go:171","msg":"trace[217221116] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"117.141046ms","start":"2026-09-18T05:22:06.28985Z","end":"2026-09-18T05:22:06.406991Z","steps":["trace[217221116] 'process raft request' (duration: 116.259011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:06.40718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.703352ms","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-18T05:22:06.407486Z","caller":"traceutil/trace.go:171","msg":"trace[1563937445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1112; }","duration":"114.024891ms","start":"2026-09-18T05:22:06.293409Z","end":"2026-09-18T05:22:06.407434Z","steps":["trace[1563937445] 'agreement among raft nodes before linearized reading' (duration: 113.62209ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:06.576461Z","caller":"traceutil/trace.go:171","msg":"trace[295938175] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"125.559416ms","start":"2026-09-18T05:22:06.450865Z","end":"2026-09-18T05:22:06.576425Z","steps":["trace[295938175] 'read index received' (duration: 63.95182ms)","trace[295938175] 'applied index is now lower than readState.Index' (duration: 61.606196ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:06.576573Z","caller":"traceutil/trace.go:171","msg":"trace[674603836] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"164.485131ms","start":"2026-09-18T05:22:06.41204Z","end":"2026-09-18T05:22:06.576525Z","steps":["trace[674603836] 'process raft request' (duration: 102.837914ms)","trace[674603836] 'compare' (duration: 61.4016ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:06.576669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.777382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:22:06.576717Z","caller":"traceutil/trace.go:171","msg":"trace[1664190721] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1113; }","duration":"125.888435ms","start":"2026-09-18T05:22:06.450814Z","end":"2026-09-18T05:22:06.576702Z","steps":["trace[1664190721] 'agreement among raft nodes before linearized reading' (duration: 125.787862ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:07.266712Z","caller":"traceutil/trace.go:171","msg":"trace[225728024] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"142.665684ms","start":"2026-09-18T05:22:07.124027Z","end":"2026-09-18T05:22:07.266692Z","steps":["trace[225728024] 'process raft request' (duration: 142.543651ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:08.034339Z","caller":"traceutil/trace.go:171","msg":"trace[512791922] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1158; }","duration":"804.330592ms","start":"2026-09-18T05:22:07.229985Z","end":"2026-09-18T05:22:08.034315Z","steps":["trace[512791922] 'read index received' (duration: 36.609481ms)","trace[512791922] 'applied index is now lower than readState.Index' (duration: 767.720251ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:08.034598Z","caller":"traceutil/trace.go:171","msg":"trace[879533920] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"822.122378ms","start":"2026-09-18T05:22:07.212432Z","end":"2026-09-18T05:22:08.034555Z","steps":["trace[879533920] 'process raft request' (duration: 732.24108ms)","trace[879533920] 'compare' (duration: 89.509739ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:08.034662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.659281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.81\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-09-18T05:22:08.034663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.194932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:22:08.034696Z","caller":"traceutil/trace.go:171","msg":"trace[1033140962] range","detail":"{range_begin:/registry/masterleases/162.253.55.81; range_end:; response_count:1; response_revision:1116; }","duration":"804.733842ms","start":"2026-09-18T05:22:07.229953Z","end":"2026-09-18T05:22:08.034687Z","steps":["trace[1033140962] 'agreement among raft nodes before linearized reading' (duration: 804.601458ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:08.034702Z","caller":"traceutil/trace.go:171","msg":"trace[863279485] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1116; }","duration":"666.284854ms","start":"2026-09-18T05:22:07.368407Z","end":"2026-09-18T05:22:08.034692Z","steps":["trace[863279485] 'agreement among raft nodes before linearized reading' (duration: 666.207872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.034726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.229941Z","time spent":"804.777544ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.81\" "} {"level":"warn","ts":"2026-09-18T05:22:08.03473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.368388Z","time spent":"666.332655ms","remote":"127.0.0.1:46890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-09-18T05:22:08.034746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.212414Z","time spent":"822.255043ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:22:08.034974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.753376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:22:08.035Z","caller":"traceutil/trace.go:171","msg":"trace[197006740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1116; }","duration":"617.809347ms","start":"2026-09-18T05:22:07.417185Z","end":"2026-09-18T05:22:08.034994Z","steps":["trace[197006740] 'agreement among raft nodes before linearized reading' (duration: 617.744955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.035015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.417165Z","time spent":"617.846308ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T05:22:08.035018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.670701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:22:08.035062Z","caller":"traceutil/trace.go:171","msg":"trace[280593228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1116; }","duration":"462.734803ms","start":"2026-09-18T05:22:07.572304Z","end":"2026-09-18T05:22:08.035039Z","steps":["trace[280593228] 'agreement among raft nodes before linearized reading' (duration: 462.688221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.035094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.572284Z","time spent":"462.803755ms","remote":"127.0.0.1:46758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-18T05:22:08.035339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.389784ms","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-18T05:22:08.035377Z","caller":"traceutil/trace.go:171","msg":"trace[1433717748] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1116; }","duration":"386.481097ms","start":"2026-09-18T05:22:07.648886Z","end":"2026-09-18T05:22:08.035367Z","steps":["trace[1433717748] 'agreement among raft nodes before linearized reading' (duration: 385.983323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.035402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:07.648863Z","time spent":"386.532268ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-18T05:22:08.374681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.758583ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-09-18T05:22:08.374901Z","caller":"traceutil/trace.go:171","msg":"trace[1377548902] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"335.670366ms","start":"2026-09-18T05:22:08.039216Z","end":"2026-09-18T05:22:08.374886Z","steps":["trace[1377548902] 'process raft request' (duration: 335.622264ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.374973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:08.039202Z","time spent":"335.724748ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:22:08.375107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:08.035831Z","time spent":"339.275565ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-18T05:22:08.375296Z","caller":"traceutil/trace.go:171","msg":"trace[278660570] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"336.254192ms","start":"2026-09-18T05:22:08.039033Z","end":"2026-09-18T05:22:08.375288Z","steps":["trace[278660570] 'process raft request' (duration: 335.712477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.375336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:08.039005Z","time spent":"336.309894ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:22:08.391737Z","caller":"traceutil/trace.go:171","msg":"trace[1814272881] transaction","detail":"{read_only:false; response_revision:1119; number_of_response:1; }","duration":"113.739084ms","start":"2026-09-18T05:22:08.277951Z","end":"2026-09-18T05:22:08.391691Z","steps":["trace[1814272881] 'process raft request' (duration: 113.61257ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:08.591648Z","caller":"traceutil/trace.go:171","msg":"trace[2058650110] linearizableReadLoop","detail":"{readStateIndex:1166; appliedIndex:1165; }","duration":"147.153157ms","start":"2026-09-18T05:22:08.444474Z","end":"2026-09-18T05:22:08.591628Z","steps":["trace[2058650110] 'read index received' (duration: 55.003495ms)","trace[2058650110] 'applied index is now lower than readState.Index' (duration: 92.148652ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:08.591721Z","caller":"traceutil/trace.go:171","msg":"trace[677332344] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"148.334499ms","start":"2026-09-18T05:22:08.443367Z","end":"2026-09-18T05:22:08.591702Z","steps":["trace[677332344] 'process raft request' (duration: 56.107755ms)","trace[677332344] 'compare' (duration: 92.005779ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:08.591848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.353292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T05:22:08.591877Z","caller":"traceutil/trace.go:171","msg":"trace[751537908] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1121; }","duration":"147.413144ms","start":"2026-09-18T05:22:08.444456Z","end":"2026-09-18T05:22:08.591869Z","steps":["trace[751537908] 'agreement among raft nodes before linearized reading' (duration: 147.28771ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:08.870466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.207783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:22:08.870536Z","caller":"traceutil/trace.go:171","msg":"trace[1659609675] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"275.351016ms","start":"2026-09-18T05:22:08.595173Z","end":"2026-09-18T05:22:08.870524Z","steps":["trace[1659609675] 'process raft request' (duration: 164.017489ms)","trace[1659609675] 'compare' (duration: 110.935506ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:09.093433Z","caller":"traceutil/trace.go:171","msg":"trace[1277562652] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"148.69736ms","start":"2026-09-18T05:22:08.944706Z","end":"2026-09-18T05:22:09.093404Z","steps":["trace[1277562652] 'process raft request' (duration: 57.663389ms)","trace[1277562652] 'compare' (duration: 90.779974ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:09.578588Z","caller":"traceutil/trace.go:171","msg":"trace[1917851205] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"242.825665ms","start":"2026-09-18T05:22:09.335726Z","end":"2026-09-18T05:22:09.578551Z","steps":["trace[1917851205] 'process raft request' (duration: 181.170168ms)","trace[1917851205] 'compare' (duration: 61.502713ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:24.082722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.940899ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T05:22:24.082843Z","caller":"traceutil/trace.go:171","msg":"trace[826997792] linearizableReadLoop","detail":"{readStateIndex:1283; appliedIndex:1282; }","duration":"475.052451ms","start":"2026-09-18T05:22:23.60777Z","end":"2026-09-18T05:22:24.082822Z","steps":["trace[826997792] 'read index received' (duration: 41.381µs)","trace[826997792] 'applied index is now lower than readState.Index' (duration: 475.00957ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:24.083115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.465831ms","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-18T05:22:24.083189Z","caller":"traceutil/trace.go:171","msg":"trace[376166240] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1234; }","duration":"426.584544ms","start":"2026-09-18T05:22:23.656587Z","end":"2026-09-18T05:22:24.083172Z","steps":["trace[376166240] 'agreement among raft nodes before linearized reading' (duration: 426.363918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:24.083192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.920392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-18T05:22:24.0833Z","caller":"traceutil/trace.go:171","msg":"trace[844759697] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1234; }","duration":"154.061797ms","start":"2026-09-18T05:22:23.929194Z","end":"2026-09-18T05:22:24.083256Z","steps":["trace[844759697] 'agreement among raft nodes before linearized reading' (duration: 153.767548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:24.083222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:23.65657Z","time spent":"426.646097ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T05:22:24.08349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.706398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-09-18T05:22:24.083692Z","caller":"traceutil/trace.go:171","msg":"trace[450060747] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1234; }","duration":"475.76664ms","start":"2026-09-18T05:22:23.607758Z","end":"2026-09-18T05:22:24.083524Z","steps":["trace[450060747] 'agreement among raft nodes before linearized reading' (duration: 475.155583ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:22:24.083875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:22:23.607702Z","time spent":"476.040188ms","remote":"127.0.0.1:47040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-09-18T05:22:24.269392Z","caller":"traceutil/trace.go:171","msg":"trace[927645678] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"179.952374ms","start":"2026-09-18T05:22:24.089402Z","end":"2026-09-18T05:22:24.269354Z","steps":["trace[927645678] 'process raft request' (duration: 146.54434ms)","trace[927645678] 'compare' (duration: 33.098575ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:24.269761Z","caller":"traceutil/trace.go:171","msg":"trace[1272277713] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"179.907833ms","start":"2026-09-18T05:22:24.089783Z","end":"2026-09-18T05:22:24.269691Z","steps":["trace[1272277713] 'process raft request' (duration: 179.529983ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:40.707189Z","caller":"traceutil/trace.go:171","msg":"trace[1720173326] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"123.827509ms","start":"2026-09-18T05:22:40.583345Z","end":"2026-09-18T05:22:40.707173Z","steps":["trace[1720173326] 'process raft request' (duration: 123.723566ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:40.850031Z","caller":"traceutil/trace.go:171","msg":"trace[1230907978] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"213.234835ms","start":"2026-09-18T05:22:40.636778Z","end":"2026-09-18T05:22:40.850013Z","steps":["trace[1230907978] 'process raft request' (duration: 121.585517ms)","trace[1230907978] 'compare' (duration: 91.326849ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:22:40.850031Z","caller":"traceutil/trace.go:171","msg":"trace[1151347838] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1362; }","duration":"199.950142ms","start":"2026-09-18T05:22:40.650053Z","end":"2026-09-18T05:22:40.850003Z","steps":["trace[1151347838] 'read index received' (duration: 56.966189ms)","trace[1151347838] 'applied index is now lower than readState.Index' (duration: 142.982803ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:22:40.850189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.123298ms","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-18T05:22:40.850222Z","caller":"traceutil/trace.go:171","msg":"trace[1677135297] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1312; }","duration":"200.196579ms","start":"2026-09-18T05:22:40.650018Z","end":"2026-09-18T05:22:40.850214Z","steps":["trace[1677135297] 'agreement among raft nodes before linearized reading' (duration: 200.045125ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:17.469028Z","caller":"traceutil/trace.go:171","msg":"trace[852613755] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"109.035081ms","start":"2026-09-18T05:25:17.359968Z","end":"2026-09-18T05:25:17.469003Z","steps":["trace[852613755] 'process raft request' (duration: 52.429324ms)","trace[852613755] 'compare' (duration: 56.509354ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:25:18.076876Z","caller":"traceutil/trace.go:171","msg":"trace[1891737362] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"103.542662ms","start":"2026-09-18T05:25:17.973271Z","end":"2026-09-18T05:25:18.076813Z","steps":["trace[1891737362] 'process raft request' (duration: 39.545757ms)","trace[1891737362] 'compare' (duration: 63.795241ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:25:19.635377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.240122ms","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-18T05:25:19.635525Z","caller":"traceutil/trace.go:171","msg":"trace[329191340] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2038; }","duration":"104.398626ms","start":"2026-09-18T05:25:19.531103Z","end":"2026-09-18T05:25:19.635502Z","steps":["trace[329191340] 'range keys from in-memory index tree' (duration: 104.222911ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:20.295476Z","caller":"traceutil/trace.go:171","msg":"trace[881805876] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"124.292712ms","start":"2026-09-18T05:25:20.171164Z","end":"2026-09-18T05:25:20.295457Z","steps":["trace[881805876] 'process raft request' (duration: 75.405993ms)","trace[881805876] 'compare' (duration: 48.409756ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:25:22.410585Z","caller":"traceutil/trace.go:171","msg":"trace[541532860] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2137; }","duration":"109.575384ms","start":"2026-09-18T05:25:22.300971Z","end":"2026-09-18T05:25:22.410546Z","steps":["trace[541532860] 'read index received' (duration: 69.094703ms)","trace[541532860] 'applied index is now lower than readState.Index' (duration: 40.477551ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:25:22.41086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.878463ms","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-18T05:25:22.410928Z","caller":"traceutil/trace.go:171","msg":"trace[1479926146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2054; }","duration":"110.002006ms","start":"2026-09-18T05:25:22.300906Z","end":"2026-09-18T05:25:22.410908Z","steps":["trace[1479926146] 'agreement among raft nodes before linearized reading' (duration: 109.78401ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:24.321051Z","caller":"traceutil/trace.go:171","msg":"trace[638201990] linearizableReadLoop","detail":"{readStateIndex:2146; appliedIndex:2145; }","duration":"140.299384ms","start":"2026-09-18T05:25:24.180725Z","end":"2026-09-18T05:25:24.321024Z","steps":["trace[638201990] 'read index received' (duration: 65.833156ms)","trace[638201990] 'applied index is now lower than readState.Index' (duration: 74.465188ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:25:24.321268Z","caller":"traceutil/trace.go:171","msg":"trace[1450095800] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"143.223633ms","start":"2026-09-18T05:25:24.178006Z","end":"2026-09-18T05:25:24.32123Z","steps":["trace[1450095800] 'process raft request' (duration: 68.667823ms)","trace[1450095800] 'compare' (duration: 74.146679ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:25:24.321361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.618813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-09-18T05:25:24.321422Z","caller":"traceutil/trace.go:171","msg":"trace[1057053354] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2061; }","duration":"140.729436ms","start":"2026-09-18T05:25:24.180675Z","end":"2026-09-18T05:25:24.321404Z","steps":["trace[1057053354] 'agreement among raft nodes before linearized reading' (duration: 140.48885ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:25.694821Z","caller":"traceutil/trace.go:171","msg":"trace[827783180] linearizableReadLoop","detail":"{readStateIndex:2152; appliedIndex:2151; }","duration":"122.765211ms","start":"2026-09-18T05:25:25.572029Z","end":"2026-09-18T05:25:25.694794Z","steps":["trace[827783180] 'read index received' (duration: 62.769283ms)","trace[827783180] 'applied index is now lower than readState.Index' (duration: 59.994768ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:25:25.694885Z","caller":"traceutil/trace.go:171","msg":"trace[860010811] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"139.287566ms","start":"2026-09-18T05:25:25.555569Z","end":"2026-09-18T05:25:25.694857Z","steps":["trace[860010811] 'process raft request' (duration: 79.243957ms)","trace[860010811] 'compare' (duration: 59.874055ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:25:25.694947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.899964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:25:25.694976Z","caller":"traceutil/trace.go:171","msg":"trace[107095142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2067; }","duration":"122.986007ms","start":"2026-09-18T05:25:25.571981Z","end":"2026-09-18T05:25:25.694967Z","steps":["trace[107095142] 'agreement among raft nodes before linearized reading' (duration: 122.921296ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:26.577333Z","caller":"traceutil/trace.go:171","msg":"trace[844731925] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"123.636184ms","start":"2026-09-18T05:25:26.453672Z","end":"2026-09-18T05:25:26.577282Z","steps":["trace[844731925] 'process raft request' (duration: 122.923535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:25:28.797607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.25485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:25:28.797708Z","caller":"traceutil/trace.go:171","msg":"trace[30489895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2082; }","duration":"220.428725ms","start":"2026-09-18T05:25:28.577257Z","end":"2026-09-18T05:25:28.797686Z","steps":["trace[30489895] 'range keys from in-memory index tree' (duration: 220.142307ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:25:28.797834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.317375ms","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-18T05:25:28.797936Z","caller":"traceutil/trace.go:171","msg":"trace[93316173] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2082; }","duration":"209.449919ms","start":"2026-09-18T05:25:28.58846Z","end":"2026-09-18T05:25:28.79791Z","steps":["trace[93316173] 'range keys from in-memory index tree' (duration: 209.141181ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:25:30.511673Z","caller":"traceutil/trace.go:171","msg":"trace[364376738] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"100.876971ms","start":"2026-09-18T05:25:30.410771Z","end":"2026-09-18T05:25:30.511648Z","steps":["trace[364376738] 'process raft request' (duration: 100.592843ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:27:48.586859Z","caller":"traceutil/trace.go:171","msg":"trace[1763450183] linearizableReadLoop","detail":"{readStateIndex:2868; appliedIndex:2867; }","duration":"167.118334ms","start":"2026-09-18T05:27:48.419712Z","end":"2026-09-18T05:27:48.586831Z","steps":["trace[1763450183] 'read index received' (duration: 166.958091ms)","trace[1763450183] 'applied index is now lower than readState.Index' (duration: 159.203µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:27:48.586937Z","caller":"traceutil/trace.go:171","msg":"trace[325368454] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"182.673249ms","start":"2026-09-18T05:27:48.404223Z","end":"2026-09-18T05:27:48.586896Z","steps":["trace[325368454] 'process raft request' (duration: 182.447304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:27:48.587048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.32387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-18T05:27:48.587088Z","caller":"traceutil/trace.go:171","msg":"trace[204054582] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:2753; }","duration":"167.412212ms","start":"2026-09-18T05:27:48.419661Z","end":"2026-09-18T05:27:48.587074Z","steps":["trace[204054582] 'agreement among raft nodes before linearized reading' (duration: 167.314719ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:27:48.782739Z","caller":"traceutil/trace.go:171","msg":"trace[351663028] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"128.639324ms","start":"2026-09-18T05:27:48.654075Z","end":"2026-09-18T05:27:48.782715Z","steps":["trace[351663028] 'process raft request' (duration: 83.518702ms)","trace[351663028] 'compare' (duration: 44.460304ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:27:48.78277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.421704ms","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-18T05:27:48.782852Z","caller":"traceutil/trace.go:171","msg":"trace[1707724477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2753; }","duration":"170.542338ms","start":"2026-09-18T05:27:48.612288Z","end":"2026-09-18T05:27:48.78283Z","steps":["trace[1707724477] 'range keys from in-memory index tree' (duration: 170.252041ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:27:48.7829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.375361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:115 size:88767"} {"level":"info","ts":"2026-09-18T05:27:48.783004Z","caller":"traceutil/trace.go:171","msg":"trace[202527341] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:115; response_revision:2753; }","duration":"141.532645ms","start":"2026-09-18T05:27:48.641446Z","end":"2026-09-18T05:27:48.782979Z","steps":["trace[202527341] 'range keys from in-memory index tree' (duration: 140.675003ms)"],"step_count":1}